builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1502878286.16 results: success (0) revision: c498777e8f39a3027e44d7badad05bd3a3f86f08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.163590) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.164023) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.164309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.188008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.188280) ========= 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=ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:11:26-- 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% 45.7M=0s 2017-08-16 03:11:26 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179318 ========= master_lag: 0.41 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.779471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:26.779797) ========= 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=ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020272 ========= master_lag: 0.33 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:27.127142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:11:27.127506) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c498777e8f39a3027e44d7badad05bd3a3f86f08 --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 c498777e8f39a3027e44d7badad05bd3a3f86f08 --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=ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:11:27,508 truncating revision to first 12 chars 2017-08-16 03:11:27,508 Setting DEBUG logging. 2017-08-16 03:11:27,509 attempt 1/10 2017-08-16 03:11:27,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c498777e8f39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 03:11:28,879 unpacking tar archive at: mozilla-central-c498777e8f39/testing/mozharness/ program finished with exit code 0 elapsedTime=1.675286 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:11:28.834758) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:28.835059) ========= script_repo_revision: c498777e8f39a3027e44d7badad05bd3a3f86f08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:28.835420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:28.844787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:11:28.867054) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-16 03:11:28.867406) ========= /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=ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:11:29 INFO - MultiFileLogger online at 20170816 03:11:29 in /builds/slave/test 03:11:29 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 03:11:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:29 INFO - {'append_to_log': False, 03:11:29 INFO - 'base_work_dir': '/builds/slave/test', 03:11:29 INFO - 'blob_upload_branch': 'Firefox', 03:11:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:29 INFO - 'branch': 'Firefox', 03:11:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:29 INFO - 'code_coverage': False, 03:11:29 INFO - 'config_files': ('talos/linux_config.py',), 03:11:29 INFO - 'default_actions': ('clobber', 03:11:29 INFO - 'read-buildbot-config', 03:11:29 INFO - 'download-and-extract', 03:11:29 INFO - 'populate-webroot', 03:11:29 INFO - 'create-virtualenv', 03:11:29 INFO - 'install', 03:11:29 INFO - 'setup-mitmproxy', 03:11:29 INFO - 'run-tests'), 03:11:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:29 INFO - 'disable_ccov_upload': False, 03:11:29 INFO - 'download_minidump_stackwalk': True, 03:11:29 INFO - 'download_symbols': 'ondemand', 03:11:29 INFO - 'enable_stylo': False, 03:11:29 INFO - 'enable_webrender': False, 03:11:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:29 INFO - 'gecko_profile': False, 03:11:29 INFO - 'gecko_profile_interval': 0, 03:11:29 INFO - 'installer_path': 'installer.exe', 03:11:29 INFO - 'log_level': 'info', 03:11:29 INFO - 'log_name': 'talos', 03:11:29 INFO - 'log_to_console': True, 03:11:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:11:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:11:29 INFO - 'opt_config_files': (), 03:11:29 INFO - 'pip_index': False, 03:11:29 INFO - 'suite': 'dromaeojs-e10s', 03:11:29 INFO - 'system_bits': '32', 03:11:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:29 INFO - 'title': 'talos-linux64-ix-035', 03:11:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:29 INFO - 'use_talos_json': True, 03:11:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:29 INFO - 'work_dir': 'build'} 03:11:29 INFO - [mozharness: 2017-08-16 10:11:29.345067Z] Running clobber step. 03:11:29 INFO - Running pre-action listener: _resource_record_pre_action 03:11:29 INFO - Running main action method: clobber 03:11:29 INFO - rmtree: /builds/slave/test/build 03:11:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:30 INFO - Running post-action listener: _resource_record_post_action 03:11:30 INFO - [mozharness: 2017-08-16 10:11:30.384629Z] Finished clobber step (success) 03:11:30 INFO - [mozharness: 2017-08-16 10:11:30.384732Z] Running read-buildbot-config step. 03:11:30 INFO - Running pre-action listener: _resource_record_pre_action 03:11:30 INFO - Running main action method: read_buildbot_config 03:11:30 INFO - Using buildbot properties: 03:11:30 INFO - { 03:11:30 INFO - "project": "", 03:11:30 INFO - "product": "firefox", 03:11:30 INFO - "who": "cbook@mozilla.com", 03:11:30 INFO - "installer_path": "public/build/target.tar.bz2", 03:11:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:11:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:11:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:11:30 INFO - "stage_platform": "linux64-stylosequential", 03:11:30 INFO - "basedir": "/builds/slave/test", 03:11:30 INFO - "buildnumber": 150, 03:11:30 INFO - "platform": "ubuntu64_hw_styloseq", 03:11:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:11:30 INFO - "slavebuilddir": "test", 03:11:30 INFO - "taskId": "V0qCgLPBQUWH-s-6rAcjRg", 03:11:30 INFO - "branch": "mozilla-central", 03:11:30 INFO - "script_repo_revision": "production", 03:11:30 INFO - "revision": "c498777e8f39a3027e44d7badad05bd3a3f86f08", 03:11:30 INFO - "slavename": "talos-linux64-ix-035", 03:11:30 INFO - "repo_path": "mozilla-central" 03:11:30 INFO - } 03:11:30 INFO - Finding installer, test and symbols from parent task. 03:11:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V0qCgLPBQUWH-s-6rAcjRg'}, attempt #1 03:11:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V0qCgLPBQUWH-s-6rAcjRg'}, attempt #1 03:11:31 INFO - Task dependencies: HuMrrxyuS1iW8gGOnr-3Zg 03:11:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg'}, attempt #1 03:11:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2 03:11:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.test_packages.json 03:11:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.crashreporter-symbols.zip 03:11:31 INFO - Running post-action listener: _resource_record_post_action 03:11:31 INFO - [mozharness: 2017-08-16 10:11:31.743530Z] Finished read-buildbot-config step (success) 03:11:31 INFO - [mozharness: 2017-08-16 10:11:31.743752Z] Running download-and-extract step. 03:11:31 INFO - Running pre-action listener: _resource_record_pre_action 03:11:31 INFO - Running main action method: download_and_extract 03:11:31 INFO - mkdir: /builds/slave/test/build/tests 03:11:31 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')]} 03:11:31 INFO - trying https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.test_packages.json 03:11:31 INFO - Downloading https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:11:32 INFO - Downloaded 989 bytes. 03:11:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:11:32 INFO - Using the following test package requirements: 03:11:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:11:32 INFO - u'common': [u'target.common.tests.zip'], 03:11:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:11:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:11:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:11:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:11:32 INFO - u'mozbase': [u'target.common.tests.zip'], 03:11:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:11:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:11:32 INFO - u'web-platform': [u'target.common.tests.zip', 03:11:32 INFO - u'target.web-platform.tests.tar.gz'], 03:11:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:11:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:11:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.common.tests.zip 03:11:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:11:32 INFO - Fetch https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.common.tests.zip into memory 03:11:33 INFO - Content-Length response header: 54004043 03:11:33 INFO - Bytes received: 54004043 03:11:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.common.tests.zip 03:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.common.tests.zip into memory 03:11:45 INFO - Content-Length response header: 54004043 03:11:45 INFO - Bytes received: 54004043 03:11:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.talos.tests.zip 03:11:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:11:57 INFO - Fetch https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.talos.tests.zip into memory 03:11:57 INFO - Content-Length response header: 14496050 03:11:57 INFO - Bytes received: 14496050 03:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:58 INFO - trying https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2 03:11:58 INFO - Downloading https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:11:59 INFO - Downloaded 61824978 bytes. 03:11:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2 03:11:59 INFO - mkdir: /builds/slave/test/properties 03:11:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:59 INFO - Contents: 03:11:59 INFO - build_url:https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2 03:11:59 INFO - Running post-action listener: _resource_record_post_action 03:11:59 INFO - Running post-action listener: set_extra_try_arguments 03:11:59 INFO - [mozharness: 2017-08-16 10:11:59.217380Z] Finished download-and-extract step (success) 03:11:59 INFO - [mozharness: 2017-08-16 10:11:59.217480Z] Running populate-webroot step. 03:11:59 INFO - Running pre-action listener: _resource_record_pre_action 03:11:59 INFO - Running main action method: populate_webroot 03:11:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:11:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:11:59 INFO - 'tests': ['damp', 'tps']}, 03:11:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:11:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:11:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:11:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:59 INFO - 'ts_paint', 03:11:59 INFO - 'tpaint', 03:11:59 INFO - 'sessionrestore', 03:11:59 INFO - 'sessionrestore_many_windows', 03:11:59 INFO - 'sessionrestore_no_auto_restore', 03:11:59 INFO - 'tabpaint']}, 03:11:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:11:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:11:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:59 INFO - 'tsvgr_opacity', 03:11:59 INFO - 'tart', 03:11:59 INFO - 'tscrollx', 03:11:59 INFO - 'tsvg_static']}, 03:11:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:11:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:11:59 INFO - 'talos_options': ['--mitmproxy', 03:11:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:11:59 INFO - '--firstNonBlankPaint'], 03:11:59 INFO - 'tests': ['tp6_google', 03:11:59 INFO - 'tp6_youtube', 03:11:59 INFO - 'tp6_amazon', 03:11:59 INFO - 'tp6_facebook']}, 03:11:59 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:11:59 INFO - 'talos_options': ['--stylo', 03:11:59 INFO - '--mitmproxy', 03:11:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:11:59 INFO - '--firstNonBlankPaint'], 03:11:59 INFO - 'tests': ['tp6_google', 03:11:59 INFO - 'tp6_youtube', 03:11:59 INFO - 'tp6_amazon', 03:11:59 INFO - 'tp6_facebook']}, 03:11:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:11:59 INFO - 'talos_options': ['--stylo', 03:11:59 INFO - '--stylo-threads=1', 03:11:59 INFO - '--mitmproxy', 03:11:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:11:59 INFO - '--firstNonBlankPaint'], 03:11:59 INFO - 'tests': ['tp6_google', 03:11:59 INFO - 'tp6_youtube', 03:11:59 INFO - 'tp6_amazon', 03:11:59 INFO - 'tp6_facebook']}, 03:11:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:11:59 INFO - 'talos_options': ['--xperf_path', 03:11:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:59 INFO - 'tests': ['tp5n']}}} 03:11:59 INFO - Running post-action listener: _resource_record_post_action 03:11:59 INFO - [mozharness: 2017-08-16 10:11:59.226043Z] Finished populate-webroot step (success) 03:11:59 INFO - [mozharness: 2017-08-16 10:11:59.226135Z] Running create-virtualenv step. 03:11:59 INFO - Running pre-action listener: _resource_record_pre_action 03:11:59 INFO - Running main action method: create_virtualenv 03:11:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:59 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 03:11:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:11:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:59 INFO - Using real prefix '/usr' 03:11:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:12:01 INFO - Installing pip.................done. 03:12:01 INFO - Return code: 0 03:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:12:02 INFO - Reading from file tmpfile_stdout 03:12:02 INFO - Output received: 03:12:02 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) 03:12:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:02 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:02 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 03:12:02 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 03:12:02 INFO - Using env: {'DISPLAY': ':0', 03:12:02 INFO - 'HOME': '/home/cltbld', 03:12:02 INFO - 'LANG': 'en_US.UTF-8', 03:12:02 INFO - 'LANGUAGE': 'en_US:en', 03:12:02 INFO - 'LOGNAME': 'cltbld', 03:12:02 INFO - 'MAIL': '/var/mail/cltbld', 03:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:02 INFO - 'MOZ_NO_REMOTE': '1', 03:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:02 INFO - 'NO_EM_RESTART': '1', 03:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:02 INFO - 'PWD': '/builds/slave/test', 03:12:02 INFO - 'SHELL': '/bin/bash', 03:12:02 INFO - 'SHLVL': '1', 03:12:02 INFO - 'TERM': 'linux', 03:12:02 INFO - 'TMOUT': '86400', 03:12:02 INFO - 'USER': 'cltbld', 03:12:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:02 INFO - '_': '/tools/buildbot/bin/python'} 03:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:02 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 03:12:02 INFO - Cleaning up... 03:12:02 INFO - Return code: 0 03:12:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:02 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:02 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 03:12:02 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 03:12:02 INFO - Using env: {'DISPLAY': ':0', 03:12:02 INFO - 'HOME': '/home/cltbld', 03:12:02 INFO - 'LANG': 'en_US.UTF-8', 03:12:02 INFO - 'LANGUAGE': 'en_US:en', 03:12:02 INFO - 'LOGNAME': 'cltbld', 03:12:02 INFO - 'MAIL': '/var/mail/cltbld', 03:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:02 INFO - 'MOZ_NO_REMOTE': '1', 03:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:02 INFO - 'NO_EM_RESTART': '1', 03:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:02 INFO - 'PWD': '/builds/slave/test', 03:12:02 INFO - 'SHELL': '/bin/bash', 03:12:02 INFO - 'SHLVL': '1', 03:12:02 INFO - 'TERM': 'linux', 03:12:02 INFO - 'TMOUT': '86400', 03:12:02 INFO - 'USER': 'cltbld', 03:12:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:02 INFO - '_': '/tools/buildbot/bin/python'} 03:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:02 INFO - Downloading/unpacking psutil>=3.1.1 03:12:02 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 03:12:02 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 03:12:02 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 03:12:02 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 03:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:03 INFO - Installing collected packages: psutil 03:12:03 INFO - Running setup.py install for psutil 03:12:03 INFO - building 'psutil._psutil_linux' extension 03:12:03 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 03:12:03 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 03:12:03 INFO - building 'psutil._psutil_posix' extension 03:12:03 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 03:12:04 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 03:12:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:04 INFO - Successfully installed psutil 03:12:04 INFO - Cleaning up... 03:12:04 INFO - Return code: 0 03:12:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:12:04 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')]} 03:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:04 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')]} 03:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:04 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:04 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 03:12:04 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 03:12:04 INFO - Using env: {'DISPLAY': ':0', 03:12:04 INFO - 'HOME': '/home/cltbld', 03:12:04 INFO - 'LANG': 'en_US.UTF-8', 03:12:04 INFO - 'LANGUAGE': 'en_US:en', 03:12:04 INFO - 'LOGNAME': 'cltbld', 03:12:04 INFO - 'MAIL': '/var/mail/cltbld', 03:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:04 INFO - 'MOZ_NO_REMOTE': '1', 03:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:04 INFO - 'NO_EM_RESTART': '1', 03:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:04 INFO - 'PWD': '/builds/slave/test', 03:12:04 INFO - 'SHELL': '/bin/bash', 03:12:04 INFO - 'SHLVL': '1', 03:12:04 INFO - 'TERM': 'linux', 03:12:04 INFO - 'TMOUT': '86400', 03:12:04 INFO - 'USER': 'cltbld', 03:12:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:04 INFO - '_': '/tools/buildbot/bin/python'} 03:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:12:04 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 03:12:04 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 03:12:04 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 03:12:04 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 03:12:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:12:05 INFO - Installing collected packages: mozsystemmonitor 03:12:05 INFO - Running setup.py install for mozsystemmonitor 03:12:05 INFO - Successfully installed mozsystemmonitor 03:12:05 INFO - Cleaning up... 03:12:05 INFO - Return code: 0 03:12:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:12:05 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')]} 03:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:05 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')]} 03:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:05 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:05 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 03:12:05 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 03:12:05 INFO - Using env: {'DISPLAY': ':0', 03:12:05 INFO - 'HOME': '/home/cltbld', 03:12:05 INFO - 'LANG': 'en_US.UTF-8', 03:12:05 INFO - 'LANGUAGE': 'en_US:en', 03:12:05 INFO - 'LOGNAME': 'cltbld', 03:12:05 INFO - 'MAIL': '/var/mail/cltbld', 03:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:05 INFO - 'MOZ_NO_REMOTE': '1', 03:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:05 INFO - 'NO_EM_RESTART': '1', 03:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:05 INFO - 'PWD': '/builds/slave/test', 03:12:05 INFO - 'SHELL': '/bin/bash', 03:12:05 INFO - 'SHLVL': '1', 03:12:05 INFO - 'TERM': 'linux', 03:12:05 INFO - 'TMOUT': '86400', 03:12:05 INFO - 'USER': 'cltbld', 03:12:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:05 INFO - '_': '/tools/buildbot/bin/python'} 03:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:05 INFO - Downloading/unpacking jsonschema==2.5.1 03:12:05 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 03:12:05 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 03:12:05 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 03:12:05 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 03:12:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:12:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:12:07 INFO - warning: no files found matching '*.txt' 03:12:07 INFO - no previously-included directories found matching 'build' 03:12:07 INFO - no previously-included directories found matching 'dist' 03:12:07 INFO - no previously-included directories found matching '.git*' 03:12:07 INFO - Installing collected packages: jsonschema, functools32 03:12:07 INFO - Running setup.py install for functools32 03:12:07 INFO - warning: no files found matching '*.txt' 03:12:07 INFO - no previously-included directories found matching 'build' 03:12:07 INFO - no previously-included directories found matching 'dist' 03:12:07 INFO - no previously-included directories found matching '.git*' 03:12:07 INFO - Successfully installed jsonschema functools32 03:12:07 INFO - Cleaning up... 03:12:07 INFO - Return code: 0 03:12:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:12:07 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')]} 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:07 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')]} 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:07 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:07 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 03:12:07 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 03:12:07 INFO - Using env: {'DISPLAY': ':0', 03:12:07 INFO - 'HOME': '/home/cltbld', 03:12:07 INFO - 'LANG': 'en_US.UTF-8', 03:12:07 INFO - 'LANGUAGE': 'en_US:en', 03:12:07 INFO - 'LOGNAME': 'cltbld', 03:12:07 INFO - 'MAIL': '/var/mail/cltbld', 03:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:07 INFO - 'MOZ_NO_REMOTE': '1', 03:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:07 INFO - 'NO_EM_RESTART': '1', 03:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:07 INFO - 'PWD': '/builds/slave/test', 03:12:07 INFO - 'SHELL': '/bin/bash', 03:12:07 INFO - 'SHLVL': '1', 03:12:07 INFO - 'TERM': 'linux', 03:12:07 INFO - 'TMOUT': '86400', 03:12:07 INFO - 'USER': 'cltbld', 03:12:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:07 INFO - '_': '/tools/buildbot/bin/python'} 03:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:12:07 INFO - Cleaning up... 03:12:07 INFO - Return code: 0 03:12:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:12:07 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')]} 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:07 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')]} 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:07 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:07 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 03:12:07 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 03:12:07 INFO - Using env: {'DISPLAY': ':0', 03:12:07 INFO - 'HOME': '/home/cltbld', 03:12:07 INFO - 'LANG': 'en_US.UTF-8', 03:12:07 INFO - 'LANGUAGE': 'en_US:en', 03:12:07 INFO - 'LOGNAME': 'cltbld', 03:12:07 INFO - 'MAIL': '/var/mail/cltbld', 03:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:07 INFO - 'MOZ_NO_REMOTE': '1', 03:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:07 INFO - 'NO_EM_RESTART': '1', 03:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:07 INFO - 'PWD': '/builds/slave/test', 03:12:07 INFO - 'SHELL': '/bin/bash', 03:12:07 INFO - 'SHLVL': '1', 03:12:07 INFO - 'TERM': 'linux', 03:12:07 INFO - 'TMOUT': '86400', 03:12:07 INFO - 'USER': 'cltbld', 03:12:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:07 INFO - '_': '/tools/buildbot/bin/python'} 03:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:08 INFO - Downloading blobuploader-1.2.4.tar.gz 03:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:12:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:12:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:09 INFO - Downloading docopt-0.6.1.tar.gz 03:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:12:09 INFO - Running setup.py install for blobuploader 03:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:12:09 INFO - Running setup.py install for requests 03:12:10 INFO - Running setup.py install for docopt 03:12:10 INFO - Successfully installed blobuploader requests docopt 03:12:10 INFO - Cleaning up... 03:12:10 INFO - Return code: 0 03:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:10 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')]} 03:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:10 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')]} 03:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:10 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:10 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 03:12:10 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 03:12:10 INFO - Using env: {'DISPLAY': ':0', 03:12:10 INFO - 'HOME': '/home/cltbld', 03:12:10 INFO - 'LANG': 'en_US.UTF-8', 03:12:10 INFO - 'LANGUAGE': 'en_US:en', 03:12:10 INFO - 'LOGNAME': 'cltbld', 03:12:10 INFO - 'MAIL': '/var/mail/cltbld', 03:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:10 INFO - 'MOZ_NO_REMOTE': '1', 03:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:10 INFO - 'NO_EM_RESTART': '1', 03:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:10 INFO - 'PWD': '/builds/slave/test', 03:12:10 INFO - 'SHELL': '/bin/bash', 03:12:10 INFO - 'SHLVL': '1', 03:12:10 INFO - 'TERM': 'linux', 03:12:10 INFO - 'TMOUT': '86400', 03:12:10 INFO - 'USER': 'cltbld', 03:12:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:10 INFO - '_': '/tools/buildbot/bin/python'} 03:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:10 INFO - Running setup.py (path:/tmp/pip-XNfvrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:10 INFO - Running setup.py (path:/tmp/pip-KwiDPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:10 INFO - Running setup.py (path:/tmp/pip-owdFrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:10 INFO - Running setup.py (path:/tmp/pip-IAxhgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:10 INFO - Running setup.py (path:/tmp/pip-2Syvi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:10 INFO - Running setup.py (path:/tmp/pip-TwB6ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:10 INFO - Running setup.py (path:/tmp/pip-bAVlg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:10 INFO - Running setup.py (path:/tmp/pip-GeQl1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:10 INFO - Running setup.py (path:/tmp/pip-SGHqpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:11 INFO - Running setup.py (path:/tmp/pip-jpJIZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:11 INFO - Running setup.py (path:/tmp/pip-4kNB3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:11 INFO - Running setup.py (path:/tmp/pip-_sSaqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:11 INFO - Running setup.py (path:/tmp/pip-nhsqsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:11 INFO - Running setup.py (path:/tmp/pip-ow5AGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:11 INFO - Running setup.py (path:/tmp/pip-VGr53o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:11 INFO - Running setup.py (path:/tmp/pip-d5vfmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:11 INFO - Running setup.py (path:/tmp/pip-MWxYdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:12:11 INFO - Running setup.py install for manifestparser 03:12:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:12:11 INFO - Running setup.py install for mozcrash 03:12:11 INFO - Running setup.py install for mozdebug 03:12:11 INFO - Running setup.py install for mozdevice 03:12:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for mozfile 03:12:12 INFO - Running setup.py install for mozhttpd 03:12:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for mozinfo 03:12:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for mozInstall 03:12:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for mozleak 03:12:12 INFO - Running setup.py install for mozlog 03:12:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for moznetwork 03:12:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for mozprocess 03:12:12 INFO - Running setup.py install for mozprofile 03:12:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:12:12 INFO - Running setup.py install for mozrunner 03:12:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:12:13 INFO - Running setup.py install for mozscreenshot 03:12:13 INFO - Running setup.py install for moztest 03:12:13 INFO - Running setup.py install for mozversion 03:12:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:12:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:12:13 INFO - Cleaning up... 03:12:13 INFO - Return code: 0 03:12:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:13 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')]} 03:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:13 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')]} 03:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:13 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:13 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 03:12:13 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 03:12:13 INFO - Using env: {'DISPLAY': ':0', 03:12:13 INFO - 'HOME': '/home/cltbld', 03:12:13 INFO - 'LANG': 'en_US.UTF-8', 03:12:13 INFO - 'LANGUAGE': 'en_US:en', 03:12:13 INFO - 'LOGNAME': 'cltbld', 03:12:13 INFO - 'MAIL': '/var/mail/cltbld', 03:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:13 INFO - 'MOZ_NO_REMOTE': '1', 03:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:13 INFO - 'NO_EM_RESTART': '1', 03:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:13 INFO - 'PWD': '/builds/slave/test', 03:12:13 INFO - 'SHELL': '/bin/bash', 03:12:13 INFO - 'SHLVL': '1', 03:12:13 INFO - 'TERM': 'linux', 03:12:13 INFO - 'TMOUT': '86400', 03:12:13 INFO - 'USER': 'cltbld', 03:12:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:13 INFO - '_': '/tools/buildbot/bin/python'} 03:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:13 INFO - Running setup.py (path:/tmp/pip-xk8kWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:13 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)) 03:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:13 INFO - Running setup.py (path:/tmp/pip-LrPuYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:13 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)) 03:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:13 INFO - Running setup.py (path:/tmp/pip-UW8gS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:13 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)) 03:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:13 INFO - Running setup.py (path:/tmp/pip-ofz5je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:13 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)) 03:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:13 INFO - Running setup.py (path:/tmp/pip-_MDeoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:13 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)) 03:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:13 INFO - Running setup.py (path:/tmp/pip-KRUbaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:14 INFO - Running setup.py (path:/tmp/pip-j6Vfs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:14 INFO - Running setup.py (path:/tmp/pip-dcI9QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:14 INFO - Running setup.py (path:/tmp/pip-AHNdYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:14 INFO - Running setup.py (path:/tmp/pip-G1xgUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:14 INFO - Running setup.py (path:/tmp/pip-1RO81p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:14 INFO - Running setup.py (path:/tmp/pip-iea1UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:14 INFO - Running setup.py (path:/tmp/pip-NeEqr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:14 INFO - Running setup.py (path:/tmp/pip-_wCUn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:14 INFO - Running setup.py (path:/tmp/pip-ak1wDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:14 INFO - Running setup.py (path:/tmp/pip-w3KBPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:14 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)) 03:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:14 INFO - Running setup.py (path:/tmp/pip-Vj5Xjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:14 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)) 03:12:14 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)) 03:12:14 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)) 03:12:14 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)) 03:12:14 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)) 03:12:14 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)) 03:12:14 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)) 03:12:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:14 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 03:12:14 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 03:12:14 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 03:12:14 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 03:12:16 INFO - Downloading blessings-1.6.tar.gz 03:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:12:16 INFO - Installing collected packages: blessings 03:12:16 INFO - Running setup.py install for blessings 03:12:16 INFO - Successfully installed blessings 03:12:16 INFO - Cleaning up... 03:12:16 INFO - Return code: 0 03:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:16 INFO - Reading from file tmpfile_stdout 03:12:16 INFO - Current package versions: 03:12:16 INFO - argparse == 1.2.1 03:12:16 INFO - blessings == 1.6 03:12:16 INFO - blobuploader == 1.2.4 03:12:16 INFO - docopt == 0.6.1 03:12:16 INFO - functools32 == 3.2.3-2 03:12:16 INFO - jsonschema == 2.5.1 03:12:16 INFO - manifestparser == 1.1 03:12:16 INFO - mozInstall == 1.13 03:12:16 INFO - mozcrash == 1.0 03:12:16 INFO - mozdebug == 0.1 03:12:16 INFO - mozdevice == 0.51 03:12:16 INFO - mozfile == 1.2 03:12:16 INFO - mozhttpd == 0.7 03:12:16 INFO - mozinfo == 0.10 03:12:16 INFO - mozleak == 0.1 03:12:16 INFO - mozlog == 3.5 03:12:16 INFO - moznetwork == 0.27 03:12:16 INFO - mozprocess == 0.25 03:12:16 INFO - mozprofile == 0.28 03:12:16 INFO - mozrunner == 6.13 03:12:16 INFO - mozscreenshot == 0.1 03:12:16 INFO - mozsystemmonitor == 0.3 03:12:16 INFO - moztest == 0.8 03:12:16 INFO - mozversion == 1.4 03:12:16 INFO - psutil == 3.1.1 03:12:16 INFO - requests == 1.2.3 03:12:16 INFO - wsgiref == 0.1.2 03:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:16 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')]} 03:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:16 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')]} 03:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:16 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:16 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 03:12:16 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 03:12:16 INFO - Using env: {'DISPLAY': ':0', 03:12:16 INFO - 'HOME': '/home/cltbld', 03:12:16 INFO - 'LANG': 'en_US.UTF-8', 03:12:16 INFO - 'LANGUAGE': 'en_US:en', 03:12:16 INFO - 'LOGNAME': 'cltbld', 03:12:16 INFO - 'MAIL': '/var/mail/cltbld', 03:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:16 INFO - 'MOZ_NO_REMOTE': '1', 03:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:16 INFO - 'NO_EM_RESTART': '1', 03:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:16 INFO - 'PWD': '/builds/slave/test', 03:12:16 INFO - 'SHELL': '/bin/bash', 03:12:16 INFO - 'SHLVL': '1', 03:12:16 INFO - 'TERM': 'linux', 03:12:16 INFO - 'TMOUT': '86400', 03:12:16 INFO - 'USER': 'cltbld', 03:12:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:16 INFO - '_': '/tools/buildbot/bin/python'} 03:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 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)) 03:12:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:12:16 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 03:12:16 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 03:12:16 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 03:12:16 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 03:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:12:17 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)) 03:12:17 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)) 03:12:17 INFO - Installing collected packages: simplejson 03:12:17 INFO - Running setup.py install for simplejson 03:12:17 INFO - building 'simplejson._speedups' extension 03:12:17 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 03:12:18 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 03:12:18 INFO - Successfully installed simplejson 03:12:18 INFO - Cleaning up... 03:12:18 INFO - Return code: 0 03:12:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:12:18 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')]} 03:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:18 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')]} 03:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:18 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 0xc4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd51a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef4ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, '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': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', '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 03:12:18 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 03:12:18 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 03:12:18 INFO - Using env: {'DISPLAY': ':0', 03:12:18 INFO - 'HOME': '/home/cltbld', 03:12:18 INFO - 'LANG': 'en_US.UTF-8', 03:12:18 INFO - 'LANGUAGE': 'en_US:en', 03:12:18 INFO - 'LOGNAME': 'cltbld', 03:12:18 INFO - 'MAIL': '/var/mail/cltbld', 03:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:18 INFO - 'MOZ_NO_REMOTE': '1', 03:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:18 INFO - 'NO_EM_RESTART': '1', 03:12:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:18 INFO - 'PWD': '/builds/slave/test', 03:12:18 INFO - 'SHELL': '/bin/bash', 03:12:18 INFO - 'SHLVL': '1', 03:12:18 INFO - 'TERM': 'linux', 03:12:18 INFO - 'TMOUT': '86400', 03:12:18 INFO - 'USER': 'cltbld', 03:12:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:18 INFO - '_': '/tools/buildbot/bin/python'} 03:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:12:19 INFO - Cleaning up... 03:12:19 INFO - Return code: 0 03:12:19 INFO - Running post-action listener: _resource_record_post_action 03:12:19 INFO - Running post-action listener: _start_resource_monitoring 03:12:19 INFO - Starting resource monitoring. 03:12:19 INFO - [mozharness: 2017-08-16 10:12:19.220994Z] Finished create-virtualenv step (success) 03:12:19 INFO - [mozharness: 2017-08-16 10:12:19.221496Z] Running install step. 03:12:19 INFO - Running pre-action listener: _resource_record_pre_action 03:12:19 INFO - Running main action method: install 03:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:19 INFO - Reading from file tmpfile_stdout 03:12:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:12:19 INFO - Reading from file tmpfile_stdout 03:12:19 INFO - Output received: 03:12:19 INFO - Usage: mozinstall [options] installer 03:12:19 INFO - Options: 03:12:19 INFO - -h, --help show this help message and exit 03:12:19 INFO - -d DEST, --destination=DEST 03:12:19 INFO - Directory to install application into. [default: 03:12:19 INFO - "/builds/slave/test"] 03:12:19 INFO - --app=APP Application being installed. [default: firefox] 03:12:19 INFO - mkdir: /builds/slave/test/build/application 03:12:19 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'] 03:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:12:37 INFO - Reading from file tmpfile_stdout 03:12:37 INFO - Output received: 03:12:37 INFO - /builds/slave/test/build/application/firefox/firefox 03:12:37 INFO - Running post-action listener: _resource_record_post_action 03:12:37 INFO - [mozharness: 2017-08-16 10:12:37.490764Z] Finished install step (success) 03:12:37 INFO - [mozharness: 2017-08-16 10:12:37.490911Z] Running setup-mitmproxy step. 03:12:37 INFO - Running pre-action listener: _resource_record_pre_action 03:12:37 INFO - Running main action method: setup_mitmproxy 03:12:37 INFO - Skipping: mitmproxy is not required 03:12:37 INFO - Running post-action listener: _resource_record_post_action 03:12:37 INFO - [mozharness: 2017-08-16 10:12:37.491463Z] Finished setup-mitmproxy step (success) 03:12:37 INFO - [mozharness: 2017-08-16 10:12:37.491568Z] Running run-tests step. 03:12:37 INFO - Running pre-action listener: _resource_record_pre_action 03:12:37 INFO - Running pre-action listener: _set_gcov_prefix 03:12:37 INFO - Running main action method: run_tests 03:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:37 INFO - Python 2.7.3 03:12:37 INFO - Return code: 0 03:12:37 INFO - grabbing minidump binary from tooltool 03:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:37 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 0xef20b0>, '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 0xef2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef3440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:37 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 03:12:37 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 03:12:37 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 03:12:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:37 INFO - Return code: 0 03:12:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:12:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:37 INFO - ENV: RUST_BACKTRACE is now full 03:12:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:12:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:37 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/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 03:12:37 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/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 03:12:37 INFO - Using env: {'DISPLAY': ':0', 03:12:37 INFO - 'HOME': '/home/cltbld', 03:12:37 INFO - 'LANG': 'en_US.UTF-8', 03:12:37 INFO - 'LANGUAGE': 'en_US:en', 03:12:37 INFO - 'LOGNAME': 'cltbld', 03:12:37 INFO - 'MAIL': '/var/mail/cltbld', 03:12:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:37 INFO - 'MOZ_NO_REMOTE': '1', 03:12:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:12:37 INFO - 'NO_EM_RESTART': '1', 03:12:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:37 INFO - 'PWD': '/builds/slave/test', 03:12:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:37 INFO - 'RUST_BACKTRACE': 'full', 03:12:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:12:37 INFO - 'SHELL': '/bin/bash', 03:12:37 INFO - 'SHLVL': '1', 03:12:37 INFO - 'STYLO_FORCE_ENABLED': '1', 03:12:37 INFO - 'TERM': 'linux', 03:12:37 INFO - 'TMOUT': '86400', 03:12:37 INFO - 'USER': 'cltbld', 03:12:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905', 03:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:37 INFO - '_': '/tools/buildbot/bin/python'} 03:12:37 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/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 03:12:37 INFO - mozversion application_buildid: 20170816091812 03:12:37 INFO - mozversion application_changeset: c498777e8f39a3027e44d7badad05bd3a3f86f08 03:12:37 INFO - mozversion application_display_name: Nightly 03:12:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:37 INFO - mozversion application_name: Firefox 03:12:37 INFO - mozversion application_remotingname: firefox 03:12:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:12:37 INFO - mozversion application_vendor: Mozilla 03:12:37 INFO - mozversion application_version: 57.0a1 03:12:37 INFO - mozversion platform_buildid: 20170816091812 03:12:37 INFO - mozversion platform_changeset: c498777e8f39a3027e44d7badad05bd3a3f86f08 03:12:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:12:37 INFO - mozversion platform_version: 57.0a1 03:12:37 INFO - using testdate: 1502878357 03:12:37 INFO - actual date: 1502878357 03:12:37 INFO - starting webserver on 'localhost:49472' 03:12:37 INFO - SUITE-START | Running 2 tests 03:12:37 INFO - TEST-START | dromaeo_css 03:12:37 INFO - Initialising browser for dromaeo_css test... 03:12:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49472/getInfo.html -profile /tmp/tmpOjmtrx/profile 03:12:37 INFO - TEST-INFO | started process 7493 (/builds/slave/test/build/application/firefox/firefox http://localhost:49472/getInfo.html) 03:12:43 INFO - TEST-INFO | 7493: exit 0 03:12:43 INFO - Browser initialized. 03:12:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:43 INFO - TEST-INFO | started process 7730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOjmtrx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:44 INFO - PID 7730 | 03:12:44 INFO - PID 7730 | (/builds/slave/test/build/application/firefox/firefox:7785): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:12:44 INFO - PID 7730 | 03:12:55 INFO - PID 7730 | RSS: Main: 167448576 03:12:55 INFO - PID 7730 | 03:15:54 INFO - PID 7730 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49472/tests/dromaeo/cssquery-ext.html) 03:15:55 INFO - PID 7730 | RSS: Main: 174546944 03:15:55 INFO - PID 7730 | 03:18:57 INFO - PID 7730 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-ext.html (next: http://localhost:49472/tests/dromaeo/cssquery-jquery.html) 03:18:57 INFO - PID 7730 | RSS: Main: 172351488 03:18:57 INFO - PID 7730 | 03:21:59 INFO - PID 7730 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49472/tests/dromaeo/cssquery-mootools.html) 03:22:00 INFO - PID 7730 | RSS: Main: 174419968 03:22:00 INFO - PID 7730 | 03:25:02 INFO - PID 7730 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49472/tests/dromaeo/cssquery-prototype.html) 03:25:02 INFO - PID 7730 | RSS: Main: 172486656 03:25:02 INFO - PID 7730 | 03:28:06 INFO - PID 7730 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49472/tests/dromaeo/cssquery-yui.html) 03:28:06 INFO - PID 7730 | RSS: Main: 173948928 03:28:06 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | Cycle 1(1): loaded http://localhost:49472/tests/dromaeo/cssquery-yui.html (next: http://localhost:49472/tests/dromaeo/cssquery-dojo.html) 03:31:08 INFO - PID 7730 | RSS: Main: 176517120 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | __start_tp_report 03:31:08 INFO - PID 7730 | _x_x_mozilla_page_load 03:31:08 INFO - PID 7730 | _x_x_mozilla_page_load_details 03:31:08 INFO - PID 7730 | |i|pagename|runs| 03:31:08 INFO - PID 7730 | |0;dojo.html;3124.828134452606;3173.4605117130086;3206.807591544507;3218.291975765331;3226.822524761137;6228.346023667517;6288.559800813945;6317.14718513;6331.905021424676;6368.458681012119;6085.4827339676185;6196.287426945903;6199.876002479948;6206.7827626033095;6233.968830155854;5684.744186511596;5697.715114244292;5721.056025755745;5727.627704199234;5740.225069615611;5728.198052272664;5762.250907382035;5763.913541296863;5771.769129234846;5777.393373695764;5804.651720896739;5816.82549523515;5824.388439213885;5831.533477321804;5833.8833223335505;5730.36965933747;5767.250257466502;5775.624584402;5838.241028666246;5846.649201047908;5196.324477817897;5538.363088244863;5633.985882541141;5645.520130788888;5712.571557133231;6119.449249567516;6150;6164.137020817045;6230.719617617218;6262.436380725757;6657.334266573353;6669.666516674147;6684.465242780614;6761.526693131483;6765.627890466022;6759.5606285591275;6776.593404395703;6801.047853300542;6807;6809.557378770364;6316.273628532732;6339.492840572835;6352.4918006559365;6355.87288254237;6356;6918.100646915969;6919.619420931897;6937.618430986344;7027.6837542309695;7035.929640703527;6542.182227221598;6556.18047744032;6600.834979125464;6687;6700.396964273142;6626.768063117865;6784.253732089466;6810.080639113756;6814.795556133324;6814.863702725917;6684.598924064571;6713.597184168965;6787.694553745093;6805.217399999064;6814.352636499525;6621.337866213436;6701.6314102723845;6715.764948226789;6727.529072964846;6802.693878775368;5438.510534051875;5442.727863606804;5443.020256353894;5443.972780136074;5451.400345961941;4667.463241727177;4687;4729.196036673774;4759.785809638574;4774.522547745198;5682.659040457585;5700.714964251771;5790.276215473066;5841.4450627190345;5922.585419020714;6726.192856857208;6728.7308507659145;6754.358335958076;6762.69567869447;6778.525503214728;5785.971070144622;5851.970740146272;5904.202932604129;5912.76348946046;5926.940730592639;5877;5979.1629171915965;5997.370276121032;5997.790077347359;6036.577439579275;6438.45273151778;6530.987696906987;6590.439812615981;6598.835029124214;6605.273419923805;6767.1879374475375;6776.08522849409;6810.148731408574;6848.623325717133;6850.623215723183;6524.771632992823;6529.640869752209;6544.9672751635935;6599.934000659932;6633.701483433354;6497.577657452251;6602.141721576164;6621.602703837785;6684.598924064571;6704.731810727516;6740.157480314961;6752.257251702407;6772.221194562689;6804.82987925286;6831.214410342675;6561.376669216417;6590.275069742229;6618.6690665467495;6628.270890201978;6635.834104147435;6553.705083271169;6557.672116394066;6644.767433139817;6645.800625981228;6656.966715166393;6313.273973493107;6433.388828061326;6455.386738259858;6456.192975878015;6555.2133743949125;6513.576617519846;6516.73933042692;6596.3073877244115;6641.33586641332;6658.766943156967;6244.781432649836;6321.367863213642;6322.620642761449;6391.488680905423;6427.903581446189 03:31:08 INFO - PID 7730 | |1;ext.html;823.1932705948175;827.3877330775224;841.3101256969285;868.5092922498784;868.8479516084684;41546;42186.99999999996;42193.7890310548;42258;42422.36366454502;38771.41842872359;39208.21583568334;39316.410253846145;39355.212895742065;39627;6739.663016849163;6834.658267086651;6836.316368363149;6840.384365407112;6843.520953533254;6909.861802763941;6931.202911665173;6966.268541803113;6974.930250697505;6976.127984002;7634.770956871275;7837.608119593998;7855.960720196391;7856.7642970710685;7872.803179920491;7758.224177582253;7795.1035630902325;7801.336886364666;7818.765437036898;7819.804504887366;7401.70393184272;7498.325150736406;7500.399968002546;7502.437317201177;7656.272654097852;38854.61145388538;39138;39147;39168.80415597932;39240.60759392398;3605.2068544920076;3659.176685245825;3659.2864391443677;3663.4138537834087;3665.6334366563397;31549;31601.84199079013;31619.20951976196;31627.683723162703;31634.683653163404;5071.644984851062;5077.517635824591;5079.1365467870555;5096.566791822699;5102.132637451605;192660;192846;193383.9999999986;193783;193979;50514.747426262635;51045;51077.23384149241;51196.74401628043;51248.48751512512;52512.212316815276;52625.210621840706;52784.47215527796;52790.20814687783;52899.47100529022;16606.25271862769;16811.243494042796;16844.24200910962;16859.747103793452;16910.32358705638;13978.091424057404;13988.090774099652;14010.229437381042;14018.719625607431;14025.579232623038;14907.850921490646;14960.40158393652;15015.249237538079;15065.548033559011;15134.848651513345;5861.970690146607;5914.852128696817;5967.940320596738;6007.36922623127;6013;999.4513989327331;1015.4161357219629;1024.4775164665925;1033.7467320506373;1037.3309215556076;23160.841957902376;23263.41841453977;23296.65055024176;23430.297091087294;23434.06263749431;1109.3066833229232;1109.8470358539298;1126.110372805491;1129.3619105205532;1133.8015847226702;12442.440090195963;12452.190607610477;12466.75066498665;16979.575510612085;17048.48854534366;239149;241723;242050;242288;243459;55449.168262476094;55920;61162.38837611567;63519.68240158862;63839;1518.8025556677783;1547.674988252457;1556.2996651506867;1560.8127024756875;1561.851624095709;27883.581746274227;28141.718582813908;28203.576946345413;28460.288492787848;28867;39003.80498097491;39177;39196.60803391929;39246;39258.2148357037;153343;153774;153866;154441;155430;36986.44520332143;37398.626013740606;37689;37750.2449950994;38340.23319533649;48094.27858582194;48109.5189048105;48368;48718.26922596093;48894;34260;34561.30877382388;34628;34688.132796680286;35366.46950295799;33801.83099084489;34360.65639343575;34700.47949280712;34734.826325868205;35521.28957420889;36380.81809591041;36998.8150059248;37330.06674833151;37407.625923740416;37640.247195056494;33512;33522.32955340928;33702.49446258357;33836;34209.657903420644;24042.278731638078;24262.90816913208;24410.51178976446;24728.752712472644;24813.25560233196 03:31:08 INFO - PID 7730 | |2;jquery.html;575.8272518244526;578.861073342398;580.3065336922374;587.764894042383;595.8004068637007;22660.54678906423;23023.76976230237;23673.76326236737;23695.289141325746;23703.762962370372;26951.32621684454;27684.723152768467;27692.861535692344;27789.166325010232;27838.16485505433;6498.577592456499;6736.157980252468;6738.494612904027;6754.5947243165565;6784.575239199774;6283.842903927415;6558.704858281365;6588.901166482483;6619.30497297784;6649.368310010541;6551.93448065518;6554.41010309072;6556.246031706343;6560.147180866481;6563.113979612763;6539.836504087389;6541.967290163542;6542.084108224853;6542.4438922691625;6542.574732642387;6087.05650624154;6093.542984276197;6098.847528811771;6099.603525770811;6101.969490152565;28795.56806647902;29768.70231297681;30023.249418764706;30096.398072038657;30180.698193018226;1921.193098898466;1925.8266755991888;1926.2776458827939;1935.0808366026165;1936.1287420660758;20167.495812604655;20741.27405540799;20750.688739668916;20756.273530426362;20808.27171049021;2298.3794375518514;2367.9881600592057;2423.672804171432;2429.3440770991733;2439.5486834935596;129119;135200;135674;135929.64070359268;136038;14268.643283917778;15027.323770430357;15166.469173578871;15303.38786448552;15452.304646290719;22796.886015569817;23689.763102368757;23699.763002370102;23792.167274145322;23864.164754233865;10365.170786337076;10536.63121790749;10558.736031599117;10706.89293107059;10742.194335424874;10012.847237843898;10061.597536098621;10103.797924041479;10104.797904041878;10131.645392411378;9464.479453630116;9617.374870633526;9725.610975560898;9750.171235444925;9800.26498012652;2639.5248855206246;2642.5903984882375;2665.60015997598;2770.8476033818333;2803.90186343477;970.2335155227291;974.7660561465198;978.5449765858909;981.2101258486987;989.5200827598609;19268.4219473416;20510.17959281612;23960.821667772103;25529;25612.615810762854;1026.984595231072;1029.120102312512;1033.1631378583372;1040.1314902056868;1042.3693665332517;11251.606193783178;11440.027597654293;11486.597969071043;11533.711657208469;11567;474810;486102;494676;495607;501254;114872;116959;119243;119396;119566;1280.5966120671958;1298.5519995601503;1317.637649646355;1318.5451019398292;1319.9406026729012;17832.55418614545;17833.46499605014;17984.460466186036;18029.368972085915;18403;57364.13953790613;60368.39631603804;61240.69379653251;62271.37728622837;62859.371406285354;70553.64723176352;77002;80144.19855801367;80837.19162808296;81894;14263.714725705635;14740.410383584966;14829.703405932038;14855;14909.925450373112;20885.26901558438;21112.68330975006;23712.881435592713;24060.75939240655;24089.277321680376;18585.16366763472;18832.34086806955;18868.905655471634;18924;19013.33453329127;17298.221580028676;17311.65376692434;17363.7395439066;17562.912185438992;17867.28530858803;18478.815211848247;19387.2245110194;19411.902940485208;19613;19659.41021769349;14751.631209219855;14826.555203343916;14868.107913525224;14907.701845963236;14910.478133265284;18158.5460363492;18741.250349985847;18749.437516874517;18763.249470021045;18801.52996175052 03:31:08 INFO - PID 7730 | |3;mootools.html;1378.5381897064485;1424.9786253206203;1430.628036710455;1438.1586771738532;1442.2860683961435;14115.929420352897;14363.066400683974;14729.926350368247;14744.115353078823;14754.40982360707;14859.405623775036;15143.77284340733;15153.54539363818;15160;15162;2479.342974111857;2526.2926380613367;2527.848329100251;2527.9241622751256;2529.8608576528377;2611.569091099966;2666.546687063204;2687.905923292675;2721.972780272192;2726.3184203949013;2466.087547607388;2481.6153496208117;2660.507806055886;2696.12375977808;2708.5801700736415;2542.313575334649;2542.707588627313;2543.6566063581363;2544.389346556822;2547.083050101962;2536.7970562354967;2559.590465525526;2589.4432696970052;2590.974090259092;2598.8050896182863;13735.656608584766;14073.366698498592;14092.436302547885;14097.154170749685;14133.152010879277;7469.887951680729;7744.690212391498;7749.457537972344;7760.06879174497;7772.145064042951;4704.623630109583;4709.505501922283;4868.707877527324;4897.853064408074;4898.2162853943555;1891.0544727636182;1894.4316704988448;1905.8380037696813;1962.6663467210608;1962.764468263803;23819.761802381927;23929.88035059831;23967.041318347245;24084.879575602186;24126.155584554457;6221.3156552779155;6433;6551.901721474182;6591.242007169141;6638;16115.758263626056;16183.10992895402;16222.107784071753;16223.594410139842;16236;6860.6912688929115;7119.608421536762;7394.223606521346;7453.515521491086;7457.664405101675;6098.512119030467;6306.873862522724;6880.759173428906;6888.552244104218;7129.679164437613;4942.57988071018;5125;5175.327207463006;5175.974120129451;5230.63385563007;1426.7268886569252;1443.6679563700409;1444.8988570800154;1454.1420561868338;1475.6089636246404;863.9784005399915;871.8692196170625;881.8765372847806;884.7743825324501;896.9416987895896;7131.643417829087;7140.428765698732;7142.250063743336;7152.249013853574;7169.641517924083;701.2846896165984;710.591409939287;717.7057406463325;718.4324383736894;722.2091809468624;4787.257975013878;5542.11326187808;5677;5806.970965145148;5809.767609295665;19506.414807555797;19511.609767804566;20316.89841550783;20338;20338.694919576217;19797.20811167566;19892;19902.50243743918;19956.002199889946;20075.498112547302;10138.341007834468;10704.625338113128;10948.069414099891;10951.780964380827;10967;8308.418410711192;8347.540885251126;8419.11599282091;8430.747077587683;8466.153384661484;17193.742093868852;17214.569635759206;17393.913030434767;17447.47657570275;17469.301227951248;17800.643987120446;17854.5536361592;17855.73216401729;17997.460076197734;18237.088145592403;11731;11927.701807454883;12038;12109.878901210875;12110.515579376726;13466.259355735529;13646.044776865921;13656.385462654005;13674.658133546343;13691.178529288274;11002.229843910849;11049.944750276198;11127.88872111301;11196.608118715805;11431.199816012799;10485.737856553647;10521.78956420852;10526;10572.84140737874;10741.301815381976;9328.253739700673;9454.669086581936;9455.574499147417;9462.621495140118;9471.384360016576;7356.154042284991;7476.140243872024;7477.626118693935;7504.662290197063;7584.469087163846;7373.29953654402;7433.108027036574;7458.888116678146;7550.7734767957045;7563.508371955805 03:31:08 INFO - PID 7730 | |4;prototype.html;474.63453141081345;490.5781028315648;494.7600413799309;500.8472415913146;514.0900605927509;6169.5989760665525;6170.598911070777;6180.536459765524;6275.811725648232;6300.180976473052;6083;6095.786647467339;6097.390260973901;6116.235470566179;6123.3876612338745;4824.372831531896;4965.7020578765205;4995.275685025669;5036.546710796028;5038.21907604321;4927.310176575283;4950.316892256632;4959.553640172384;4973.751312434364;5020.799168033274;4873.34209881665;4910.2143657014885;4933;4954;5001.499850015006;4863.027394521092;4912.140375434303;4912.280701754393;4923.645997350722;4963.230699241623;4490.708103973231;4492.820287188509;4495.190865644183;4499.977500112511;4508.752018638974;6003.849903752397;6012.278526576795;6098.756049758049;6118.847028824271;6165.383461653843;5628.662280263197;5646.26598542191;5660.179274005287;5684.261046064026;5704.828855134311;6420.715856828653;6442.710078046499;6450.161479007746;6561.3438656134485;6567.0627164986445;4843.200871856139;4853.296272040569;4878.682885612424;4897;4903.387076615423;6574.389274627747;6626.966865165643;6695.899561506581;6787.864242715167;6867.725290988355;4942;4951.777170027357;4959.817680220692;4963.478834722302;5004.874878128003;5010.64925455222;5019.974900125476;5021.472745361758;5058.418281897555;5069.200433845932;5579.660881388438;5584.46947539983;5614.9719251403485;5628.452175651647;5670.404607516234;6526.759915616018;6561;6588.4729221662155;6591.242007169141;6592.43964263043;1750.0812073661175;1765.1350838089245;1770.8406243438153;1771.4419957713278;1787.5709829641053;1164.1152723929874;1212.121212121205;1227.766724322376;1231.741334319803;1238.8823061809114;5714.200011998323;5725.599208055396;5725.969325521362;5760;5792.899349123737;6551.508636852255;6625.668716564152;6698.665066746643;6728.192616885907;6777.2545020047755;5631.63394379364;5638.774449021993;5657.179708942181;5727.7089164333765;5742.741576628978;3505.298940211968;3513.9648603514147;3553.271579326232;3557.1640664443835;3564.4831499432958;6444.130042444303;6463.612183269019;6480.51396145291;6529.094552923903;6546.410823025951;6845.794626161223;6877.65611719412;6914.827129321807;6925.757598484029;6998.440124790106;6413.16628838248;6534;6544.411003009752;6544.9672751635935;6556.541042127005;6574.572652777554;6597.6041437511985;6606.465540935576;6654.367835055662;6734;6003.949308871018;6608.127547350701;6644.4020038196795;6687.531872768859;6698.430633396216;6383.808485745435;6387.297397286387;6460.870782584416;6471.611703297817;6532.216134063943;4939.629527785502;4940.456549779593;4992.600591952708;4998.500149984972;5029.4719054498755;6508.316626754123;6514;6683.966580167068;6738.898916516158;6758.391744742997;6390.680465976776;6407.295197528175;6409.647469389229;6498.837529061811;6501.284858665637;6372.235331760218;6456.709448074942;6469.729978214356;6488.416042556192;6518.511111666549;6273.874522509615;6276.748930042747;6416.743330266737;6421.646809425526;6435.388638079375;6465.515086368635;6530.412262896362;6539.476841852736;6598.274189839018;6599;6324.810255692337;6338.746450141943;6341.4292713656;6359.872802544016;6367.42693157618 03:31:08 INFO - PID 7730 | |5;yui.html;903.3586153830784;907.3376435202302;924.7688077980507;925.3661242049201;928.2156577691852;21548.89225553872;23429.179978700726;23493.882530587343;23571.41071473214;23595.5280894382;20778.792212077875;21925.561488770214;21943;21994;22005.449863753413;973.4743238651138;989.351974456732;989.4607438945756;989.6585677941099;990.529498488216;1014.2595904989362;1059.464970190053;1059.6026490066224;1059.8622179116703;1060.1571750458365;1114.9777004459906;1121.024708503603;1121.1031175059961;1121.344013751956;1121.5401685309025;1111.8554587903561;1113.9944300278487;1114.637742733615;1116.101538261699;1116.4585176189541;811.6469335838929;814.0475643497123;815.135955886756;815.3314282288526;817.6157206113118;20266.797332026785;20285.087171077335;20344;20807.271745488986;21066.683999740017;20726.5854682907;21252.36242912715;21380.679289810665;21394.46513837151;21813.890930545247;16682.249298781582;17017.234224459928;17132.743008854875;17149.22828472709;17316.653666926715;3635.2184280379847;3657.9085522861874;3657.963420365789;3659.323025240339;3660.7254455915913;125205.37397312955;125508;127134;128035;128332;16642.83357166437;16801.747973780402;17019.659606808043;17083.658326833392;17242.051687157076;25336.619950700755;26812.195634131007;26974.730252697613;28714;31452;8897.644094236288;8960.372773905765;9079.954600226956;9101.590428430736;9110.726678199664;4310.331898555729;4428.623566996777;4432.867013989521;4440.156370289635;4448.688591798607;5274.12976858814;5348.3849357323625;5396.244525766396;5401.756920938567;5414.566834653218;947.8672985781996;1007.9546420410952;1011.5245834457793;1013.1388319928002;1016.217512515359;691.5055735149392;695.6904177641003;711.9786406407816;717.9712811487586;729.2925861913935;12262.632121036384;12321.075919306088;12630.494780208688;13309.916265740452;13501.527446539323;697.1634039153037;711.1217646207034;727.5089314712548;727.6143643868758;734.5445823589408;5897.49871260939;5968.46283834457;6043.546733994968;6049.848753781191;6225.595336303126;100416.49791750994;105180;108080;110985;113042.43478782554;96616;98239.50880245553;98338.50830745943;102187.48906255422;102873;83157;83605.16394835974;84243.57878210692;85766;88457;11249.943750281196;12538.247705137721;12964.481420743065;13578.796318055434;13617.79573306421;39715.602843972345;40148.598514014484;40394.39408408935;40929.1814163721;42014.57985420229;71182;71191.64404177947;72995.54008919898;76278;77542;18977.33579324717;19346.4196074118;19826.107825148192;20196.697049543975;20214;21381;22431.32706018822;22443.102275909434;22638.094476221424;22662.660060099442;19948.60102797965;19987;20003.199872004956;20044.198232071136;20108.59782804365;19763.308284209983;20185.192592296145;20327.695084573446;20383.286584970047;20625;17941.372051978116;18878.52803679919;19672.409827705193;20130.19479220815;20285.49286267855;14531.491397801026;14705.926470368007;14813.33339999681;14983.625409364417;15309;14163.433462661791;14666.85333146655;14865.777013345025;15043.247837608295;16153.4346297879 03:31:08 INFO - PID 7730 | __end_tp_report 03:31:08 INFO - PID 7730 | __start_cc_report 03:31:08 INFO - PID 7730 | _x_x_mozilla_cycle_collect,386 03:31:08 INFO - PID 7730 | __end_cc_report 03:31:08 INFO - PID 7730 | __startTimestamp1502879468908__endTimestamp 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | ------- Summary: start ------- 03:31:08 INFO - PID 7730 | Number of tests: 6 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | [#0] dojo.html Cycles:165 Average:6201.61 Median:6438.45 stddev:735.28 (11.4%) stddev-sans-first:696.80 03:31:08 INFO - PID 7730 | Values: 3124.8 3173.5 3206.8 3218.3 3226.8 6228.3 6288.6 6317.1 6331.9 6368.5 6085.5 6196.3 6199.9 6206.8 6234.0 5684.7 5697.7 5721.1 5727.6 5740.2 5728.2 5762.3 5763.9 5771.8 5777.4 5804.7 5816.8 5824.4 5831.5 5833.9 5730.4 5767.3 5775.6 5838.2 5846.6 5196.3 5538.4 5634.0 5645.5 5712.6 6119.4 6150.0 6164.1 6230.7 6262.4 6657.3 6669.7 6684.5 6761.5 6765.6 6759.6 6776.6 6801.0 6807.0 6809.6 6316.3 6339.5 6352.5 6355.9 6356.0 6918.1 6919.6 6937.6 7027.7 7035.9 6542.2 6556.2 6600.8 6687.0 6700.4 6626.8 6784.3 6810.1 6814.8 6814.9 6684.6 6713.6 6787.7 6805.2 6814.4 6621.3 6701.6 6715.8 6727.5 6802.7 5438.5 5442.7 5443.0 5444.0 5451.4 4667.5 4687.0 4729.2 4759.8 4774.5 5682.7 5700.7 5790.3 5841.4 5922.6 6726.2 6728.7 6754.4 6762.7 6778.5 5786.0 5852.0 5904.2 5912.8 5926.9 5877.0 5979.2 5997.4 5997.8 6036.6 6438.5 6531.0 6590.4 6598.8 6605.3 6767.2 6776.1 6810.1 6848.6 6850.6 6524.8 6529.6 6545.0 6599.9 6633.7 6497.6 6602.1 6621.6 6684.6 6704.7 6740.2 6752.3 6772.2 6804.8 6831.2 6561.4 6590.3 6618.7 6628.3 6635.8 6553.7 6557.7 6644.8 6645.8 6657.0 6313.3 6433.4 6455.4 6456.2 6555.2 6513.6 6516.7 6596.3 6641.3 6658.8 6244.8 6321.4 6322.6 6391.5 6427.9 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | [#1] ext.html Cycles:180 Average:37856.37 Median:36992.63 stddev:51853.54 (140.2%) stddev-sans-first:51924.44 03:31:08 INFO - PID 7730 | Values: 823.2 827.4 841.3 868.5 868.8 41546.0 42187.0 42193.8 42258.0 42422.4 38771.4 39208.2 39316.4 39355.2 39627.0 6739.7 6834.7 6836.3 6840.4 6843.5 6909.9 6931.2 6966.3 6974.9 6976.1 7634.8 7837.6 7856.0 7856.8 7872.8 7758.2 7795.1 7801.3 7818.8 7819.8 7401.7 7498.3 7500.4 7502.4 7656.3 38854.6 39138.0 39147.0 39168.8 39240.6 3605.2 3659.2 3659.3 3663.4 3665.6 31549.0 31601.8 31619.2 31627.7 31634.7 5071.6 5077.5 5079.1 5096.6 5102.1 192660.0 192846.0 193384.0 193783.0 193979.0 50514.7 51045.0 51077.2 51196.7 51248.5 52512.2 52625.2 52784.5 52790.2 52899.5 16606.3 16811.2 16844.2 16859.7 16910.3 13978.1 13988.1 14010.2 14018.7 14025.6 14907.9 14960.4 15015.2 15065.5 15134.8 5862.0 5914.9 5967.9 6007.4 6013.0 999.5 1015.4 1024.5 1033.7 1037.3 23160.8 23263.4 23296.7 23430.3 23434.1 1109.3 1109.8 1126.1 1129.4 1133.8 12442.4 12452.2 12466.8 16979.6 17048.5 239149.0 241723.0 242050.0 242288.0 243459.0 55449.2 55920.0 61162.4 63519.7 63839.0 1518.8 1547.7 1556.3 1560.8 1561.9 27883.6 28141.7 28203.6 28460.3 28867.0 39003.8 39177.0 39196.6 39246.0 39258.2 153343.0 153774.0 153866.0 154441.0 155430.0 36986.4 37398.6 37689.0 37750.2 38340.2 48094.3 48109.5 48368.0 48718.3 48894.0 34260.0 34561.3 34628.0 34688.1 35366.5 33801.8 34360.7 34700.5 34734.8 35521.3 36380.8 36998.8 37330.1 37407.6 37640.2 33512.0 33522.3 33702.5 33836.0 34209.7 24042.3 24262.9 24410.5 24728.8 24813.3 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | [#2] jquery.html Cycles:180 Average:35403.99 Median:12547.63 stddev:82662.83 (658.8%) stddev-sans-first:82853.36 03:31:08 INFO - PID 7730 | Values: 575.8 578.9 580.3 587.8 595.8 22660.5 23023.8 23673.8 23695.3 23703.8 26951.3 27684.7 27692.9 27789.2 27838.2 6498.6 6736.2 6738.5 6754.6 6784.6 6283.8 6558.7 6588.9 6619.3 6649.4 6551.9 6554.4 6556.2 6560.1 6563.1 6539.8 6542.0 6542.1 6542.4 6542.6 6087.1 6093.5 6098.8 6099.6 6102.0 28795.6 29768.7 30023.2 30096.4 30180.7 1921.2 1925.8 1926.3 1935.1 1936.1 20167.5 20741.3 20750.7 20756.3 20808.3 2298.4 2368.0 2423.7 2429.3 2439.5 129119.0 135200.0 135674.0 135929.6 136038.0 14268.6 15027.3 15166.5 15303.4 15452.3 22796.9 23689.8 23699.8 23792.2 23864.2 10365.2 10536.6 10558.7 10706.9 10742.2 10012.8 10061.6 10103.8 10104.8 10131.6 9464.5 9617.4 9725.6 9750.2 9800.3 2639.5 2642.6 2665.6 2770.8 2803.9 970.2 974.8 978.5 981.2 989.5 19268.4 20510.2 23960.8 25529.0 25612.6 1027.0 1029.1 1033.2 1040.1 1042.4 11251.6 11440.0 11486.6 11533.7 11567.0 474810.0 486102.0 494676.0 495607.0 501254.0 114872.0 116959.0 119243.0 119396.0 119566.0 1280.6 1298.6 1317.6 1318.5 1319.9 17832.6 17833.5 17984.5 18029.4 18403.0 57364.1 60368.4 61240.7 62271.4 62859.4 70553.6 77002.0 80144.2 80837.2 81894.0 14263.7 14740.4 14829.7 14855.0 14909.9 20885.3 21112.7 23712.9 24060.8 24089.3 18585.2 18832.3 18868.9 18924.0 19013.3 17298.2 17311.7 17363.7 17562.9 17867.3 18478.8 19387.2 19411.9 19613.0 19659.4 14751.6 14826.6 14868.1 14907.7 14910.5 18158.5 18741.3 18749.4 18763.2 18801.5 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | [#3] mootools.html Cycles:180 Average:8887.97 Median:2528.89 stddev:6197.73 (245.1%) stddev-sans-first:6189.43 03:31:08 INFO - PID 7730 | Values: 1378.5 1425.0 1430.6 1438.2 1442.3 14115.9 14363.1 14729.9 14744.1 14754.4 14859.4 15143.8 15153.5 15160.0 15162.0 2479.3 2526.3 2527.8 2527.9 2529.9 2611.6 2666.5 2687.9 2722.0 2726.3 2466.1 2481.6 2660.5 2696.1 2708.6 2542.3 2542.7 2543.7 2544.4 2547.1 2536.8 2559.6 2589.4 2591.0 2598.8 13735.7 14073.4 14092.4 14097.2 14133.2 7469.9 7744.7 7749.5 7760.1 7772.1 4704.6 4709.5 4868.7 4897.9 4898.2 1891.1 1894.4 1905.8 1962.7 1962.8 23819.8 23929.9 23967.0 24084.9 24126.2 6221.3 6433.0 6551.9 6591.2 6638.0 16115.8 16183.1 16222.1 16223.6 16236.0 6860.7 7119.6 7394.2 7453.5 7457.7 6098.5 6306.9 6880.8 6888.6 7129.7 4942.6 5125.0 5175.3 5176.0 5230.6 1426.7 1443.7 1444.9 1454.1 1475.6 864.0 871.9 881.9 884.8 896.9 7131.6 7140.4 7142.3 7152.2 7169.6 701.3 710.6 717.7 718.4 722.2 4787.3 5542.1 5677.0 5807.0 5809.8 19506.4 19511.6 20316.9 20338.0 20338.7 19797.2 19892.0 19902.5 19956.0 20075.5 10138.3 10704.6 10948.1 10951.8 10967.0 8308.4 8347.5 8419.1 8430.7 8466.2 17193.7 17214.6 17393.9 17447.5 17469.3 17800.6 17854.6 17855.7 17997.5 18237.1 11731.0 11927.7 12038.0 12109.9 12110.5 13466.3 13646.0 13656.4 13674.7 13691.2 11002.2 11049.9 11127.9 11196.6 11431.2 10485.7 10521.8 10526.0 10572.8 10741.3 9328.3 9454.7 9455.6 9462.6 9471.4 7356.2 7476.1 7477.6 7504.7 7584.5 7373.3 7433.1 7458.9 7550.8 7563.5 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | [#4] prototype.html Cycles:180 Average:5473.50 Median:6098.07 stddev:1531.40 (25.1%) stddev-sans-first:1489.02 03:31:08 INFO - PID 7730 | Values: 474.6 490.6 494.8 500.8 514.1 6169.6 6170.6 6180.5 6275.8 6300.2 6083.0 6095.8 6097.4 6116.2 6123.4 4824.4 4965.7 4995.3 5036.5 5038.2 4927.3 4950.3 4959.6 4973.8 5020.8 4873.3 4910.2 4933.0 4954.0 5001.5 4863.0 4912.1 4912.3 4923.6 4963.2 4490.7 4492.8 4495.2 4500.0 4508.8 6003.8 6012.3 6098.8 6118.8 6165.4 5628.7 5646.3 5660.2 5684.3 5704.8 6420.7 6442.7 6450.2 6561.3 6567.1 4843.2 4853.3 4878.7 4897.0 4903.4 6574.4 6627.0 6695.9 6787.9 6867.7 4942.0 4951.8 4959.8 4963.5 5004.9 5010.6 5020.0 5021.5 5058.4 5069.2 5579.7 5584.5 5615.0 5628.5 5670.4 6526.8 6561.0 6588.5 6591.2 6592.4 1750.1 1765.1 1770.8 1771.4 1787.6 1164.1 1212.1 1227.8 1231.7 1238.9 5714.2 5725.6 5726.0 5760.0 5792.9 6551.5 6625.7 6698.7 6728.2 6777.3 5631.6 5638.8 5657.2 5727.7 5742.7 3505.3 3514.0 3553.3 3557.2 3564.5 6444.1 6463.6 6480.5 6529.1 6546.4 6845.8 6877.7 6914.8 6925.8 6998.4 6413.2 6534.0 6544.4 6545.0 6556.5 6574.6 6597.6 6606.5 6654.4 6734.0 6003.9 6608.1 6644.4 6687.5 6698.4 6383.8 6387.3 6460.9 6471.6 6532.2 4939.6 4940.5 4992.6 4998.5 5029.5 6508.3 6514.0 6684.0 6738.9 6758.4 6390.7 6407.3 6409.6 6498.8 6501.3 6372.2 6456.7 6469.7 6488.4 6518.5 6273.9 6276.7 6416.7 6421.6 6435.4 6465.5 6530.4 6539.5 6598.3 6599.0 6324.8 6338.7 6341.4 6359.9 6367.4 03:31:08 INFO - PID 7730 | 03:31:08 INFO - PID 7730 | [#5] yui.html Cycles:180 Average:24339.28 Median:21387.73 stddev:32110.86 (150.1%) stddev-sans-first:32152.71 03:31:08 INFO - PID 7730 | Values: 903.4 907.3 924.8 925.4 928.2 21548.9 23429.2 23493.9 23571.4 23595.5 20778.8 21925.6 21943.0 21994.0 22005.4 973.5 989.4 989.5 989.7 990.5 1014.3 1059.5 1059.6 1059.9 1060.2 1115.0 1121.0 1121.1 1121.3 1121.5 1111.9 1114.0 1114.6 1116.1 1116.5 811.6 814.0 815.1 815.3 817.6 20266.8 20285.1 20344.0 20807.3 21066.7 20726.6 21252.4 21380.7 21394.5 21813.9 16682.2 17017.2 17132.7 17149.2 17316.7 3635.2 3657.9 3658.0 3659.3 3660.7 125205.4 125508.0 127134.0 128035.0 128332.0 16642.8 16801.7 17019.7 17083.7 17242.1 25336.6 26812.2 26974.7 28714.0 31452.0 8897.6 8960.4 9080.0 9101.6 9110.7 4310.3 4428.6 4432.9 4440.2 4448.7 5274.1 5348.4 5396.2 5401.8 5414.6 947.9 1008.0 1011.5 1013.1 1016.2 691.5 695.7 712.0 718.0 729.3 12262.6 12321.1 12630.5 13309.9 13501.5 697.2 711.1 727.5 727.6 734.5 5897.5 5968.5 6043.5 6049.8 6225.6 100416.5 105180.0 108080.0 110985.0 113042.4 96616.0 98239.5 98338.5 102187.5 102873.0 83157.0 83605.2 84243.6 85766.0 88457.0 11249.9 12538.2 12964.5 13578.8 13617.8 39715.6 40148.6 40394.4 40929.2 42014.6 71182.0 71191.6 72995.5 76278.0 77542.0 18977.3 19346.4 19826.1 20196.7 20214.0 21381.0 22431.3 22443.1 22638.1 22662.7 19948.6 19987.0 20003.2 20044.2 20108.6 19763.3 20185.2 20327.7 20383.3 20625.0 17941.4 18878.5 19672.4 20130.2 20285.5 14531.5 14705.9 14813.3 14983.6 15309.0 14163.4 14666.9 14865.8 15043.2 16153.4 03:31:08 INFO - PID 7730 | -------- Summary: end -------- 03:31:08 INFO - PID 7730 | 03:31:09 INFO - TEST-INFO | 7730: exit 0 03:31:09 INFO - TEST-OK | dromaeo_css | took 1111771ms 03:31:09 INFO - TEST-START | kraken 03:31:09 INFO - Initialising browser for kraken test... 03:31:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49472/getInfo.html -profile /tmp/tmpLVBxLb/profile 03:31:09 INFO - TEST-INFO | started process 8105 (/builds/slave/test/build/application/firefox/firefox http://localhost:49472/getInfo.html) 03:31:15 INFO - TEST-INFO | 8105: exit 0 03:31:15 INFO - Browser initialized. 03:31:15 INFO - Running cycle 1/1 for kraken test... 03:31:15 INFO - TEST-INFO | started process 8336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLVBxLb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:16 INFO - PID 8336 | 03:31:16 INFO - PID 8336 | (/builds/slave/test/build/application/firefox/firefox:8390): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:31:16 INFO - PID 8336 | 03:31:26 INFO - PID 8336 | RSS: Main: 167555072 03:31:26 INFO - PID 8336 | 03:31:29 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:30 INFO - PID 8336 | RSS: Main: 173854720 03:31:30 INFO - PID 8336 | 03:31:32 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-dft) 03:31:33 INFO - PID 8336 | RSS: Main: 177795072 03:31:33 INFO - PID 8336 | 03:31:36 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-fft) 03:31:37 INFO - PID 8336 | RSS: Main: 171421696 03:31:37 INFO - PID 8336 | 03:31:39 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49472/tests/kraken/driver.html?testName=audio-oscillator) 03:31:40 INFO - PID 8336 | RSS: Main: 171962368 03:31:40 INFO - PID 8336 | 03:31:42 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:42 INFO - PID 8336 | RSS: Main: 172642304 03:31:42 INFO - PID 8336 | 03:31:45 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:46 INFO - PID 8336 | RSS: Main: 173527040 03:31:46 INFO - PID 8336 | 03:31:50 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49472/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:50 INFO - PID 8336 | RSS: Main: 173125632 03:31:50 INFO - PID 8336 | 03:31:53 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49472/tests/kraken/driver.html?testName=json-parse-financial) 03:31:54 INFO - PID 8336 | RSS: Main: 173895680 03:31:54 INFO - PID 8336 | 03:31:55 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:56 INFO - PID 8336 | RSS: Main: 173928448 03:31:56 INFO - PID 8336 | 03:31:58 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:59 INFO - PID 8336 | RSS: Main: 173989888 03:31:59 INFO - PID 8336 | 03:32:01 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:32:01 INFO - PID 8336 | RSS: Main: 173580288 03:32:01 INFO - PID 8336 | 03:32:04 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:32:05 INFO - PID 8336 | RSS: Main: 174161920 03:32:05 INFO - PID 8336 | 03:32:08 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:32:09 INFO - PID 8336 | RSS: Main: 173912064 03:32:09 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | Cycle 1(1): loaded http://localhost:49472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49472/tests/kraken/driver.html?testName=ai-astar) 03:32:11 INFO - PID 8336 | RSS: Main: 175468544 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | __start_tp_report 03:32:11 INFO - PID 8336 | _x_x_mozilla_page_load 03:32:11 INFO - PID 8336 | _x_x_mozilla_page_load_details 03:32:11 INFO - PID 8336 | |i|pagename|runs| 03:32:11 INFO - PID 8336 | |0;ai-astar;108;114;96;107;109;112;111;107;109;109 03:32:11 INFO - PID 8336 | |1;audio-beat-detection;147;121;147;170;119;147;147;121;170;120 03:32:11 INFO - PID 8336 | |2;audio-dft;167;163;161;161;173;169;165;165;163;164 03:32:11 INFO - PID 8336 | |3;audio-fft;76;75;74;172;78;75;76;79;163;77 03:32:11 INFO - PID 8336 | |4;audio-oscillator;79;78;129;79;82;78;133;82;78;124 03:32:11 INFO - PID 8336 | |5;imaging-gaussian-blur;113;119;116;116;117;117;114;114;119;114 03:32:11 INFO - PID 8336 | |6;imaging-darkroom;151;149;150;149;149;149;150;156;149;155 03:32:11 INFO - PID 8336 | |7;imaging-desaturate;97;94;94;95;94;94;94;96;94;94 03:32:11 INFO - PID 8336 | |8;json-parse-financial;54;57;54;63;55;54;55;55;54;57 03:32:11 INFO - PID 8336 | |9;json-stringify-tinderbox;54;55;54;53;57;53;54;54;59;58 03:32:11 INFO - PID 8336 | |10;stanford-crypto-aes;83;77;77;82;78;78;77;84;78;79 03:32:11 INFO - PID 8336 | |11;stanford-crypto-ccm;129;127;137;133;129;140;126;137;128;157 03:32:11 INFO - PID 8336 | |12;stanford-crypto-pbkdf2;175;179;179;180;171;170;185;180;188;172 03:32:11 INFO - PID 8336 | |13;stanford-crypto-sha256-iterative;78;69;71;68;68;69;77;73;73;71 03:32:11 INFO - PID 8336 | __end_tp_report 03:32:11 INFO - PID 8336 | __start_cc_report 03:32:11 INFO - PID 8336 | _x_x_mozilla_cycle_collect,937 03:32:11 INFO - PID 8336 | __end_cc_report 03:32:11 INFO - PID 8336 | __startTimestamp1502879531270__endTimestamp 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | ------- Summary: start ------- 03:32:11 INFO - PID 8336 | Number of tests: 14 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:4.83 (4.4%) stddev-sans-first:5.12 03:32:11 INFO - PID 8336 | Values: 108.0 114.0 96.0 107.0 109.0 112.0 111.0 107.0 109.0 109.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.00 stddev:19.86 (13.5%) stddev-sans-first:20.95 03:32:11 INFO - PID 8336 | Values: 147.0 121.0 147.0 170.0 119.0 147.0 147.0 121.0 170.0 120.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.73 (2.3%) stddev-sans-first:3.89 03:32:11 INFO - PID 8336 | Values: 167.0 163.0 161.0 161.0 173.0 169.0 165.0 165.0 163.0 164.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:38.56 (50.7%) stddev-sans-first:40.31 03:32:11 INFO - PID 8336 | Values: 76.0 75.0 74.0 172.0 78.0 75.0 76.0 79.0 163.0 77.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.50 stddev:23.92 (30.5%) stddev-sans-first:24.74 03:32:11 INFO - PID 8336 | Values: 79.0 78.0 129.0 79.0 82.0 78.0 133.0 82.0 78.0 124.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.50 stddev:2.13 (1.8%) stddev-sans-first:1.99 03:32:11 INFO - PID 8336 | Values: 113.0 119.0 116.0 116.0 117.0 117.0 114.0 114.0 119.0 114.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.00 stddev:2.63 (1.8%) stddev-sans-first:2.78 03:32:11 INFO - PID 8336 | Values: 151.0 149.0 150.0 149.0 149.0 149.0 150.0 156.0 149.0 155.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.07 (1.1%) stddev-sans-first:0.71 03:32:11 INFO - PID 8336 | Values: 97.0 94.0 94.0 95.0 94.0 94.0 94.0 96.0 94.0 94.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:2.78 (5.1%) stddev-sans-first:2.87 03:32:11 INFO - PID 8336 | Values: 54.0 57.0 54.0 63.0 55.0 54.0 55.0 55.0 54.0 57.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:54.50 stddev:2.13 (3.9%) stddev-sans-first:2.22 03:32:11 INFO - PID 8336 | Values: 54.0 55.0 54.0 53.0 57.0 53.0 54.0 54.0 59.0 58.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.67 (3.4%) stddev-sans-first:2.47 03:32:11 INFO - PID 8336 | Values: 83.0 77.0 77.0 82.0 78.0 78.0 77.0 84.0 78.0 79.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:135.00 stddev:9.32 (6.9%) stddev-sans-first:9.69 03:32:11 INFO - PID 8336 | Values: 129.0 127.0 137.0 133.0 129.0 140.0 126.0 137.0 128.0 157.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:179.50 stddev:5.93 (3.3%) stddev-sans-first:6.20 03:32:11 INFO - PID 8336 | Values: 175.0 179.0 179.0 180.0 171.0 170.0 185.0 180.0 188.0 172.0 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:3.56 (4.9%) stddev-sans-first:2.96 03:32:11 INFO - PID 8336 | Values: 78.0 69.0 71.0 68.0 68.0 69.0 77.0 73.0 73.0 71.0 03:32:11 INFO - PID 8336 | -------- Summary: end -------- 03:32:11 INFO - PID 8336 | 03:32:11 INFO - PID 8336 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:32:11 INFO - TEST-INFO | 8336: exit 0 03:32:11 INFO - TEST-OK | kraken | took 62288ms 03:32:11 INFO - SUITE-END | took 1174s 03:32:12 INFO - Completed test suite (00:19:34) 03:32:12 INFO - javascript benchmark 03:32:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8608.20194662296, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.828134452606, 3173.4605117130086, 3206.807591544507, 3218.291975765331, 3226.822524761137, 6228.346023667517, 6288.559800813945, 6317.14718513, 6331.905021424676, 6368.458681012119, 6085.4827339676185, 6196.287426945903, 6199.876002479948, 6206.7827626033095, 6233.968830155854, 5684.744186511596, 5697.715114244292, 5721.056025755745, 5727.627704199234, 5740.225069615611, 5728.198052272664, 5762.250907382035, 5763.913541296863, 5771.769129234846, 5777.393373695764, 5804.651720896739, 5816.82549523515, 5824.388439213885, 5831.533477321804, 5833.8833223335505, 5730.36965933747, 5767.250257466502, 5775.624584402, 5838.241028666246, 5846.649201047908, 5196.324477817897, 5538.363088244863, 5633.985882541141, 5645.520130788888, 5712.571557133231, 6119.449249567516, 6150.0, 6164.137020817045, 6230.719617617218, 6262.436380725757, 6657.334266573353, 6669.666516674147, 6684.465242780614, 6761.526693131483, 6765.627890466022, 6759.5606285591275, 6776.593404395703, 6801.047853300542, 6807.0, 6809.557378770364, 6316.273628532732, 6339.492840572835, 6352.4918006559365, 6355.87288254237, 6356.0, 6918.100646915969, 6919.619420931897, 6937.618430986344, 7027.6837542309695, 7035.929640703527, 6542.182227221598, 6556.18047744032, 6600.834979125464, 6687.0, 6700.396964273142, 6626.768063117865, 6784.253732089466, 6810.080639113756, 6814.795556133324, 6814.863702725917, 6684.598924064571, 6713.597184168965, 6787.694553745093, 6805.217399999064, 6814.352636499525, 6621.337866213436, 6701.6314102723845, 6715.764948226789, 6727.529072964846, 6802.693878775368, 5438.510534051875, 5442.727863606804, 5443.020256353894, 5443.972780136074, 5451.400345961941, 4667.463241727177, 4687.0, 4729.196036673774, 4759.785809638574, 4774.522547745198, 5682.659040457585, 5700.714964251771, 5790.276215473066, 5841.4450627190345, 5922.585419020714, 6726.192856857208, 6728.7308507659145, 6754.358335958076, 6762.69567869447, 6778.525503214728, 5785.971070144622, 5851.970740146272, 5904.202932604129, 5912.76348946046, 5926.940730592639, 5877.0, 5979.1629171915965, 5997.370276121032, 5997.790077347359, 6036.577439579275, 6438.45273151778, 6530.987696906987, 6590.439812615981, 6598.835029124214, 6605.273419923805, 6767.1879374475375, 6776.08522849409, 6810.148731408574, 6848.623325717133, 6850.623215723183, 6524.771632992823, 6529.640869752209, 6544.9672751635935, 6599.934000659932, 6633.701483433354, 6497.577657452251, 6602.141721576164, 6621.602703837785, 6684.598924064571, 6704.731810727516, 6740.157480314961, 6752.257251702407, 6772.221194562689, 6804.82987925286, 6831.214410342675, 6561.376669216417, 6590.275069742229, 6618.6690665467495, 6628.270890201978, 6635.834104147435, 6553.705083271169, 6557.672116394066, 6644.767433139817, 6645.800625981228, 6656.966715166393, 6313.273973493107, 6433.388828061326, 6455.386738259858, 6456.192975878015, 6555.2133743949125, 6513.576617519846, 6516.73933042692, 6596.3073877244115, 6641.33586641332, 6658.766943156967, 6244.781432649836, 6321.367863213642, 6322.620642761449, 6391.488680905423, 6427.903581446189], "value": 6146.514005224882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.1932705948175, 827.3877330775224, 841.3101256969285, 868.5092922498784, 868.8479516084684, 41546.0, 42186.99999999996, 42193.7890310548, 42258.0, 42422.36366454502, 38771.41842872359, 39208.21583568334, 39316.410253846145, 39355.212895742065, 39627.0, 6739.663016849163, 6834.658267086651, 6836.316368363149, 6840.384365407112, 6843.520953533254, 6909.861802763941, 6931.202911665173, 6966.268541803113, 6974.930250697505, 6976.127984002, 7634.770956871275, 7837.608119593998, 7855.960720196391, 7856.7642970710685, 7872.803179920491, 7758.224177582253, 7795.1035630902325, 7801.336886364666, 7818.765437036898, 7819.804504887366, 7401.70393184272, 7498.325150736406, 7500.399968002546, 7502.437317201177, 7656.272654097852, 38854.61145388538, 39138.0, 39147.0, 39168.80415597932, 39240.60759392398, 3605.2068544920076, 3659.176685245825, 3659.2864391443677, 3663.4138537834087, 3665.6334366563397, 31549.0, 31601.84199079013, 31619.20951976196, 31627.683723162703, 31634.683653163404, 5071.644984851062, 5077.517635824591, 5079.1365467870555, 5096.566791822699, 5102.132637451605, 192660.0, 192846.0, 193383.9999999986, 193783.0, 193979.0, 50514.747426262635, 51045.0, 51077.23384149241, 51196.74401628043, 51248.48751512512, 52512.212316815276, 52625.210621840706, 52784.47215527796, 52790.20814687783, 52899.47100529022, 16606.25271862769, 16811.243494042796, 16844.24200910962, 16859.747103793452, 16910.32358705638, 13978.091424057404, 13988.090774099652, 14010.229437381042, 14018.719625607431, 14025.579232623038, 14907.850921490646, 14960.40158393652, 15015.249237538079, 15065.548033559011, 15134.848651513345, 5861.970690146607, 5914.852128696817, 5967.940320596738, 6007.36922623127, 6013.0, 999.4513989327331, 1015.4161357219629, 1024.4775164665925, 1033.7467320506373, 1037.3309215556076, 23160.841957902376, 23263.41841453977, 23296.65055024176, 23430.297091087294, 23434.06263749431, 1109.3066833229232, 1109.8470358539298, 1126.110372805491, 1129.3619105205532, 1133.8015847226702, 12442.440090195963, 12452.190607610477, 12466.75066498665, 16979.575510612085, 17048.48854534366, 239149.0, 241723.0, 242050.0, 242288.0, 243459.0, 55449.168262476094, 55920.0, 61162.38837611567, 63519.68240158862, 63839.0, 1518.8025556677783, 1547.674988252457, 1556.2996651506867, 1560.8127024756875, 1561.851624095709, 27883.581746274227, 28141.718582813908, 28203.576946345413, 28460.288492787848, 28867.0, 39003.80498097491, 39177.0, 39196.60803391929, 39246.0, 39258.2148357037, 153343.0, 153774.0, 153866.0, 154441.0, 155430.0, 36986.44520332143, 37398.626013740606, 37689.0, 37750.2449950994, 38340.23319533649, 48094.27858582194, 48109.5189048105, 48368.0, 48718.26922596093, 48894.0, 34260.0, 34561.30877382388, 34628.0, 34688.132796680286, 35366.46950295799, 33801.83099084489, 34360.65639343575, 34700.47949280712, 34734.826325868205, 35521.28957420889, 36380.81809591041, 36998.8150059248, 37330.06674833151, 37407.625923740416, 37640.247195056494, 33512.0, 33522.32955340928, 33702.49446258357, 33836.0, 34209.657903420644, 24042.278731638078, 24262.90816913208, 24410.51178976446, 24728.752712472644, 24813.25560233196], "value": 17642.994155574415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8272518244526, 578.861073342398, 580.3065336922374, 587.764894042383, 595.8004068637007, 22660.54678906423, 23023.76976230237, 23673.76326236737, 23695.289141325746, 23703.762962370372, 26951.32621684454, 27684.723152768467, 27692.861535692344, 27789.166325010232, 27838.16485505433, 6498.577592456499, 6736.157980252468, 6738.494612904027, 6754.5947243165565, 6784.575239199774, 6283.842903927415, 6558.704858281365, 6588.901166482483, 6619.30497297784, 6649.368310010541, 6551.93448065518, 6554.41010309072, 6556.246031706343, 6560.147180866481, 6563.113979612763, 6539.836504087389, 6541.967290163542, 6542.084108224853, 6542.4438922691625, 6542.574732642387, 6087.05650624154, 6093.542984276197, 6098.847528811771, 6099.603525770811, 6101.969490152565, 28795.56806647902, 29768.70231297681, 30023.249418764706, 30096.398072038657, 30180.698193018226, 1921.193098898466, 1925.8266755991888, 1926.2776458827939, 1935.0808366026165, 1936.1287420660758, 20167.495812604655, 20741.27405540799, 20750.688739668916, 20756.273530426362, 20808.27171049021, 2298.3794375518514, 2367.9881600592057, 2423.672804171432, 2429.3440770991733, 2439.5486834935596, 129119.0, 135200.0, 135674.0, 135929.64070359268, 136038.0, 14268.643283917778, 15027.323770430357, 15166.469173578871, 15303.38786448552, 15452.304646290719, 22796.886015569817, 23689.763102368757, 23699.763002370102, 23792.167274145322, 23864.164754233865, 10365.170786337076, 10536.63121790749, 10558.736031599117, 10706.89293107059, 10742.194335424874, 10012.847237843898, 10061.597536098621, 10103.797924041479, 10104.797904041878, 10131.645392411378, 9464.479453630116, 9617.374870633526, 9725.610975560898, 9750.171235444925, 9800.26498012652, 2639.5248855206246, 2642.5903984882375, 2665.60015997598, 2770.8476033818333, 2803.90186343477, 970.2335155227291, 974.7660561465198, 978.5449765858909, 981.2101258486987, 989.5200827598609, 19268.4219473416, 20510.17959281612, 23960.821667772103, 25529.0, 25612.615810762854, 1026.984595231072, 1029.120102312512, 1033.1631378583372, 1040.1314902056868, 1042.3693665332517, 11251.606193783178, 11440.027597654293, 11486.597969071043, 11533.711657208469, 11567.0, 474810.0, 486102.0, 494676.0, 495607.0, 501254.0, 114872.0, 116959.0, 119243.0, 119396.0, 119566.0, 1280.5966120671958, 1298.5519995601503, 1317.637649646355, 1318.5451019398292, 1319.9406026729012, 17832.55418614545, 17833.46499605014, 17984.460466186036, 18029.368972085915, 18403.0, 57364.13953790613, 60368.39631603804, 61240.69379653251, 62271.37728622837, 62859.371406285354, 70553.64723176352, 77002.0, 80144.19855801367, 80837.19162808296, 81894.0, 14263.714725705635, 14740.410383584966, 14829.703405932038, 14855.0, 14909.925450373112, 20885.26901558438, 21112.68330975006, 23712.881435592713, 24060.75939240655, 24089.277321680376, 18585.16366763472, 18832.34086806955, 18868.905655471634, 18924.0, 19013.33453329127, 17298.221580028676, 17311.65376692434, 17363.7395439066, 17562.912185438992, 17867.28530858803, 18478.815211848247, 19387.2245110194, 19411.902940485208, 19613.0, 19659.41021769349, 14751.631209219855, 14826.555203343916, 14868.107913525224, 14907.701845963236, 14910.478133265284, 18158.5460363492, 18741.250349985847, 18749.437516874517, 18763.249470021045, 18801.52996175052], "value": 12287.824653585534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.5381897064485, 1424.9786253206203, 1430.628036710455, 1438.1586771738532, 1442.2860683961435, 14115.929420352897, 14363.066400683974, 14729.926350368247, 14744.115353078823, 14754.40982360707, 14859.405623775036, 15143.77284340733, 15153.54539363818, 15160.0, 15162.0, 2479.342974111857, 2526.2926380613367, 2527.848329100251, 2527.9241622751256, 2529.8608576528377, 2611.569091099966, 2666.546687063204, 2687.905923292675, 2721.972780272192, 2726.3184203949013, 2466.087547607388, 2481.6153496208117, 2660.507806055886, 2696.12375977808, 2708.5801700736415, 2542.313575334649, 2542.707588627313, 2543.6566063581363, 2544.389346556822, 2547.083050101962, 2536.7970562354967, 2559.590465525526, 2589.4432696970052, 2590.974090259092, 2598.8050896182863, 13735.656608584766, 14073.366698498592, 14092.436302547885, 14097.154170749685, 14133.152010879277, 7469.887951680729, 7744.690212391498, 7749.457537972344, 7760.06879174497, 7772.145064042951, 4704.623630109583, 4709.505501922283, 4868.707877527324, 4897.853064408074, 4898.2162853943555, 1891.0544727636182, 1894.4316704988448, 1905.8380037696813, 1962.6663467210608, 1962.764468263803, 23819.761802381927, 23929.88035059831, 23967.041318347245, 24084.879575602186, 24126.155584554457, 6221.3156552779155, 6433.0, 6551.901721474182, 6591.242007169141, 6638.0, 16115.758263626056, 16183.10992895402, 16222.107784071753, 16223.594410139842, 16236.0, 6860.6912688929115, 7119.608421536762, 7394.223606521346, 7453.515521491086, 7457.664405101675, 6098.512119030467, 6306.873862522724, 6880.759173428906, 6888.552244104218, 7129.679164437613, 4942.57988071018, 5125.0, 5175.327207463006, 5175.974120129451, 5230.63385563007, 1426.7268886569252, 1443.6679563700409, 1444.8988570800154, 1454.1420561868338, 1475.6089636246404, 863.9784005399915, 871.8692196170625, 881.8765372847806, 884.7743825324501, 896.9416987895896, 7131.643417829087, 7140.428765698732, 7142.250063743336, 7152.249013853574, 7169.641517924083, 701.2846896165984, 710.591409939287, 717.7057406463325, 718.4324383736894, 722.2091809468624, 4787.257975013878, 5542.11326187808, 5677.0, 5806.970965145148, 5809.767609295665, 19506.414807555797, 19511.609767804566, 20316.89841550783, 20338.0, 20338.694919576217, 19797.20811167566, 19892.0, 19902.50243743918, 19956.002199889946, 20075.498112547302, 10138.341007834468, 10704.625338113128, 10948.069414099891, 10951.780964380827, 10967.0, 8308.418410711192, 8347.540885251126, 8419.11599282091, 8430.747077587683, 8466.153384661484, 17193.742093868852, 17214.569635759206, 17393.913030434767, 17447.47657570275, 17469.301227951248, 17800.643987120446, 17854.5536361592, 17855.73216401729, 17997.460076197734, 18237.088145592403, 11731.0, 11927.701807454883, 12038.0, 12109.878901210875, 12110.515579376726, 13466.259355735529, 13646.044776865921, 13656.385462654005, 13674.658133546343, 13691.178529288274, 11002.229843910849, 11049.944750276198, 11127.88872111301, 11196.608118715805, 11431.199816012799, 10485.737856553647, 10521.78956420852, 10526.0, 10572.84140737874, 10741.301815381976, 9328.253739700673, 9454.669086581936, 9455.574499147417, 9462.621495140118, 9471.384360016576, 7356.154042284991, 7476.140243872024, 7477.626118693935, 7504.662290197063, 7584.469087163846, 7373.29953654402, 7433.108027036574, 7458.888116678146, 7550.7734767957045, 7563.508371955805], "value": 6376.490700466435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.63453141081345, 490.5781028315648, 494.7600413799309, 500.8472415913146, 514.0900605927509, 6169.5989760665525, 6170.598911070777, 6180.536459765524, 6275.811725648232, 6300.180976473052, 6083.0, 6095.786647467339, 6097.390260973901, 6116.235470566179, 6123.3876612338745, 4824.372831531896, 4965.7020578765205, 4995.275685025669, 5036.546710796028, 5038.21907604321, 4927.310176575283, 4950.316892256632, 4959.553640172384, 4973.751312434364, 5020.799168033274, 4873.34209881665, 4910.2143657014885, 4933.0, 4954.0, 5001.499850015006, 4863.027394521092, 4912.140375434303, 4912.280701754393, 4923.645997350722, 4963.230699241623, 4490.708103973231, 4492.820287188509, 4495.190865644183, 4499.977500112511, 4508.752018638974, 6003.849903752397, 6012.278526576795, 6098.756049758049, 6118.847028824271, 6165.383461653843, 5628.662280263197, 5646.26598542191, 5660.179274005287, 5684.261046064026, 5704.828855134311, 6420.715856828653, 6442.710078046499, 6450.161479007746, 6561.3438656134485, 6567.0627164986445, 4843.200871856139, 4853.296272040569, 4878.682885612424, 4897.0, 4903.387076615423, 6574.389274627747, 6626.966865165643, 6695.899561506581, 6787.864242715167, 6867.725290988355, 4942.0, 4951.777170027357, 4959.817680220692, 4963.478834722302, 5004.874878128003, 5010.64925455222, 5019.974900125476, 5021.472745361758, 5058.418281897555, 5069.200433845932, 5579.660881388438, 5584.46947539983, 5614.9719251403485, 5628.452175651647, 5670.404607516234, 6526.759915616018, 6561.0, 6588.4729221662155, 6591.242007169141, 6592.43964263043, 1750.0812073661175, 1765.1350838089245, 1770.8406243438153, 1771.4419957713278, 1787.5709829641053, 1164.1152723929874, 1212.121212121205, 1227.766724322376, 1231.741334319803, 1238.8823061809114, 5714.200011998323, 5725.599208055396, 5725.969325521362, 5760.0, 5792.899349123737, 6551.508636852255, 6625.668716564152, 6698.665066746643, 6728.192616885907, 6777.2545020047755, 5631.63394379364, 5638.774449021993, 5657.179708942181, 5727.7089164333765, 5742.741576628978, 3505.298940211968, 3513.9648603514147, 3553.271579326232, 3557.1640664443835, 3564.4831499432958, 6444.130042444303, 6463.612183269019, 6480.51396145291, 6529.094552923903, 6546.410823025951, 6845.794626161223, 6877.65611719412, 6914.827129321807, 6925.757598484029, 6998.440124790106, 6413.16628838248, 6534.0, 6544.411003009752, 6544.9672751635935, 6556.541042127005, 6574.572652777554, 6597.6041437511985, 6606.465540935576, 6654.367835055662, 6734.0, 6003.949308871018, 6608.127547350701, 6644.4020038196795, 6687.531872768859, 6698.430633396216, 6383.808485745435, 6387.297397286387, 6460.870782584416, 6471.611703297817, 6532.216134063943, 4939.629527785502, 4940.456549779593, 4992.600591952708, 4998.500149984972, 5029.4719054498755, 6508.316626754123, 6514.0, 6683.966580167068, 6738.898916516158, 6758.391744742997, 6390.680465976776, 6407.295197528175, 6409.647469389229, 6498.837529061811, 6501.284858665637, 6372.235331760218, 6456.709448074942, 6469.729978214356, 6488.416042556192, 6518.511111666549, 6273.874522509615, 6276.748930042747, 6416.743330266737, 6421.646809425526, 6435.388638079375, 6465.515086368635, 6530.412262896362, 6539.476841852736, 6598.274189839018, 6599.0, 6324.810255692337, 6338.746450141943, 6341.4292713656, 6359.872802544016, 6367.42693157618], "value": 5020.358769375889, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.3586153830784, 907.3376435202302, 924.7688077980507, 925.3661242049201, 928.2156577691852, 21548.89225553872, 23429.179978700726, 23493.882530587343, 23571.41071473214, 23595.5280894382, 20778.792212077875, 21925.561488770214, 21943.0, 21994.0, 22005.449863753413, 973.4743238651138, 989.351974456732, 989.4607438945756, 989.6585677941099, 990.529498488216, 1014.2595904989362, 1059.464970190053, 1059.6026490066224, 1059.8622179116703, 1060.1571750458365, 1114.9777004459906, 1121.024708503603, 1121.1031175059961, 1121.344013751956, 1121.5401685309025, 1111.8554587903561, 1113.9944300278487, 1114.637742733615, 1116.101538261699, 1116.4585176189541, 811.6469335838929, 814.0475643497123, 815.135955886756, 815.3314282288526, 817.6157206113118, 20266.797332026785, 20285.087171077335, 20344.0, 20807.271745488986, 21066.683999740017, 20726.5854682907, 21252.36242912715, 21380.679289810665, 21394.46513837151, 21813.890930545247, 16682.249298781582, 17017.234224459928, 17132.743008854875, 17149.22828472709, 17316.653666926715, 3635.2184280379847, 3657.9085522861874, 3657.963420365789, 3659.323025240339, 3660.7254455915913, 125205.37397312955, 125508.0, 127134.0, 128035.0, 128332.0, 16642.83357166437, 16801.747973780402, 17019.659606808043, 17083.658326833392, 17242.051687157076, 25336.619950700755, 26812.195634131007, 26974.730252697613, 28714.0, 31452.0, 8897.644094236288, 8960.372773905765, 9079.954600226956, 9101.590428430736, 9110.726678199664, 4310.331898555729, 4428.623566996777, 4432.867013989521, 4440.156370289635, 4448.688591798607, 5274.12976858814, 5348.3849357323625, 5396.244525766396, 5401.756920938567, 5414.566834653218, 947.8672985781996, 1007.9546420410952, 1011.5245834457793, 1013.1388319928002, 1016.217512515359, 691.5055735149392, 695.6904177641003, 711.9786406407816, 717.9712811487586, 729.2925861913935, 12262.632121036384, 12321.075919306088, 12630.494780208688, 13309.916265740452, 13501.527446539323, 697.1634039153037, 711.1217646207034, 727.5089314712548, 727.6143643868758, 734.5445823589408, 5897.49871260939, 5968.46283834457, 6043.546733994968, 6049.848753781191, 6225.595336303126, 100416.49791750994, 105180.0, 108080.0, 110985.0, 113042.43478782554, 96616.0, 98239.50880245553, 98338.50830745943, 102187.48906255422, 102873.0, 83157.0, 83605.16394835974, 84243.57878210692, 85766.0, 88457.0, 11249.943750281196, 12538.247705137721, 12964.481420743065, 13578.796318055434, 13617.79573306421, 39715.602843972345, 40148.598514014484, 40394.39408408935, 40929.1814163721, 42014.57985420229, 71182.0, 71191.64404177947, 72995.54008919898, 76278.0, 77542.0, 18977.33579324717, 19346.4196074118, 19826.107825148192, 20196.697049543975, 20214.0, 21381.0, 22431.32706018822, 22443.102275909434, 22638.094476221424, 22662.660060099442, 19948.60102797965, 19987.0, 20003.199872004956, 20044.198232071136, 20108.59782804365, 19763.308284209983, 20185.192592296145, 20327.695084573446, 20383.286584970047, 20625.0, 17941.372051978116, 18878.52803679919, 19672.409827705193, 20130.19479220815, 20285.49286267855, 14531.491397801026, 14705.926470368007, 14813.33339999681, 14983.625409364417, 15309.0, 14163.433462661791, 14666.85333146655, 14865.777013345025, 15043.247837608295, 16153.4346297879], "value": 9537.926567907529, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 96.0, 107.0, 109.0, 112.0, 111.0, 107.0, 109.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 147.0, 170.0, 119.0, 147.0, 147.0, 121.0, 170.0, 120.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 161.0, 161.0, 173.0, 169.0, 165.0, 165.0, 163.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 172.0, 78.0, 75.0, 76.0, 79.0, 163.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 129.0, 79.0, 82.0, 78.0, 133.0, 82.0, 78.0, 124.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 116.0, 116.0, 117.0, 117.0, 114.0, 114.0, 119.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 149.0, 149.0, 149.0, 150.0, 156.0, 149.0, 155.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 63.0, 55.0, 54.0, 55.0, 55.0, 54.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 57.0, 53.0, 54.0, 54.0, 59.0, 58.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 77.0, 82.0, 78.0, 78.0, 77.0, 84.0, 78.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 137.0, 133.0, 129.0, 140.0, 126.0, 137.0, 128.0, 157.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 179.0, 180.0, 171.0, 170.0, 185.0, 180.0, 188.0, 172.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 69.0, 71.0, 68.0, 68.0, 69.0, 77.0, 73.0, 73.0, 71.0], "value": 71.7, "unit": "score"}]}]} 03:32:12 INFO - Return code: 0 03:32:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:32:12 INFO - # TBPL SUCCESS # 03:32:12 INFO - Running post-action listener: _package_coverage_data 03:32:12 INFO - Running post-action listener: _resource_record_post_action 03:32:12 INFO - [mozharness: 2017-08-16 10:32:12.562538Z] Finished run-tests step (success) 03:32:12 INFO - Running post-run listener: _resource_record_post_run 03:32:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433164288; Read time: 20; Write time: 287008 03:32:12 INFO - TinderboxPrint: CPU usage
13.1% 03:32:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:32:12 INFO - TinderboxPrint: I/O write bytes / time
433,164,288 / 287,008 03:32:12 INFO - TinderboxPrint: CPU idle
8,262.2 (86.9%) 03:32:12 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 03:32:12 INFO - TinderboxPrint: Swap in / out
0 / 0 03:32:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108609536; Read time: 0; Write time: 99544 03:32:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:32:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 324554752; Read time: 0; Write time: 187464 03:32:13 INFO - Running post-run listener: _upload_blobber_files 03:32:13 INFO - Blob upload gear active. 03:32:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:13 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 03:32:13 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'] 03:32:13 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 03:32:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:32:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:32:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:14 INFO - (blobuploader) - INFO - Done attempting. 03:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:20 INFO - (blobuploader) - INFO - Done attempting. 03:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:21 INFO - (blobuploader) - INFO - Done attempting. 03:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:22 INFO - (blobuploader) - INFO - Done attempting. 03:32:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:22 INFO - Return code: 0 03:32:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3411e3a8da5fabc362311ad326f7b67107a59f429089956d2b89a7f1308b4974361b9b18cfa4f34be8eba369e48a76ef6a7ca05315c944694a78ab0a78b70d4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37a6c6f22298ab69e51fe6f9d0c38b920061b879733325ff78e56319109b8c5bd307d02e940cd580141a6a6a83a7e71bc378dbac5dd247d7467105f479dca9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7183cd0c35455be0a4cccab99c880d1913da726cef3ea8d99c58464556d6a5143e8644a1eaf7fec75e4b060a12b56757c0aff51182f7da154642f0e9271a66b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6630e095cfb1054704a01d2956d43fc8baed0f796d099d8a03f33f8f2ec13ca33362ddde694d03416fbdbca91773d4515a13204e3396fbd4463b3650ca6e8221"} 03:32:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:22 INFO - Contents: 03:32:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3411e3a8da5fabc362311ad326f7b67107a59f429089956d2b89a7f1308b4974361b9b18cfa4f34be8eba369e48a76ef6a7ca05315c944694a78ab0a78b70d4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37a6c6f22298ab69e51fe6f9d0c38b920061b879733325ff78e56319109b8c5bd307d02e940cd580141a6a6a83a7e71bc378dbac5dd247d7467105f479dca9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7183cd0c35455be0a4cccab99c880d1913da726cef3ea8d99c58464556d6a5143e8644a1eaf7fec75e4b060a12b56757c0aff51182f7da154642f0e9271a66b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6630e095cfb1054704a01d2956d43fc8baed0f796d099d8a03f33f8f2ec13ca33362ddde694d03416fbdbca91773d4515a13204e3396fbd4463b3650ca6e8221"} 03:32:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:22 INFO - Copying logs to upload dir... 03:32:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.519993 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-16 03:32:22.426014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:32:22.434977) ========= 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=ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905 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/3411e3a8da5fabc362311ad326f7b67107a59f429089956d2b89a7f1308b4974361b9b18cfa4f34be8eba369e48a76ef6a7ca05315c944694a78ab0a78b70d4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37a6c6f22298ab69e51fe6f9d0c38b920061b879733325ff78e56319109b8c5bd307d02e940cd580141a6a6a83a7e71bc378dbac5dd247d7467105f479dca9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7183cd0c35455be0a4cccab99c880d1913da726cef3ea8d99c58464556d6a5143e8644a1eaf7fec75e4b060a12b56757c0aff51182f7da154642f0e9271a66b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6630e095cfb1054704a01d2956d43fc8baed0f796d099d8a03f33f8f2ec13ca33362ddde694d03416fbdbca91773d4515a13204e3396fbd4463b3650ca6e8221"} build_url:https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/HuMrrxyuS1iW8gGOnr-3Zg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3411e3a8da5fabc362311ad326f7b67107a59f429089956d2b89a7f1308b4974361b9b18cfa4f34be8eba369e48a76ef6a7ca05315c944694a78ab0a78b70d4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37a6c6f22298ab69e51fe6f9d0c38b920061b879733325ff78e56319109b8c5bd307d02e940cd580141a6a6a83a7e71bc378dbac5dd247d7467105f479dca9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7183cd0c35455be0a4cccab99c880d1913da726cef3ea8d99c58464556d6a5143e8644a1eaf7fec75e4b060a12b56757c0aff51182f7da154642f0e9271a66b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6630e095cfb1054704a01d2956d43fc8baed0f796d099d8a03f33f8f2ec13ca33362ddde694d03416fbdbca91773d4515a13204e3396fbd4463b3650ca6e8221"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:32:22.462664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:32:22.462973) ========= 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=ed14279e38b05397cf4aa391000001a4-1502878284.960970-1570623905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:32:22.545523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:32:22.547841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:32:22.548125) ========= ========= Total master_lag: 0.90 =========