builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1502228840.44 results: success (0) revision: be392d4638052977f11e3fdd7fe6aac78057351c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.442892) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.443332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.443646) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.462365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.462643) ========= 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=523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 14:47:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2017-08-08 14:47:20 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.598338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.598630) ========= 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=523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018166 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:20.648636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-08 14:47:20.648945) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be392d4638052977f11e3fdd7fe6aac78057351c --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 be392d4638052977f11e3fdd7fe6aac78057351c --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=523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 14:47:21,069 truncating revision to first 12 chars 2017-08-08 14:47:21,070 Setting DEBUG logging. 2017-08-08 14:47:21,070 attempt 1/10 2017-08-08 14:47:21,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be392d463805?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 14:47:21,752 sleeping for 10.00s (attempt 1/10) 2017-08-08 14:47:31,763 attempt 2/10 2017-08-08 14:47:31,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be392d463805?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 14:47:32,207 unpacking tar archive at: mozilla-central-be392d463805/testing/mozharness/ program finished with exit code 0 elapsedTime=11.428858 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-08 14:47:32.090834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:32.091161) ========= script_repo_revision: be392d4638052977f11e3fdd7fe6aac78057351c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:32.091553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:32.091824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:47:32.101726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-08 14:47:32.102025) ========= /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=523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:32 INFO - MultiFileLogger online at 20170808 14:47:32 in /builds/slave/test 14:47:32 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 14:47:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:32 INFO - {'append_to_log': False, 14:47:32 INFO - 'base_work_dir': '/builds/slave/test', 14:47:32 INFO - 'blob_upload_branch': 'Firefox', 14:47:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:32 INFO - 'branch': 'Firefox', 14:47:32 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:32 INFO - 'code_coverage': False, 14:47:32 INFO - 'config_files': ('talos/linux_config.py',), 14:47:32 INFO - 'default_actions': ('clobber', 14:47:32 INFO - 'read-buildbot-config', 14:47:32 INFO - 'download-and-extract', 14:47:32 INFO - 'populate-webroot', 14:47:32 INFO - 'create-virtualenv', 14:47:32 INFO - 'install', 14:47:32 INFO - 'setup-mitmproxy', 14:47:32 INFO - 'run-tests'), 14:47:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:32 INFO - 'disable_ccov_upload': False, 14:47:32 INFO - 'download_minidump_stackwalk': True, 14:47:32 INFO - 'download_symbols': 'ondemand', 14:47:32 INFO - 'enable_stylo': False, 14:47:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:32 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:32 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:32 INFO - 'gecko_profile': False, 14:47:32 INFO - 'gecko_profile_interval': 0, 14:47:32 INFO - 'installer_path': 'installer.exe', 14:47:32 INFO - 'log_level': 'info', 14:47:32 INFO - 'log_name': 'talos', 14:47:32 INFO - 'log_to_console': True, 14:47:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:32 INFO - 'opt_config_files': (), 14:47:32 INFO - 'pip_index': False, 14:47:32 INFO - 'suite': 'dromaeojs-e10s', 14:47:32 INFO - 'system_bits': '32', 14:47:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:32 INFO - 'title': 'talos-linux64-ix-065', 14:47:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:32 INFO - 'use_talos_json': True, 14:47:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:32 INFO - 'work_dir': 'build'} 14:47:32 INFO - [mozharness: 2017-08-08 21:47:32.630442Z] Running clobber step. 14:47:32 INFO - Running pre-action listener: _resource_record_pre_action 14:47:32 INFO - Running main action method: clobber 14:47:32 INFO - rmtree: /builds/slave/test/build 14:47:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:33 INFO - Running post-action listener: _resource_record_post_action 14:47:33 INFO - [mozharness: 2017-08-08 21:47:33.663005Z] Finished clobber step (success) 14:47:33 INFO - [mozharness: 2017-08-08 21:47:33.663108Z] Running read-buildbot-config step. 14:47:33 INFO - Running pre-action listener: _resource_record_pre_action 14:47:33 INFO - Running main action method: read_buildbot_config 14:47:33 INFO - Using buildbot properties: 14:47:33 INFO - { 14:47:33 INFO - "project": "", 14:47:33 INFO - "product": "firefox", 14:47:33 INFO - "who": "kwierso@gmail.com", 14:47:33 INFO - "installer_path": "public/build/target.tar.bz2", 14:47:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:47:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:47:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:47:33 INFO - "stage_platform": "linux64-stylosequential", 14:47:33 INFO - "basedir": "/builds/slave/test", 14:47:33 INFO - "buildnumber": 174, 14:47:33 INFO - "platform": "ubuntu64_hw_styloseq", 14:47:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:47:33 INFO - "slavebuilddir": "test", 14:47:33 INFO - "taskId": "J7zDke93R0KeLNQDjiBRYw", 14:47:33 INFO - "branch": "mozilla-central", 14:47:33 INFO - "script_repo_revision": "production", 14:47:33 INFO - "revision": "be392d4638052977f11e3fdd7fe6aac78057351c", 14:47:33 INFO - "slavename": "talos-linux64-ix-065", 14:47:33 INFO - "repo_path": "mozilla-central" 14:47:33 INFO - } 14:47:33 INFO - Finding installer, test and symbols from parent task. 14:47:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J7zDke93R0KeLNQDjiBRYw'}, attempt #1 14:47:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J7zDke93R0KeLNQDjiBRYw'}, attempt #1 14:47:34 INFO - Task dependencies: GaBE-UeZSkOefe_vidhhZg 14:47:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg'}, attempt #1 14:47:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2 14:47:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.test_packages.json 14:47:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.crashreporter-symbols.zip 14:47:35 INFO - Running post-action listener: _resource_record_post_action 14:47:35 INFO - [mozharness: 2017-08-08 21:47:35.037855Z] Finished read-buildbot-config step (success) 14:47:35 INFO - [mozharness: 2017-08-08 21:47:35.038078Z] Running download-and-extract step. 14:47:35 INFO - Running pre-action listener: _resource_record_pre_action 14:47:35 INFO - Running main action method: download_and_extract 14:47:35 INFO - mkdir: /builds/slave/test/build/tests 14:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:35 INFO - trying https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.test_packages.json 14:47:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:47:35 INFO - Downloaded 989 bytes. 14:47:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:47:35 INFO - Using the following test package requirements: 14:47:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:47:35 INFO - u'common': [u'target.common.tests.zip'], 14:47:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:47:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:47:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:47:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:47:35 INFO - u'mozbase': [u'target.common.tests.zip'], 14:47:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:47:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:47:35 INFO - u'web-platform': [u'target.common.tests.zip', 14:47:35 INFO - u'target.web-platform.tests.tar.gz'], 14:47:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:47:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:47:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.common.tests.zip 14:47:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:47:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.common.tests.zip into memory 14:47:36 INFO - Content-Length response header: 54284715 14:47:36 INFO - Bytes received: 54284715 14:47:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:47:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.common.tests.zip 14:47:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:47:47 INFO - Fetch https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.common.tests.zip into memory 14:47:48 INFO - Content-Length response header: 54284715 14:47:48 INFO - Bytes received: 54284715 14:48:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.talos.tests.zip 14:48:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:48:00 INFO - Fetch https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.talos.tests.zip into memory 14:48:01 INFO - Content-Length response header: 14496008 14:48:01 INFO - Bytes received: 14496008 14:48:01 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')]} 14:48:01 INFO - trying https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2 14:48:01 INFO - Downloading https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:48:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:48:02 INFO - Downloaded 61723014 bytes. 14:48:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2 14:48:02 INFO - mkdir: /builds/slave/test/properties 14:48:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:48:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:48:02 INFO - Contents: 14:48:02 INFO - build_url:https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2 14:48:02 INFO - Running post-action listener: _resource_record_post_action 14:48:02 INFO - Running post-action listener: set_extra_try_arguments 14:48:02 INFO - [mozharness: 2017-08-08 21:48:02.699168Z] Finished download-and-extract step (success) 14:48:02 INFO - [mozharness: 2017-08-08 21:48:02.699267Z] Running populate-webroot step. 14:48:02 INFO - Running pre-action listener: _resource_record_pre_action 14:48:02 INFO - Running main action method: populate_webroot 14:48:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:48:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:48:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:48:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:48:02 INFO - 'tests': ['damp', 'tps']}, 14:48:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:48:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:48:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:48:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:48:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:48:02 INFO - 'ts_paint', 14:48:02 INFO - 'tpaint', 14:48:02 INFO - 'sessionrestore', 14:48:02 INFO - 'sessionrestore_many_windows', 14:48:02 INFO - 'sessionrestore_no_auto_restore', 14:48:02 INFO - 'tabpaint']}, 14:48:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:48:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:48:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:48:02 INFO - 'tsvgr_opacity', 14:48:02 INFO - 'tart', 14:48:02 INFO - 'tscrollx', 14:48:02 INFO - 'tsvg_static']}, 14:48:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:48:02 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:02 INFO - 'talos_options': ['--mitmproxy', 14:48:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:02 INFO - '--firstNonBlankPaint'], 14:48:02 INFO - 'tests': ['tp6_google', 14:48:02 INFO - 'tp6_youtube', 14:48:02 INFO - 'tp6_amazon', 14:48:02 INFO - 'tp6_facebook']}, 14:48:02 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:02 INFO - 'talos_options': ['--stylo', 14:48:02 INFO - '--mitmproxy', 14:48:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:02 INFO - '--firstNonBlankPaint'], 14:48:02 INFO - 'tests': ['tp6_google', 14:48:02 INFO - 'tp6_youtube', 14:48:02 INFO - 'tp6_amazon', 14:48:02 INFO - 'tp6_facebook']}, 14:48:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:48:02 INFO - 'talos_options': ['--stylo', 14:48:02 INFO - '--stylo-threads=1', 14:48:02 INFO - '--mitmproxy', 14:48:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:48:02 INFO - '--firstNonBlankPaint'], 14:48:02 INFO - 'tests': ['tp6_google', 14:48:02 INFO - 'tp6_youtube', 14:48:02 INFO - 'tp6_amazon', 14:48:02 INFO - 'tp6_facebook']}, 14:48:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:48:02 INFO - 'talos_options': ['--xperf_path', 14:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:48:02 INFO - 'tests': ['tp5n']}}} 14:48:02 INFO - Running post-action listener: _resource_record_post_action 14:48:02 INFO - [mozharness: 2017-08-08 21:48:02.707702Z] Finished populate-webroot step (success) 14:48:02 INFO - [mozharness: 2017-08-08 21:48:02.707792Z] Running create-virtualenv step. 14:48:02 INFO - Running pre-action listener: _resource_record_pre_action 14:48:02 INFO - Running main action method: create_virtualenv 14:48:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:48:02 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 14:48:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:48:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:48:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:48:02 INFO - Using real prefix '/usr' 14:48:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:48:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:48:05 INFO - Installing pip.................done. 14:48:05 INFO - Return code: 0 14:48:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:48:05 INFO - Reading from file tmpfile_stdout 14:48:05 INFO - Output received: 14:48:05 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) 14:48:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48: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', 'pip>=1.5'] in /builds/slave/test/build 14:48: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 pip>=1.5 14:48:05 INFO - Using env: {'DISPLAY': ':0', 14:48:05 INFO - 'HOME': '/home/cltbld', 14:48:05 INFO - 'LANG': 'en_US.UTF-8', 14:48:05 INFO - 'LANGUAGE': 'en_US:en', 14:48:05 INFO - 'LOGNAME': 'cltbld', 14:48:05 INFO - 'MAIL': '/var/mail/cltbld', 14:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:05 INFO - 'MOZ_NO_REMOTE': '1', 14:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:05 INFO - 'NO_EM_RESTART': '1', 14:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:05 INFO - 'PWD': '/builds/slave/test', 14:48:05 INFO - 'SHELL': '/bin/bash', 14:48:05 INFO - 'SHLVL': '1', 14:48:05 INFO - 'TERM': 'linux', 14:48:05 INFO - 'TMOUT': '86400', 14:48:05 INFO - 'USER': 'cltbld', 14:48:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:05 INFO - '_': '/tools/buildbot/bin/python'} 14:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:05 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 14:48:05 INFO - Cleaning up... 14:48:05 INFO - Return code: 0 14:48:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48: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', '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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:48: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 psutil>=3.1.1 14:48:05 INFO - Using env: {'DISPLAY': ':0', 14:48:05 INFO - 'HOME': '/home/cltbld', 14:48:05 INFO - 'LANG': 'en_US.UTF-8', 14:48:05 INFO - 'LANGUAGE': 'en_US:en', 14:48:05 INFO - 'LOGNAME': 'cltbld', 14:48:05 INFO - 'MAIL': '/var/mail/cltbld', 14:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:05 INFO - 'MOZ_NO_REMOTE': '1', 14:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:05 INFO - 'NO_EM_RESTART': '1', 14:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:05 INFO - 'PWD': '/builds/slave/test', 14:48:05 INFO - 'SHELL': '/bin/bash', 14:48:05 INFO - 'SHLVL': '1', 14:48:05 INFO - 'TERM': 'linux', 14:48:05 INFO - 'TMOUT': '86400', 14:48:05 INFO - 'USER': 'cltbld', 14:48:05 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:05 INFO - '_': '/tools/buildbot/bin/python'} 14:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:05 INFO - Downloading/unpacking psutil>=3.1.1 14:48: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 14:48: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 14:48: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 14:48: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 14:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:07 INFO - Installing collected packages: psutil 14:48:07 INFO - Running setup.py install for psutil 14:48:07 INFO - building 'psutil._psutil_linux' extension 14:48:07 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 14:48:07 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 14:48:07 INFO - building 'psutil._psutil_posix' extension 14:48:07 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 14:48:07 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 14:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:48:07 INFO - Successfully installed psutil 14:48:07 INFO - Cleaning up... 14:48:07 INFO - Return code: 0 14:48:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:48: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 mozsystemmonitor==0.3 14:48:07 INFO - Using env: {'DISPLAY': ':0', 14:48:07 INFO - 'HOME': '/home/cltbld', 14:48:07 INFO - 'LANG': 'en_US.UTF-8', 14:48:07 INFO - 'LANGUAGE': 'en_US:en', 14:48:07 INFO - 'LOGNAME': 'cltbld', 14:48:07 INFO - 'MAIL': '/var/mail/cltbld', 14:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:07 INFO - 'MOZ_NO_REMOTE': '1', 14:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:07 INFO - 'NO_EM_RESTART': '1', 14:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:07 INFO - 'PWD': '/builds/slave/test', 14:48:07 INFO - 'SHELL': '/bin/bash', 14:48:07 INFO - 'SHLVL': '1', 14:48:07 INFO - 'TERM': 'linux', 14:48:07 INFO - 'TMOUT': '86400', 14:48:07 INFO - 'USER': 'cltbld', 14:48:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:07 INFO - '_': '/tools/buildbot/bin/python'} 14:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:48: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 14:48: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 14:48: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 14:48: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 14:48:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:48:09 INFO - Installing collected packages: mozsystemmonitor 14:48:09 INFO - Running setup.py install for mozsystemmonitor 14:48:09 INFO - Successfully installed mozsystemmonitor 14:48:09 INFO - Cleaning up... 14:48:09 INFO - Return code: 0 14:48:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:48:09 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')]} 14:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:09 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')]} 14:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:09 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:09 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 14:48:09 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 14:48:09 INFO - Using env: {'DISPLAY': ':0', 14:48:09 INFO - 'HOME': '/home/cltbld', 14:48:09 INFO - 'LANG': 'en_US.UTF-8', 14:48:09 INFO - 'LANGUAGE': 'en_US:en', 14:48:09 INFO - 'LOGNAME': 'cltbld', 14:48:09 INFO - 'MAIL': '/var/mail/cltbld', 14:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:09 INFO - 'MOZ_NO_REMOTE': '1', 14:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:09 INFO - 'NO_EM_RESTART': '1', 14:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:09 INFO - 'PWD': '/builds/slave/test', 14:48:09 INFO - 'SHELL': '/bin/bash', 14:48:09 INFO - 'SHLVL': '1', 14:48:09 INFO - 'TERM': 'linux', 14:48:09 INFO - 'TMOUT': '86400', 14:48:09 INFO - 'USER': 'cltbld', 14:48:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:09 INFO - '_': '/tools/buildbot/bin/python'} 14:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:09 INFO - Downloading/unpacking jsonschema==2.5.1 14:48: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 14:48: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 14:48: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 14:48: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 14:48:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:48:10 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 14:48:10 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 14:48:10 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 14:48:10 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 14:48:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:10 INFO - warning: no files found matching '*.txt' 14:48:10 INFO - no previously-included directories found matching 'build' 14:48:10 INFO - no previously-included directories found matching 'dist' 14:48:10 INFO - no previously-included directories found matching '.git*' 14:48:10 INFO - Installing collected packages: jsonschema, functools32 14:48:10 INFO - Running setup.py install for functools32 14:48:10 INFO - warning: no files found matching '*.txt' 14:48:10 INFO - no previously-included directories found matching 'build' 14:48:10 INFO - no previously-included directories found matching 'dist' 14:48:10 INFO - no previously-included directories found matching '.git*' 14:48:10 INFO - Successfully installed jsonschema functools32 14:48:10 INFO - Cleaning up... 14:48:10 INFO - Return code: 0 14:48:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:10 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:10 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 14:48:10 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 14:48:10 INFO - Using env: {'DISPLAY': ':0', 14:48:10 INFO - 'HOME': '/home/cltbld', 14:48:10 INFO - 'LANG': 'en_US.UTF-8', 14:48:10 INFO - 'LANGUAGE': 'en_US:en', 14:48:10 INFO - 'LOGNAME': 'cltbld', 14:48:10 INFO - 'MAIL': '/var/mail/cltbld', 14:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:10 INFO - 'MOZ_NO_REMOTE': '1', 14:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:10 INFO - 'NO_EM_RESTART': '1', 14:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:10 INFO - 'PWD': '/builds/slave/test', 14:48:10 INFO - 'SHELL': '/bin/bash', 14:48:10 INFO - 'SHLVL': '1', 14:48:10 INFO - 'TERM': 'linux', 14:48:10 INFO - 'TMOUT': '86400', 14:48:10 INFO - 'USER': 'cltbld', 14:48:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:10 INFO - '_': '/tools/buildbot/bin/python'} 14:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:48:11 INFO - Cleaning up... 14:48:11 INFO - Return code: 0 14:48:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:11 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:11 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 14:48:11 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 14:48:11 INFO - Using env: {'DISPLAY': ':0', 14:48:11 INFO - 'HOME': '/home/cltbld', 14:48:11 INFO - 'LANG': 'en_US.UTF-8', 14:48:11 INFO - 'LANGUAGE': 'en_US:en', 14:48:11 INFO - 'LOGNAME': 'cltbld', 14:48:11 INFO - 'MAIL': '/var/mail/cltbld', 14:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:11 INFO - 'MOZ_NO_REMOTE': '1', 14:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:11 INFO - 'NO_EM_RESTART': '1', 14:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:11 INFO - 'PWD': '/builds/slave/test', 14:48:11 INFO - 'SHELL': '/bin/bash', 14:48:11 INFO - 'SHLVL': '1', 14:48:11 INFO - 'TERM': 'linux', 14:48:11 INFO - 'TMOUT': '86400', 14:48:11 INFO - 'USER': 'cltbld', 14:48:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:11 INFO - '_': '/tools/buildbot/bin/python'} 14:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:11 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 14:48:11 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 14:48:11 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 14:48:11 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 14:48:12 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:12 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 14:48:12 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 14:48:12 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 14:48:12 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 14:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:12 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 14:48:12 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 14:48:12 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 14:48:12 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 14:48:12 INFO - Downloading docopt-0.6.1.tar.gz 14:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:13 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:13 INFO - Running setup.py install for blobuploader 14:48:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:13 INFO - Running setup.py install for requests 14:48:13 INFO - Running setup.py install for docopt 14:48:13 INFO - Successfully installed blobuploader requests docopt 14:48:13 INFO - Cleaning up... 14:48:13 INFO - Return code: 0 14:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:13 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:13 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 14:48:13 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 14:48:13 INFO - Using env: {'DISPLAY': ':0', 14:48:13 INFO - 'HOME': '/home/cltbld', 14:48:13 INFO - 'LANG': 'en_US.UTF-8', 14:48:13 INFO - 'LANGUAGE': 'en_US:en', 14:48:13 INFO - 'LOGNAME': 'cltbld', 14:48:13 INFO - 'MAIL': '/var/mail/cltbld', 14:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:13 INFO - 'MOZ_NO_REMOTE': '1', 14:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:13 INFO - 'NO_EM_RESTART': '1', 14:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:13 INFO - 'PWD': '/builds/slave/test', 14:48:13 INFO - 'SHELL': '/bin/bash', 14:48:13 INFO - 'SHLVL': '1', 14:48:13 INFO - 'TERM': 'linux', 14:48:13 INFO - 'TMOUT': '86400', 14:48:13 INFO - 'USER': 'cltbld', 14:48:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:13 INFO - '_': '/tools/buildbot/bin/python'} 14:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:13 INFO - Running setup.py (path:/tmp/pip-hO72Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:13 INFO - Running setup.py (path:/tmp/pip-utcUZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:14 INFO - Running setup.py (path:/tmp/pip-bWN3Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:14 INFO - Running setup.py (path:/tmp/pip-gPm_dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:14 INFO - Running setup.py (path:/tmp/pip-4jG8HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:14 INFO - Running setup.py (path:/tmp/pip-O6Swh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:14 INFO - Running setup.py (path:/tmp/pip-Uqrb5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:14 INFO - Running setup.py (path:/tmp/pip-k8ykKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:14 INFO - Running setup.py (path:/tmp/pip-Qsk3Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:14 INFO - Running setup.py (path:/tmp/pip-ltKhb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:14 INFO - Running setup.py (path:/tmp/pip-WCVj5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:14 INFO - Running setup.py (path:/tmp/pip-h2d3Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:14 INFO - Running setup.py (path:/tmp/pip-ttSLc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:14 INFO - Running setup.py (path:/tmp/pip-vyDNOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:14 INFO - Running setup.py (path:/tmp/pip-nUSs0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:14 INFO - Running setup.py (path:/tmp/pip-hnNAI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:15 INFO - Running setup.py (path:/tmp/pip-xiClw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:15 INFO - Running setup.py install for manifestparser 14:48:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozcrash 14:48:15 INFO - Running setup.py install for mozdebug 14:48:15 INFO - Running setup.py install for mozdevice 14:48:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozfile 14:48:15 INFO - Running setup.py install for mozhttpd 14:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozinfo 14:48:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozInstall 14:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozleak 14:48:15 INFO - Running setup.py install for mozlog 14:48:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for moznetwork 14:48:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozprocess 14:48:16 INFO - Running setup.py install for mozprofile 14:48:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozrunner 14:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozscreenshot 14:48:16 INFO - Running setup.py install for moztest 14:48:16 INFO - Running setup.py install for mozversion 14:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:16 INFO - Cleaning up... 14:48:16 INFO - Return code: 0 14:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48: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')]} 14:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:16 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:16 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 14:48:16 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 14:48:16 INFO - Using env: {'DISPLAY': ':0', 14:48:16 INFO - 'HOME': '/home/cltbld', 14:48:16 INFO - 'LANG': 'en_US.UTF-8', 14:48:16 INFO - 'LANGUAGE': 'en_US:en', 14:48:16 INFO - 'LOGNAME': 'cltbld', 14:48:16 INFO - 'MAIL': '/var/mail/cltbld', 14:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:16 INFO - 'MOZ_NO_REMOTE': '1', 14:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:16 INFO - 'NO_EM_RESTART': '1', 14:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:16 INFO - 'PWD': '/builds/slave/test', 14:48:16 INFO - 'SHELL': '/bin/bash', 14:48:16 INFO - 'SHLVL': '1', 14:48:16 INFO - 'TERM': 'linux', 14:48:16 INFO - 'TMOUT': '86400', 14:48:16 INFO - 'USER': 'cltbld', 14:48:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:16 INFO - '_': '/tools/buildbot/bin/python'} 14:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:17 INFO - Running setup.py (path:/tmp/pip-FOhIZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:17 INFO - Running setup.py (path:/tmp/pip-FjX1gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:17 INFO - Running setup.py (path:/tmp/pip-aZzWue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:17 INFO - Running setup.py (path:/tmp/pip-IHiUfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:17 INFO - Running setup.py (path:/tmp/pip-fQdpii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:17 INFO - Running setup.py (path:/tmp/pip-qDYnjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:17 INFO - Running setup.py (path:/tmp/pip-pVAUvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:17 INFO - Running setup.py (path:/tmp/pip-QJSL1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:17 INFO - Running setup.py (path:/tmp/pip-gnLTR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:17 INFO - Running setup.py (path:/tmp/pip-VHwqJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:17 INFO - Running setup.py (path:/tmp/pip-Hl8vyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:17 INFO - Running setup.py (path:/tmp/pip-ZnJoUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:17 INFO - Running setup.py (path:/tmp/pip-qHyNTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:18 INFO - Running setup.py (path:/tmp/pip-ydKffo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:18 INFO - Running setup.py (path:/tmp/pip-r4PeO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:18 INFO - Running setup.py (path:/tmp/pip-9Q0S4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:18 INFO - Running setup.py (path:/tmp/pip-0jCODi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48:18 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 14:48:18 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 14:48:18 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 14:48:18 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 14:48:19 INFO - Downloading blessings-1.6.tar.gz 14:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:19 INFO - Installing collected packages: blessings 14:48:19 INFO - Running setup.py install for blessings 14:48:19 INFO - Successfully installed blessings 14:48:19 INFO - Cleaning up... 14:48:19 INFO - Return code: 0 14:48:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:19 INFO - Reading from file tmpfile_stdout 14:48:19 INFO - Current package versions: 14:48:19 INFO - argparse == 1.2.1 14:48:19 INFO - blessings == 1.6 14:48:19 INFO - blobuploader == 1.2.4 14:48:19 INFO - docopt == 0.6.1 14:48:19 INFO - functools32 == 3.2.3-2 14:48:19 INFO - jsonschema == 2.5.1 14:48:19 INFO - manifestparser == 1.1 14:48:19 INFO - mozInstall == 1.13 14:48:19 INFO - mozcrash == 1.0 14:48:19 INFO - mozdebug == 0.1 14:48:19 INFO - mozdevice == 0.51 14:48:19 INFO - mozfile == 1.2 14:48:19 INFO - mozhttpd == 0.7 14:48:19 INFO - mozinfo == 0.10 14:48:19 INFO - mozleak == 0.1 14:48:19 INFO - mozlog == 3.5 14:48:19 INFO - moznetwork == 0.27 14:48:19 INFO - mozprocess == 0.25 14:48:19 INFO - mozprofile == 0.28 14:48:19 INFO - mozrunner == 6.13 14:48:19 INFO - mozscreenshot == 0.1 14:48:19 INFO - mozsystemmonitor == 0.3 14:48:19 INFO - moztest == 0.8 14:48:19 INFO - mozversion == 1.4 14:48:19 INFO - psutil == 3.1.1 14:48:19 INFO - requests == 1.2.3 14:48:19 INFO - wsgiref == 0.1.2 14:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:19 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')]} 14:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:19 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')]} 14:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:19 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:19 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 14:48:19 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 14:48:19 INFO - Using env: {'DISPLAY': ':0', 14:48:19 INFO - 'HOME': '/home/cltbld', 14:48:19 INFO - 'LANG': 'en_US.UTF-8', 14:48:19 INFO - 'LANGUAGE': 'en_US:en', 14:48:19 INFO - 'LOGNAME': 'cltbld', 14:48:19 INFO - 'MAIL': '/var/mail/cltbld', 14:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:19 INFO - 'MOZ_NO_REMOTE': '1', 14:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:19 INFO - 'NO_EM_RESTART': '1', 14:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:19 INFO - 'PWD': '/builds/slave/test', 14:48:19 INFO - 'SHELL': '/bin/bash', 14:48:19 INFO - 'SHLVL': '1', 14:48:19 INFO - 'TERM': 'linux', 14:48:19 INFO - 'TMOUT': '86400', 14:48:19 INFO - 'USER': 'cltbld', 14:48:19 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:19 INFO - '_': '/tools/buildbot/bin/python'} 14:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 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)) 14:48:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:48:20 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 14:48:20 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 14:48:20 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 14:48:20 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 14:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:48:21 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)) 14:48:21 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)) 14:48:21 INFO - Installing collected packages: simplejson 14:48:21 INFO - Running setup.py install for simplejson 14:48:21 INFO - building 'simplejson._speedups' extension 14:48:21 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 14:48:22 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 14:48:22 INFO - Successfully installed simplejson 14:48:22 INFO - Cleaning up... 14:48:22 INFO - Return code: 0 14:48:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48:22 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')]} 14:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:22 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')]} 14:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:22 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 0x11091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, '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': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', '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 14:48:22 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 14:48:22 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 14:48:22 INFO - Using env: {'DISPLAY': ':0', 14:48:22 INFO - 'HOME': '/home/cltbld', 14:48:22 INFO - 'LANG': 'en_US.UTF-8', 14:48:22 INFO - 'LANGUAGE': 'en_US:en', 14:48:22 INFO - 'LOGNAME': 'cltbld', 14:48:22 INFO - 'MAIL': '/var/mail/cltbld', 14:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:22 INFO - 'MOZ_NO_REMOTE': '1', 14:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:22 INFO - 'NO_EM_RESTART': '1', 14:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:22 INFO - 'PWD': '/builds/slave/test', 14:48:22 INFO - 'SHELL': '/bin/bash', 14:48:22 INFO - 'SHLVL': '1', 14:48:22 INFO - 'TERM': 'linux', 14:48:22 INFO - 'TMOUT': '86400', 14:48:22 INFO - 'USER': 'cltbld', 14:48:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:22 INFO - '_': '/tools/buildbot/bin/python'} 14:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:48:22 INFO - Cleaning up... 14:48:22 INFO - Return code: 0 14:48:22 INFO - Running post-action listener: _resource_record_post_action 14:48:22 INFO - Running post-action listener: _start_resource_monitoring 14:48:22 INFO - Starting resource monitoring. 14:48:22 INFO - [mozharness: 2017-08-08 21:48:22.578044Z] Finished create-virtualenv step (success) 14:48:22 INFO - [mozharness: 2017-08-08 21:48:22.578509Z] Running install step. 14:48:22 INFO - Running pre-action listener: _resource_record_pre_action 14:48:22 INFO - Running main action method: install 14:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:22 INFO - Reading from file tmpfile_stdout 14:48:22 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:22 INFO - Reading from file tmpfile_stdout 14:48:22 INFO - Output received: 14:48:22 INFO - Usage: mozinstall [options] installer 14:48:22 INFO - Options: 14:48:22 INFO - -h, --help show this help message and exit 14:48:22 INFO - -d DEST, --destination=DEST 14:48:22 INFO - Directory to install application into. [default: 14:48:22 INFO - "/builds/slave/test"] 14:48:22 INFO - --app=APP Application being installed. [default: firefox] 14:48:22 INFO - mkdir: /builds/slave/test/build/application 14:48:22 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'] 14:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:48:40 INFO - Reading from file tmpfile_stdout 14:48:40 INFO - Output received: 14:48:40 INFO - /builds/slave/test/build/application/firefox/firefox 14:48:40 INFO - Running post-action listener: _resource_record_post_action 14:48:40 INFO - [mozharness: 2017-08-08 21:48:40.845626Z] Finished install step (success) 14:48:40 INFO - [mozharness: 2017-08-08 21:48:40.845973Z] Running setup-mitmproxy step. 14:48:40 INFO - Running pre-action listener: _resource_record_pre_action 14:48:40 INFO - Running main action method: setup_mitmproxy 14:48:40 INFO - Skipping: mitmproxy is not required 14:48:40 INFO - Running post-action listener: _resource_record_post_action 14:48:40 INFO - [mozharness: 2017-08-08 21:48:40.847604Z] Finished setup-mitmproxy step (success) 14:48:40 INFO - [mozharness: 2017-08-08 21:48:40.847913Z] Running run-tests step. 14:48:40 INFO - Running pre-action listener: _resource_record_pre_action 14:48:40 INFO - Running pre-action listener: _set_gcov_prefix 14:48:40 INFO - Running main action method: run_tests 14:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:40 INFO - Python 2.7.3 14:48:40 INFO - Return code: 0 14:48:40 INFO - grabbing minidump binary from tooltool 14:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:40 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 0x1475eb0>, '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 0x1476db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1477240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:40 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 14:48:40 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 14:48:40 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 14:48:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:40 INFO - Return code: 0 14:48:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:48:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:40 INFO - ENV: RUST_BACKTRACE is now 1 14:48:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:48:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:40 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/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 14:48:40 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/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 14:48:40 INFO - Using env: {'DISPLAY': ':0', 14:48:40 INFO - 'HOME': '/home/cltbld', 14:48:40 INFO - 'LANG': 'en_US.UTF-8', 14:48:40 INFO - 'LANGUAGE': 'en_US:en', 14:48:40 INFO - 'LOGNAME': 'cltbld', 14:48:40 INFO - 'MAIL': '/var/mail/cltbld', 14:48:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:40 INFO - 'MOZ_NO_REMOTE': '1', 14:48:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:48:40 INFO - 'NO_EM_RESTART': '1', 14:48:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:40 INFO - 'PWD': '/builds/slave/test', 14:48:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:40 INFO - 'RUST_BACKTRACE': '1', 14:48:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:48:40 INFO - 'SHELL': '/bin/bash', 14:48:40 INFO - 'SHLVL': '1', 14:48:40 INFO - 'STYLO_FORCE_ENABLED': '1', 14:48:40 INFO - 'TERM': 'linux', 14:48:40 INFO - 'TMOUT': '86400', 14:48:40 INFO - 'USER': 'cltbld', 14:48:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189', 14:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:40 INFO - '_': '/tools/buildbot/bin/python'} 14:48:40 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/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 14:48:41 INFO - mozversion application_buildid: 20170808210644 14:48:41 INFO - mozversion application_changeset: be392d4638052977f11e3fdd7fe6aac78057351c 14:48:41 INFO - mozversion application_display_name: Nightly 14:48:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:41 INFO - mozversion application_name: Firefox 14:48:41 INFO - mozversion application_remotingname: firefox 14:48:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:48:41 INFO - mozversion application_vendor: Mozilla 14:48:41 INFO - mozversion application_version: 57.0a1 14:48:41 INFO - mozversion platform_buildid: 20170808210644 14:48:41 INFO - mozversion platform_changeset: be392d4638052977f11e3fdd7fe6aac78057351c 14:48:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:48:41 INFO - mozversion platform_version: 57.0a1 14:48:41 INFO - using testdate: 1502228921 14:48:41 INFO - actual date: 1502228921 14:48:41 INFO - starting webserver on 'localhost:34516' 14:48:41 INFO - SUITE-START | Running 2 tests 14:48:41 INFO - TEST-START | dromaeo_css 14:48:41 INFO - Initialising browser for dromaeo_css test... 14:48:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34516/getInfo.html -profile /tmp/tmptjeoJK/profile 14:48:41 INFO - TEST-INFO | started process 5252 (/builds/slave/test/build/application/firefox/firefox http://localhost:34516/getInfo.html) 14:48:47 INFO - TEST-INFO | 5252: exit 0 14:48:47 INFO - Browser initialized. 14:48:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:47 INFO - TEST-INFO | started process 5481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjeoJK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:48 INFO - PID 5481 | 14:48:48 INFO - PID 5481 | (/builds/slave/test/build/application/firefox/firefox:5535): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:48:48 INFO - PID 5481 | 14:48:58 INFO - PID 5481 | RSS: Main: 170422272 14:48:58 INFO - PID 5481 | 14:51:58 INFO - PID 5481 | Cycle 1(1): loaded http://localhost:34516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34516/tests/dromaeo/cssquery-ext.html) 14:52:00 INFO - PID 5481 | RSS: Main: 174596096 14:52:00 INFO - PID 5481 | 14:55:02 INFO - PID 5481 | Cycle 1(1): loaded http://localhost:34516/tests/dromaeo/cssquery-ext.html (next: http://localhost:34516/tests/dromaeo/cssquery-jquery.html) 14:55:02 INFO - PID 5481 | RSS: Main: 172765184 14:55:02 INFO - PID 5481 | 14:58:04 INFO - PID 5481 | Cycle 1(1): loaded http://localhost:34516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34516/tests/dromaeo/cssquery-mootools.html) 14:58:05 INFO - PID 5481 | RSS: Main: 174899200 14:58:05 INFO - PID 5481 | 15:01:07 INFO - PID 5481 | Cycle 1(1): loaded http://localhost:34516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34516/tests/dromaeo/cssquery-prototype.html) 15:01:07 INFO - PID 5481 | RSS: Main: 173142016 15:01:07 INFO - PID 5481 | 15:04:11 INFO - PID 5481 | Cycle 1(1): loaded http://localhost:34516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34516/tests/dromaeo/cssquery-yui.html) 15:04:11 INFO - PID 5481 | RSS: Main: 176775168 15:04:11 INFO - PID 5481 | 15:07:13 INFO - PID 5481 | Cycle 1(1): loaded http://localhost:34516/tests/dromaeo/cssquery-yui.html (next: http://localhost:34516/tests/dromaeo/cssquery-dojo.html) 15:07:14 INFO - PID 5481 | RSS: Main: 177664000 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | __start_tp_report 15:07:14 INFO - PID 5481 | _x_x_mozilla_page_load 15:07:14 INFO - PID 5481 | _x_x_mozilla_page_load_details 15:07:14 INFO - PID 5481 | |i|pagename|runs| 15:07:14 INFO - PID 5481 | |0;dojo.html;3126.8436578171086;3165.2245199926024;3177.3962947040045;3187.6174859016905;3194.632617249016;6092.329843717188;6182.165407669963;6188.102725104857;6207.813765587034;6221;6198.504119670427;6208.379162083801;6216.285127210373;6242.375762423755;6272.623642581449;5677.602567820244;5720.3135623725;5726.083826587746;5766.942330576703;5811.912821307684;5731.770729170828;5826.475617194473;5841.532677385799;5845.444682755153;5857.004309267413;5714.171445140431;5749.770009199648;5800.796972105956;5840.795572154975;5857.238558987326;5597.944020559783;5669.26299581056;5670.177824215466;5675.772969081232;5762.07806750922;5594.328680558359;5639.605227634067;5650.463205995465;5656.4060773618585;5679.148127780824;6045.576809623328;6058.4244496772735;6065.636061836304;6082.60463069899;6098.634081955097;6573.93426065738;6578.3092775258865;6585.045168450596;6606.537542372036;6623.966880165616;6655.267920528738;6656.733730650768;6659.33406659335;6662.067310576524;6674.399304062657;5470.370907345667;6097.146399504073;6156.6613836238985;6157.476614487774;6162;6847.486438517031;6859.5541289816;6935.063766391523;6949.096617439701;6956.826079348057;6461.418472337512;6554.016897465323;6555.475561955032;6626.072349871022;6649.734010639617;6592.670366481657;6628.337166283333;6725.932740672629;6733.326667333227;6734.730610775612;6627.801165965029;6684.1978962523835;6701.564398314094;6703.530752847254;6712.865742685217;6546.247181574085;6704.463642908556;6709.597424154469;6719.025741267586;6749.730010799513;5395.4604539545735;5402.945970540244;5418.485243901823;5430.42980487051;5439.129739241703;4580;4654.534546545387;4657.767111644404;4676.859694209179;4677.462091859412;5731.140328950691;5806.622569532967;5852.619579727304;5879;5895.734691938873;6703.229128650268;6707.0610114584;6743.898841517381;6744.123263975652;6746.426553742888;5812.38969908162;5848.298204215522;5865.120231965154;5900.675462849498;5914.408559144051;5916.142159386951;5918.171455996164;5960.284765828128;5979.671118088547;5992.610480318765;6393.328700486382;6573.408393244631;6654.23476300222;6661.4004739573675;6672.799816005528;6699.9665001674675;6701.128853249242;6744.426723728538;6773.356531129535;6778.2205046420295;6539.509536784855;6541.901871471837;6578.111954886029;6627.867442651216;6628.867422651617;6619.271880093283;6645.102911106938;6647.302033286435;6658.167729033871;6666.500012499179;6742;6776.457883369417;6817.693203805741;6838.111045564244;6853.725850966105;6380.9361906380345;6538.444232240313;6558.1802274715665;6620.867582648417;6640.634765087966;6521.054447105238;6542.051402546699;6542.672866356758;6557.967210163919;6560.44236239925;6460.967695161494;6473.093766872547;6473.967630161819;6475.611463312216;6479.611223326616;5983.461488466059;6503.317151699192;6523.804285871432;6541.509386795914;6545.247296560957;6280.9685951569945;6318.526110541819;6323.272823625342;6326.177596912372;6330.683465826783 15:07:14 INFO - PID 5481 | |1;ext.html;759.5708424740021;817.5912043978011;851.7700220940346;872.8734333521637;875.40035075973;39969.99999999996;40286.59713402865;40291.59708402915;40400.39399409004;40449.3932591011;36376;36437.27125457496;36488.81755591225;36725.81637091811;36784.26431471376;6726.730930762776;6906.412954898839;6907.861842763142;6929.896051559231;6935.653217339138;6816.113905192318;6849.1096157499705;6935.687894044755;6939.479539034567;6941.791746247595;6871;7095.184053833824;7394.149672787617;7712.267334603203;7763.728269510569;7689.231076892322;7767;7769.145394006627;7772.572508512029;7775.922240777605;6999.055127557765;7479.4016478682115;7544.132424771166;7582.317591416799;7685.884711729329;37205.441918371245;37845.62154378449;37851.810740946115;37913.241735165415;38039.23921521582;3552.7513074084823;3581.83881725323;3598.6581274778855;3600.4419315006216;3616.4032934565766;30104.8494757527;30421.847890760404;30597.847010764803;30614.38771224563;30683.539746903814;5004.249362595603;5025.447200807908;5027.49725027498;5031.6729412588065;5087.872803179913;194541;230110;234148;234803;235179.8241008801;47919.520804792206;47965;48047.75976120097;48074;48151;50657.74671126695;51127.48872511302;51635.48364516382;52645.47354526406;53403.73298133485;16209.270582823801;16308.67382652364;16327.59181020484;16338.346466141222;16361.83638163603;13144.671383215305;13256.270905100118;13275.336233188302;13277.601671949857;13278.468861245636;14226.786598201035;14242.928785356007;14262.786058209134;14306;14454.927725361305;5867.970660146672;5964.373740757244;5964.7315870785915;5980.401959803985;6048.274207095089;1015.9898401016043;1019.143919107938;1037.5019990404649;1043.118564812732;1044.185535282481;23804.642930356058;23860.761392385855;23997.160099396788;24125.396865078514;31102.53346199809;1101.2126329674322;1103.2608152537819;1105.1987309200765;1119.2668801934747;1128.7065363005513;12354;12891.548795792101;13021.609351719464;13072.28102454355;13136.540221092217;237276;238969;239759;239893;240545;51501.7424912873;51997.740011300455;52079.47920520822;53168.46831531713;57282.713586431804;1494.4769330734373;1516.8634822865774;1518.4305885293015;1535.669830986321;1537.5848520899294;28094.066830644137;28251.57622635621;28498.145055648365;28813.423731525672;29272.414551709273;38211.42682859704;38492.80753596214;38518.2296354077;38585;38587.22825543417;212690;213569;213850;213883;213904;36818.63181368152;37194.442083369315;37303;37389.439158412104;37407.625923740416;42884;43146.784266079725;43532;43544;44031;32253.838730806197;32462.675373245966;32699.673003270615;32749.34501309913;33434.83282583669;31396;31919.36161276808;32599.18502037468;32739.508907366886;32789.01632951015;35357.11607209737;35358.11604709903;35645.82177089098;38229.61770382261;39202.6079739199;34028.48957265692;34201.82899085488;34400.82799585986;34643.307133857685;34839.65160348364;23731.525369492167;24496.755032449448;25290.36774080589;25444.872775636002;25805.225843224733 15:07:14 INFO - PID 5481 | |2;jquery.html;573.3607028163599;582.5572564850712;582.6562328226346;598.3956204233724;609.7408601344429;21916.89041554792;22428.32715018548;23298.41753956152;23329.76670233297;23342.766572334272;26032.47935041303;26579.202623921265;26579.867100664516;26602.33494162647;26652;6397.840053998664;6525.151730275082;6532.967335163317;6533.640649764261;6561.2782593914635;6108.602940808833;6403.039544068381;6442.7745028924;6513.804585862432;6522.543421960465;6381.13854629626;6386.074019267204;6393.0730044143575;6402.615843049409;6411.358864113575;6380.68096595173;6389.584676995981;6391.392817682313;6395.296517383084;6396.552241343108;5857.76568937242;5952.285725712899;5953.047512397996;5960.523158147338;5982.700864956735;29587.852060739773;30114.698853011407;31046.534301985488;31058.53412198819;31180.37639247225;1875.6530041942149;1934.8935808530525;1934.9709754353696;1935.8838469691864;1939.7963213862624;18553.907230463898;19308.80691193098;19315.130819113172;19334.516637084187;19370.903145484182;2316.2356422380744;2382.8808559571953;2388.689470368858;2390.1634427950253;2489.5020995800733;137463.56341091453;141498;141620;142273;142374.28812855974;14215.786763198561;15083.924580377248;15192.696146077016;15256.160911149771;15610.76583851243;23635.172768953005;23660.881695591757;23682.88158559196;23723;23786.286411407684;10261.384316941007;10449.582016719247;10525.631602893862;10597.099246564128;10675.786484270271;9714.61141554344;9759.658411955548;9793;9859.112679858847;9893.653722119836;8646.956765216259;9278.62885484573;9296.116868897443;9411.482368469662;9426.198773104226;2732.6720793504905;2733.8633068346503;2796.804223704321;2808.606795048695;2821.901233456819;950.8858936927475;981.9754506137403;986.8273052215977;991.2466525440573;1001.1040119093516;20012.69980950287;20238.34434380581;20584.897075514527;20964.266250681154;21068.367948961557;1039.1686650679426;1047.2355180718118;1062.0176336888348;1063.7181146996052;1069.561479793281;11162.944185279022;11510.366929818772;11519.25124866881;11569.537218511165;11612.89677480638;511075;513422;514337;515648;520086;119379;121892.39053804675;123236;123562;124346;1196.7829053583725;1225.4975460061332;1242.3353505874495;1246.0343233993729;1251.4368534159664;17629.20668569892;17641;17861.106944652976;18002.099895004936;18188.36340728121;56737.43262567487;57245.14132287935;57402;57427.42572574221;59017.11474327803;71139.28860711533;71570.28429715637;73525.26474735184;76545.23454765382;76672.23327766651;12387.75224495523;12882.742345153232;14589.708205835612;15196.392144314104;15300.846991530387;17452.912735436243;19171.61656766829;19341.903290483457;23798.286051418487;24109.276721698378;18115.094245287946;18672.253109875997;18707.158177881756;18776.53058673544;18785.812141878952;16593.50219493417;16595.004299742053;16741.91629041847;17176.22706978214;17447.38934137299;18411.907940460213;18998.620027599645;19216.807831921502;19377.128029239;19434.12546435442;14889.702205956037;15013.399464021317;15126.773098403313;15142;15161.620959476102;18443.72334414958;18535.0732463379;18543.258269669062;18844.52888677794;18852 15:07:14 INFO - PID 5481 | |3;mootools.html;1321.108251929947;1361.9250941198236;1382.3502953611803;1390.617580165455;1398.986010139899;13367.866321336796;14022.789658155136;14060.718785624282;14077.225752583616;14191.92904035481;14066.859331406682;14309.713805723879;14313.856861431383;14327.92836035821;14339.283035848219;2597.2727636261784;2692.569188929772;2730.7405796449307;2757;2757.214193954723;2744.5059889219933;2781.860906954654;2784.916452506428;2785.3036740814796;2785.387214812738;2682.8926842926257;2692.623032775413;2700.7704345130687;2703.7566619004288;2757.310672331917;2573.562494375961;2596.8961241550314;2636.762691357787;2695.0432596428377;2701.770349520293;2578.961315580249;2604.518164139621;2607.9869600652064;2614.333344997033;2616.4505453854713;13314.201147931155;13605.31973401326;13607;13608.795868061987;13622.046456748032;7279.563226206445;7606.619669016527;7623.733169339046;7665.3101220890385;7672.884906726404;4959.528844759742;5096.872578185575;5184;5266.789328426858;5288.709120998344;1785.1520527749344;1813.3743858368841;1817.4184261036473;1847.1410793980729;1850.8334249917573;22479.21322753696;22848.200312988967;22962.081516739312;23049.88475057614;23051.53896922052;6857.417119544794;7016.122984626922;7017.3684368407085;7176.7488137914925;7225.458090643223;18017.369392071214;18058;18069.819301807078;18072;18082.276708931757;7587.848243035109;7821.960890195513;7890;7893;7894.64474098667;5890.4698577128265;5910.556708246899;6309.905351419732;6977.511574189758;7216.8917466238045;5502.312210973629;5561.888762224733;5651.26533550644;5745.425457454221;5751.511121554715;1733.263363070715;1745.6072383713563;1755.7884910447806;1765.6556971390455;1770.504258807536;908.3823000359687;934.5233930695258;936.4942930817282;936.9812603747887;940.2618944128826;7239.457040721862;7335.303146201102;7353.301436363537;7379;7400.629968501554;728.8360118973295;729.4091785653637;983.3608154699502;1020.4999550220487;1020.7856350166549;4997.475265097112;5061.164907790173;5147.974260128675;5209.661372010807;5232.319798426256;18989.430317090508;19242.71135932962;19578.21687132499;19816.306429274908;19847.900760496104;17876.28494860217;19138.138783754763;19399.8060019398;19447.611047778966;19526.414207573795;10555.947220264003;10683.358998460117;10774.461276936121;10796.406197659204;10820.296680715728;7880.960595196987;8037.156098609796;8112.10766815638;8208.671653134046;8310.376721745772;16465.83534164691;16602.16989150562;16776.832231678014;16899.7465038027;17022.233999469805;16137.67724645524;17235.310587576358;17439.215235314186;17650.64698705993;17691.203895824976;11501.252418592765;11502.079833613458;11780.882191178322;12048.638540843789;12054.819177712166;13430.798538022133;13546.729065418833;13557.796633050315;13570.38933248026;13613.79579306331;10892.509837057192;10909.454527273763;10984.615538456115;11162.330260184415;11422;10068.748281293027;10329.328593641389;10373.636922707668;10385.84421233667;10702.73243168927;9115.498647574446;9292.907070929205;9363.719088427359;9368.344215905094;9375.296852736208;7138;7220.169680486812;7263.418926485762;7275.963620181865;7293.416526677959;7118.537295075804;7126.251743566851;7139.571625702474;7152.356287934111;7269.382102521345 15:07:14 INFO - PID 5481 | |4;prototype.html;503.8639567316823;512.4875124875125;523.520978304851;532.4515748778759;535.6464733276036;6232.127502149697;6255.530835187356;6283.246010478738;6287.214098237726;6331.303556608775;5922.407759224076;6025.770464927972;6095.329513753483;6110.69446527673;6131.417515336036;4824.662273640846;4907.705537667734;4924.384451943507;4926.704397736129;4942.876428089308;4930.827421040264;4961.826336078238;4979.705276628067;5004.499550045003;5009.647395203293;5120.820771273006;5122.180451127821;5126.7436628168625;5142.357205349332;5196.818111366103;5220.269162317279;5228.816991405301;5233.921491177635;5238.161894096965;5267.1309233976735;4867.610591152735;4898.657094003421;4902.730349830758;4912.263160525914;4913.926291105637;6111.480524155452;6136.447719705248;6137;6182.258129024501;6187.54592670722;6040.728167232485;6106.511479081707;6107.4808641265545;6125.448709616111;6140.201773769426;6492.285848556655;6551.639659818708;6554.705038273241;6636.93363066368;6638.137042184533;5335.1730481775385;5342.599305052097;5356.598255130881;5361.927614477081;5365.490278423544;6932.6533673316635;6963.16442026955;6990.440764738809;7036.929630703678;7064.1876184238445;5509.06102136974;5509.338879334426;5514.6691198528215;5519.116941289455;5537.58468114893;5577.107662774018;5604.047311956977;5621.15682647598;5626.381098079208;5662.716864156776;6015.187949626832;6035.758569657164;6063.302720187146;6074;6098.1157732128595;6590.946567860731;6620.337966203341;6621.635810030398;6623.9006414903815;6645.700943457459;1831.413947536802;1897.8197071278207;1925.1529327096032;1948.2888745608034;1989.3236299658186;1436.4988586926686;1453.1644304524941;1476.933537990793;1482.2514630111725;1492.2837038221714;5728.255326807488;5797.739101740432;5806.709664516842;5806.780576079071;5828.679422631796;6663.13379260693;6714.3957043866285;6744.460443164535;6821.420179284717;6863.245043045261;5883.264591926009;5894.6757928314355;5894.823155305347;5898.085796701518;5903.937291287523;3599.784012959231;3628.510151129564;3633.8909832705062;3636.78179309237;3638.108183744438;6618.271990081087;6626.7017984190825;6630.336966303427;6649.567778094409;6676.899846502306;6881.483888708367;6910.7581234656545;6916.3429474199875;6992.230854605989;6994.720211191496;6579.47364210862;6590.9670451647435;6615.140031795932;6634.601923884582;6686;6703.731850725916;6731.495137864582;6769.255381908085;6773.6951837168435;6779.796606101825;6668.099806526056;6669.03192600402;6680.298568650222;6707;6719.496037797087;6543.934560654333;6551.705173267119;6590.90113648286;6640.580101247958;6653.534252602465;4982.20284754452;5013.674111182761;5015.3730783652045;5033.798648054183;5059.924101138559;6731.293214212437;6732.495062870206;6748.223954245128;6782.898256526255;6806;6120.846978825565;6211.689415529115;6462.386073323027;6488.286288508355;6539.803805885831;6390.233172019387;6436.871262574628;6449.419552240133;6492.707828147651;6542.985837195242;6333.556651034383;6340.302566717565;6374.203224596926;6394.26465956421;6439.388258115471;6295.433410993032;6488.383603557654;6527.836804079936;6568.47452203813;6594.439472644687;6249.25008998923;6255.31191568918;6301.180846489927;6356.332585078685;6385.169927909528 15:07:14 INFO - PID 5481 | |5;yui.html;906.8095699903024;916.0793402630358;924.6717415317567;926.1571969507747;932.4032619123758;18023.909880450596;19136;19180.136893839775;19196.712049319252;22095.66856497154;19855.5036124097;21221.893890530566;21533.78466215341;21580;21590.89204553975;982.2633025231058;985.6747273399761;990.6681261777277;994.5623925472769;994.8855881573639;995.0894931138037;995.3281534963907;996.3922007575374;997.276974193711;997.8353571660667;1044.3681572648552;1044.5195210203315;1050.7950949564838;1051.5425789781432;1051.5636011055403;1039.4750650921237;1039.8024375368693;1039.8908114647966;1040.0847254416142;1047.1361127070159;769.4306213402042;772.2740623813597;773.2460850670608;776.2509178642581;777.1257335497565;18848.62302753951;19304.90347548267;19555.315563955337;19611.705824412646;19670.311539096063;21270.574588508298;21277.787222127736;21315.893420532953;21403.892980535154;21868.89065554662;15649.061056336543;15845.60385990348;15871.20643967797;16901.15494225296;17435.389761358292;3683.778973261613;3694.0949467380397;3714.1086139326635;3727.0868637183794;3728.459373390843;118971.40514297373;122053;126459.36770316181;128855.35572322078;132396.3380183093;16690.749638755427;17874.374396896048;17986;18022.5494362642;18160.001199933868;30377;30540.23649408738;31154.221144471117;31602.683973160434;31707.682923170934;7711.807204819925;8038;8650.78373040679;8680.739577812676;8707.695230666895;3648.835802388899;4122.773247471418;4298.118885628439;4320.827166913288;4338.023944612437;5194.6104042196985;5262.315898933114;5276.657017293864;5289.338832645919;5848.61983971049;1126.8197088465806;1141.3095077478006;1164.5225457562358;1167.4629670351733;1168.6435637130758;661.351875162334;676.4216594811463;676.5331920974512;683.0573808144828;690.7202582953912;11859.525618975316;12391.256524608552;12693.809592856114;12729.618111456672;12928.353582320846;696.3732640623379;704.915410150775;706.9328413800783;715.0561259137888;717.5694583250008;5653.858653533694;5683.976884160891;5711.514521265656;5814.854628634233;5866.970665146732;102656;102888;103782;104122;106853;90468.5476572613;93067;93930.53034734783;98334.50832745933;98697;78784.60607696924;80923;83548;83683;83867;12356.25862448256;12384.195027323196;12484.812727808909;12593.559225427067;12620.32511422789;33579.66420335863;34458.655413445544;34833.65166348304;34845.825770870986;35617.64382356143;44815;44964.77517612391;45212.321815173455;45631.31553026773;45783;17666.381676641256;18076.819231807513;18301.816981830012;18464.26142954267;18540.81459185391;19079.236830526625;20789.272375466786;21273.893630531747;21325.786742133;21343.35969920905;19296.807031930064;19601.313954012112;19736.90131549333;19746.70379944331;19891.502712432306;19070.33253836109;19598.510037249183;19651.347068146188;19696.606067878274;19737.80262197417;16820.158992050594;17611.64776704433;18004.279828806702;18237.81762182361;18261.08694565293;9116.27069834425;9645.469499177612;9660.71017869465;9706.126448619658;9935.304528683211;14331.278544510636;14770.926145369205;14937.402503899722;15121.773173402627;15265.923670381577 15:07:14 INFO - PID 5481 | __end_tp_report 15:07:14 INFO - PID 5481 | __start_cc_report 15:07:14 INFO - PID 5481 | _x_x_mozilla_cycle_collect,347 15:07:14 INFO - PID 5481 | __end_cc_report 15:07:14 INFO - PID 5481 | __startTimestamp1502230034122__endTimestamp 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | ------- Summary: start ------- 15:07:14 INFO - PID 5481 | Number of tests: 6 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | [#0] dojo.html Cycles:165 Average:6158.61 Median:6393.33 stddev:726.59 (11.4%) stddev-sans-first:688.79 15:07:14 INFO - PID 5481 | Values: 3126.8 3165.2 3177.4 3187.6 3194.6 6092.3 6182.2 6188.1 6207.8 6221.0 6198.5 6208.4 6216.3 6242.4 6272.6 5677.6 5720.3 5726.1 5766.9 5811.9 5731.8 5826.5 5841.5 5845.4 5857.0 5714.2 5749.8 5800.8 5840.8 5857.2 5597.9 5669.3 5670.2 5675.8 5762.1 5594.3 5639.6 5650.5 5656.4 5679.1 6045.6 6058.4 6065.6 6082.6 6098.6 6573.9 6578.3 6585.0 6606.5 6624.0 6655.3 6656.7 6659.3 6662.1 6674.4 5470.4 6097.1 6156.7 6157.5 6162.0 6847.5 6859.6 6935.1 6949.1 6956.8 6461.4 6554.0 6555.5 6626.1 6649.7 6592.7 6628.3 6725.9 6733.3 6734.7 6627.8 6684.2 6701.6 6703.5 6712.9 6546.2 6704.5 6709.6 6719.0 6749.7 5395.5 5402.9 5418.5 5430.4 5439.1 4580.0 4654.5 4657.8 4676.9 4677.5 5731.1 5806.6 5852.6 5879.0 5895.7 6703.2 6707.1 6743.9 6744.1 6746.4 5812.4 5848.3 5865.1 5900.7 5914.4 5916.1 5918.2 5960.3 5979.7 5992.6 6393.3 6573.4 6654.2 6661.4 6672.8 6700.0 6701.1 6744.4 6773.4 6778.2 6539.5 6541.9 6578.1 6627.9 6628.9 6619.3 6645.1 6647.3 6658.2 6666.5 6742.0 6776.5 6817.7 6838.1 6853.7 6380.9 6538.4 6558.2 6620.9 6640.6 6521.1 6542.1 6542.7 6558.0 6560.4 6461.0 6473.1 6474.0 6475.6 6479.6 5983.5 6503.3 6523.8 6541.5 6545.2 6281.0 6318.5 6323.3 6326.2 6330.7 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | [#1] ext.html Cycles:180 Average:39535.77 Median:3599.55 stddev:58763.92 (1632.5%) stddev-sans-first:58856.64 15:07:14 INFO - PID 5481 | Values: 759.6 817.6 851.8 872.9 875.4 39970.0 40286.6 40291.6 40400.4 40449.4 36376.0 36437.3 36488.8 36725.8 36784.3 6726.7 6906.4 6907.9 6929.9 6935.7 6816.1 6849.1 6935.7 6939.5 6941.8 6871.0 7095.2 7394.1 7712.3 7763.7 7689.2 7767.0 7769.1 7772.6 7775.9 6999.1 7479.4 7544.1 7582.3 7685.9 37205.4 37845.6 37851.8 37913.2 38039.2 3552.8 3581.8 3598.7 3600.4 3616.4 30104.8 30421.8 30597.8 30614.4 30683.5 5004.2 5025.4 5027.5 5031.7 5087.9 194541.0 230110.0 234148.0 234803.0 235179.8 47919.5 47965.0 48047.8 48074.0 48151.0 50657.7 51127.5 51635.5 52645.5 53403.7 16209.3 16308.7 16327.6 16338.3 16361.8 13144.7 13256.3 13275.3 13277.6 13278.5 14226.8 14242.9 14262.8 14306.0 14454.9 5868.0 5964.4 5964.7 5980.4 6048.3 1016.0 1019.1 1037.5 1043.1 1044.2 23804.6 23860.8 23997.2 24125.4 31102.5 1101.2 1103.3 1105.2 1119.3 1128.7 12354.0 12891.5 13021.6 13072.3 13136.5 237276.0 238969.0 239759.0 239893.0 240545.0 51501.7 51997.7 52079.5 53168.5 57282.7 1494.5 1516.9 1518.4 1535.7 1537.6 28094.1 28251.6 28498.1 28813.4 29272.4 38211.4 38492.8 38518.2 38585.0 38587.2 212690.0 213569.0 213850.0 213883.0 213904.0 36818.6 37194.4 37303.0 37389.4 37407.6 42884.0 43146.8 43532.0 43544.0 44031.0 32253.8 32462.7 32699.7 32749.3 33434.8 31396.0 31919.4 32599.2 32739.5 32789.0 35357.1 35358.1 35645.8 38229.6 39202.6 34028.5 34201.8 34400.8 34643.3 34839.7 23731.5 24496.8 25290.4 25444.9 25805.2 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | [#2] jquery.html Cycles:180 Average:35916.24 Median:12372.28 stddev:86731.99 (701.0%) stddev-sans-first:86934.70 15:07:14 INFO - PID 5481 | Values: 573.4 582.6 582.7 598.4 609.7 21916.9 22428.3 23298.4 23329.8 23342.8 26032.5 26579.2 26579.9 26602.3 26652.0 6397.8 6525.2 6533.0 6533.6 6561.3 6108.6 6403.0 6442.8 6513.8 6522.5 6381.1 6386.1 6393.1 6402.6 6411.4 6380.7 6389.6 6391.4 6395.3 6396.6 5857.8 5952.3 5953.0 5960.5 5982.7 29587.9 30114.7 31046.5 31058.5 31180.4 1875.7 1934.9 1935.0 1935.9 1939.8 18553.9 19308.8 19315.1 19334.5 19370.9 2316.2 2382.9 2388.7 2390.2 2489.5 137463.6 141498.0 141620.0 142273.0 142374.3 14215.8 15083.9 15192.7 15256.2 15610.8 23635.2 23660.9 23682.9 23723.0 23786.3 10261.4 10449.6 10525.6 10597.1 10675.8 9714.6 9759.7 9793.0 9859.1 9893.7 8647.0 9278.6 9296.1 9411.5 9426.2 2732.7 2733.9 2796.8 2808.6 2821.9 950.9 982.0 986.8 991.2 1001.1 20012.7 20238.3 20584.9 20964.3 21068.4 1039.2 1047.2 1062.0 1063.7 1069.6 11162.9 11510.4 11519.3 11569.5 11612.9 511075.0 513422.0 514337.0 515648.0 520086.0 119379.0 121892.4 123236.0 123562.0 124346.0 1196.8 1225.5 1242.3 1246.0 1251.4 17629.2 17641.0 17861.1 18002.1 18188.4 56737.4 57245.1 57402.0 57427.4 59017.1 71139.3 71570.3 73525.3 76545.2 76672.2 12387.8 12882.7 14589.7 15196.4 15300.8 17452.9 19171.6 19341.9 23798.3 24109.3 18115.1 18672.3 18707.2 18776.5 18785.8 16593.5 16595.0 16741.9 17176.2 17447.4 18411.9 18998.6 19216.8 19377.1 19434.1 14889.7 15013.4 15126.8 15142.0 15161.6 18443.7 18535.1 18543.3 18844.5 18852.0 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | [#3] mootools.html Cycles:180 Average:8804.44 Median:2600.90 stddev:5984.16 (230.1%) stddev-sans-first:5974.53 15:07:14 INFO - PID 5481 | Values: 1321.1 1361.9 1382.4 1390.6 1399.0 13367.9 14022.8 14060.7 14077.2 14191.9 14066.9 14309.7 14313.9 14327.9 14339.3 2597.3 2692.6 2730.7 2757.0 2757.2 2744.5 2781.9 2784.9 2785.3 2785.4 2682.9 2692.6 2700.8 2703.8 2757.3 2573.6 2596.9 2636.8 2695.0 2701.8 2579.0 2604.5 2608.0 2614.3 2616.5 13314.2 13605.3 13607.0 13608.8 13622.0 7279.6 7606.6 7623.7 7665.3 7672.9 4959.5 5096.9 5184.0 5266.8 5288.7 1785.2 1813.4 1817.4 1847.1 1850.8 22479.2 22848.2 22962.1 23049.9 23051.5 6857.4 7016.1 7017.4 7176.7 7225.5 18017.4 18058.0 18069.8 18072.0 18082.3 7587.8 7822.0 7890.0 7893.0 7894.6 5890.5 5910.6 6309.9 6977.5 7216.9 5502.3 5561.9 5651.3 5745.4 5751.5 1733.3 1745.6 1755.8 1765.7 1770.5 908.4 934.5 936.5 937.0 940.3 7239.5 7335.3 7353.3 7379.0 7400.6 728.8 729.4 983.4 1020.5 1020.8 4997.5 5061.2 5148.0 5209.7 5232.3 18989.4 19242.7 19578.2 19816.3 19847.9 17876.3 19138.1 19399.8 19447.6 19526.4 10555.9 10683.4 10774.5 10796.4 10820.3 7881.0 8037.2 8112.1 8208.7 8310.4 16465.8 16602.2 16776.8 16899.7 17022.2 16137.7 17235.3 17439.2 17650.6 17691.2 11501.3 11502.1 11780.9 12048.6 12054.8 13430.8 13546.7 13557.8 13570.4 13613.8 10892.5 10909.5 10984.6 11162.3 11422.0 10068.7 10329.3 10373.6 10385.8 10702.7 9115.5 9292.9 9363.7 9368.3 9375.3 7138.0 7220.2 7263.4 7276.0 7293.4 7118.5 7126.3 7139.6 7152.4 7269.4 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | [#4] prototype.html Cycles:180 Average:5625.04 Median:6133.93 stddev:1507.27 (24.6%) stddev-sans-first:1461.67 15:07:14 INFO - PID 5481 | Values: 503.9 512.5 523.5 532.5 535.6 6232.1 6255.5 6283.2 6287.2 6331.3 5922.4 6025.8 6095.3 6110.7 6131.4 4824.7 4907.7 4924.4 4926.7 4942.9 4930.8 4961.8 4979.7 5004.5 5009.6 5120.8 5122.2 5126.7 5142.4 5196.8 5220.3 5228.8 5233.9 5238.2 5267.1 4867.6 4898.7 4902.7 4912.3 4913.9 6111.5 6136.4 6137.0 6182.3 6187.5 6040.7 6106.5 6107.5 6125.4 6140.2 6492.3 6551.6 6554.7 6636.9 6638.1 5335.2 5342.6 5356.6 5361.9 5365.5 6932.7 6963.2 6990.4 7036.9 7064.2 5509.1 5509.3 5514.7 5519.1 5537.6 5577.1 5604.0 5621.2 5626.4 5662.7 6015.2 6035.8 6063.3 6074.0 6098.1 6590.9 6620.3 6621.6 6623.9 6645.7 1831.4 1897.8 1925.2 1948.3 1989.3 1436.5 1453.2 1476.9 1482.3 1492.3 5728.3 5797.7 5806.7 5806.8 5828.7 6663.1 6714.4 6744.5 6821.4 6863.2 5883.3 5894.7 5894.8 5898.1 5903.9 3599.8 3628.5 3633.9 3636.8 3638.1 6618.3 6626.7 6630.3 6649.6 6676.9 6881.5 6910.8 6916.3 6992.2 6994.7 6579.5 6591.0 6615.1 6634.6 6686.0 6703.7 6731.5 6769.3 6773.7 6779.8 6668.1 6669.0 6680.3 6707.0 6719.5 6543.9 6551.7 6590.9 6640.6 6653.5 4982.2 5013.7 5015.4 5033.8 5059.9 6731.3 6732.5 6748.2 6782.9 6806.0 6120.8 6211.7 6462.4 6488.3 6539.8 6390.2 6436.9 6449.4 6492.7 6543.0 6333.6 6340.3 6374.2 6394.3 6439.4 6295.4 6488.4 6527.8 6568.5 6594.4 6249.3 6255.3 6301.2 6356.3 6385.2 15:07:14 INFO - PID 5481 | 15:07:14 INFO - PID 5481 | [#5] yui.html Cycles:180 Average:22627.88 Median:21556.89 stddev:30415.46 (141.1%) stddev-sans-first:30457.05 15:07:14 INFO - PID 5481 | Values: 906.8 916.1 924.7 926.2 932.4 18023.9 19136.0 19180.1 19196.7 22095.7 19855.5 21221.9 21533.8 21580.0 21590.9 982.3 985.7 990.7 994.6 994.9 995.1 995.3 996.4 997.3 997.8 1044.4 1044.5 1050.8 1051.5 1051.6 1039.5 1039.8 1039.9 1040.1 1047.1 769.4 772.3 773.2 776.3 777.1 18848.6 19304.9 19555.3 19611.7 19670.3 21270.6 21277.8 21315.9 21403.9 21868.9 15649.1 15845.6 15871.2 16901.2 17435.4 3683.8 3694.1 3714.1 3727.1 3728.5 118971.4 122053.0 126459.4 128855.4 132396.3 16690.7 17874.4 17986.0 18022.5 18160.0 30377.0 30540.2 31154.2 31602.7 31707.7 7711.8 8038.0 8650.8 8680.7 8707.7 3648.8 4122.8 4298.1 4320.8 4338.0 5194.6 5262.3 5276.7 5289.3 5848.6 1126.8 1141.3 1164.5 1167.5 1168.6 661.4 676.4 676.5 683.1 690.7 11859.5 12391.3 12693.8 12729.6 12928.4 696.4 704.9 706.9 715.1 717.6 5653.9 5684.0 5711.5 5814.9 5867.0 102656.0 102888.0 103782.0 104122.0 106853.0 90468.5 93067.0 93930.5 98334.5 98697.0 78784.6 80923.0 83548.0 83683.0 83867.0 12356.3 12384.2 12484.8 12593.6 12620.3 33579.7 34458.7 34833.7 34845.8 35617.6 44815.0 44964.8 45212.3 45631.3 45783.0 17666.4 18076.8 18301.8 18464.3 18540.8 19079.2 20789.3 21273.9 21325.8 21343.4 19296.8 19601.3 19736.9 19746.7 19891.5 19070.3 19598.5 19651.3 19696.6 19737.8 16820.2 17611.6 18004.3 18237.8 18261.1 9116.3 9645.5 9660.7 9706.1 9935.3 14331.3 14770.9 14937.4 15121.8 15265.9 15:07:14 INFO - PID 5481 | -------- Summary: end -------- 15:07:14 INFO - PID 5481 | 15:07:14 INFO - TEST-INFO | 5481: exit 0 15:07:14 INFO - TEST-OK | dromaeo_css | took 1113552ms 15:07:14 INFO - TEST-START | kraken 15:07:14 INFO - Initialising browser for kraken test... 15:07:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34516/getInfo.html -profile /tmp/tmpYBoqeP/profile 15:07:14 INFO - TEST-INFO | started process 5851 (/builds/slave/test/build/application/firefox/firefox http://localhost:34516/getInfo.html) 15:07:20 INFO - TEST-INFO | 5851: exit 0 15:07:20 INFO - Browser initialized. 15:07:20 INFO - Running cycle 1/1 for kraken test... 15:07:20 INFO - TEST-INFO | started process 6084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYBoqeP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:21 INFO - PID 6084 | 15:07:21 INFO - PID 6084 | (/builds/slave/test/build/application/firefox/firefox:6139): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:07:21 INFO - PID 6084 | 15:07:31 INFO - PID 6084 | RSS: Main: 170557440 15:07:31 INFO - PID 6084 | 15:07:34 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34516/tests/kraken/driver.html?testName=audio-beat-detection) 15:07:35 INFO - PID 6084 | RSS: Main: 174923776 15:07:35 INFO - PID 6084 | 15:07:38 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34516/tests/kraken/driver.html?testName=audio-dft) 15:07:38 INFO - PID 6084 | RSS: Main: 175894528 15:07:38 INFO - PID 6084 | 15:07:42 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34516/tests/kraken/driver.html?testName=audio-fft) 15:07:42 INFO - PID 6084 | RSS: Main: 170766336 15:07:42 INFO - PID 6084 | 15:07:44 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34516/tests/kraken/driver.html?testName=audio-oscillator) 15:07:45 INFO - PID 6084 | RSS: Main: 170643456 15:07:45 INFO - PID 6084 | 15:07:47 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:48 INFO - PID 6084 | RSS: Main: 171319296 15:07:48 INFO - PID 6084 | 15:07:51 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34516/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:52 INFO - PID 6084 | RSS: Main: 173670400 15:07:52 INFO - PID 6084 | 15:07:55 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34516/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:56 INFO - PID 6084 | RSS: Main: 173547520 15:07:56 INFO - PID 6084 | 15:07:59 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34516/tests/kraken/driver.html?testName=json-parse-financial) 15:07:59 INFO - PID 6084 | RSS: Main: 174551040 15:07:59 INFO - PID 6084 | 15:08:01 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:02 INFO - PID 6084 | RSS: Main: 174182400 15:08:02 INFO - PID 6084 | 15:08:04 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:04 INFO - PID 6084 | RSS: Main: 174354432 15:08:04 INFO - PID 6084 | 15:08:06 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:07 INFO - PID 6084 | RSS: Main: 174231552 15:08:07 INFO - PID 6084 | 15:08:10 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:11 INFO - PID 6084 | RSS: Main: 174759936 15:08:11 INFO - PID 6084 | 15:08:14 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:14 INFO - PID 6084 | RSS: Main: 174452736 15:08:14 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | Cycle 1(1): loaded http://localhost:34516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34516/tests/kraken/driver.html?testName=ai-astar) 15:08:16 INFO - PID 6084 | RSS: Main: 176209920 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | __start_tp_report 15:08:16 INFO - PID 6084 | _x_x_mozilla_page_load 15:08:16 INFO - PID 6084 | _x_x_mozilla_page_load_details 15:08:16 INFO - PID 6084 | |i|pagename|runs| 15:08:16 INFO - PID 6084 | |0;ai-astar;97;112;106;107;111;110;108;101;113;109 15:08:16 INFO - PID 6084 | |1;audio-beat-detection;154;123;146;174;117;164;147;124;177;126 15:08:16 INFO - PID 6084 | |2;audio-dft;164;163;165;165;168;170;177;163;162;165 15:08:16 INFO - PID 6084 | |3;audio-fft;75;75;74;186;81;74;75;74;153;75 15:08:16 INFO - PID 6084 | |4;audio-oscillator;80;79;133;79;79;79;129;79;77;130 15:08:16 INFO - PID 6084 | |5;imaging-gaussian-blur;114;116;118;114;114;121;114;115;119;115 15:08:16 INFO - PID 6084 | |6;imaging-darkroom;151;151;158;157;151;150;150;149;156;153 15:08:16 INFO - PID 6084 | |7;imaging-desaturate;94;95;95;94;99;94;94;101;94;99 15:08:16 INFO - PID 6084 | |8;json-parse-financial;54;54;54;59;54;54;54;56;53;63 15:08:16 INFO - PID 6084 | |9;json-stringify-tinderbox;54;54;54;54;54;54;63;56;54;61 15:08:16 INFO - PID 6084 | |10;stanford-crypto-aes;89;78;77;94;78;89;79;88;92;87 15:08:16 INFO - PID 6084 | |11;stanford-crypto-ccm;133;129;125;138;127;130;130;136;130;170 15:08:16 INFO - PID 6084 | |12;stanford-crypto-pbkdf2;179;173;181;174;179;188;174;177;181;183 15:08:16 INFO - PID 6084 | |13;stanford-crypto-sha256-iterative;80;67;66;69;65;71;68;68;72;66 15:08:16 INFO - PID 6084 | __end_tp_report 15:08:16 INFO - PID 6084 | __start_cc_report 15:08:16 INFO - PID 6084 | _x_x_mozilla_cycle_collect,963 15:08:16 INFO - PID 6084 | __end_cc_report 15:08:16 INFO - PID 6084 | __startTimestamp1502230096927__endTimestamp 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | ------- Summary: start ------- 15:08:16 INFO - PID 6084 | Number of tests: 14 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.50 stddev:5.02 (4.5%) stddev-sans-first:3.64 15:08:16 INFO - PID 6084 | Values: 97.0 112.0 106.0 107.0 111.0 110.0 108.0 101.0 113.0 109.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:150.50 stddev:22.06 (14.7%) stddev-sans-first:23.17 15:08:16 INFO - PID 6084 | Values: 154.0 123.0 146.0 174.0 117.0 164.0 147.0 124.0 177.0 126.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:4.49 (2.7%) stddev-sans-first:4.69 15:08:16 INFO - PID 6084 | Values: 164.0 163.0 165.0 165.0 168.0 170.0 177.0 163.0 162.0 165.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:40.49 (54.0%) stddev-sans-first:42.35 15:08:16 INFO - PID 6084 | Values: 75.0 75.0 74.0 186.0 81.0 74.0 75.0 74.0 153.0 75.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:25.06 (31.7%) stddev-sans-first:26.03 15:08:16 INFO - PID 6084 | Values: 80.0 79.0 133.0 79.0 79.0 79.0 129.0 79.0 77.0 130.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:115.50 stddev:2.49 (2.2%) stddev-sans-first:2.54 15:08:16 INFO - PID 6084 | Values: 114.0 116.0 118.0 114.0 114.0 121.0 114.0 115.0 119.0 115.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#6] imaging-darkroom Cycles:10 Average:152.60 Median:152.00 stddev:3.24 (2.1%) stddev-sans-first:3.38 15:08:16 INFO - PID 6084 | Values: 151.0 151.0 158.0 157.0 151.0 150.0 150.0 149.0 156.0 153.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:94.50 stddev:2.69 (2.8%) stddev-sans-first:2.76 15:08:16 INFO - PID 6084 | Values: 94.0 95.0 95.0 94.0 99.0 94.0 94.0 101.0 94.0 99.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:3.14 (5.8%) stddev-sans-first:3.28 15:08:16 INFO - PID 6084 | Values: 54.0 54.0 54.0 59.0 54.0 54.0 54.0 56.0 53.0 63.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:54.00 stddev:3.36 (6.2%) stddev-sans-first:3.50 15:08:16 INFO - PID 6084 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 63.0 56.0 54.0 61.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:88.50 stddev:6.44 (7.3%) stddev-sans-first:6.67 15:08:16 INFO - PID 6084 | Values: 89.0 78.0 77.0 94.0 78.0 89.0 79.0 88.0 92.0 87.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:131.50 stddev:12.97 (9.9%) stddev-sans-first:13.74 15:08:16 INFO - PID 6084 | Values: 133.0 129.0 125.0 138.0 127.0 130.0 130.0 136.0 130.0 170.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:180.00 stddev:4.65 (2.6%) stddev-sans-first:4.94 15:08:16 INFO - PID 6084 | Values: 179.0 173.0 181.0 174.0 179.0 188.0 174.0 177.0 181.0 183.0 15:08:16 INFO - PID 6084 | 15:08:16 INFO - PID 6084 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:4.39 (6.4%) stddev-sans-first:2.35 15:08:16 INFO - PID 6084 | Values: 80.0 67.0 66.0 69.0 65.0 71.0 68.0 68.0 72.0 66.0 15:08:16 INFO - PID 6084 | -------- Summary: end -------- 15:08:16 INFO - PID 6084 | 15:08:17 INFO - PID 6084 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:08:17 INFO - TEST-INFO | 6084: exit 0 15:08:17 INFO - TEST-OK | kraken | took 62879ms 15:08:17 INFO - SUITE-END | took 1176s 15:08:18 INFO - Completed test suite (00:19:36) 15:08:18 INFO - javascript benchmark 15:08:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8544.113922851213, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.8436578171086, 3165.2245199926024, 3177.3962947040045, 3187.6174859016905, 3194.632617249016, 6092.329843717188, 6182.165407669963, 6188.102725104857, 6207.813765587034, 6221.0, 6198.504119670427, 6208.379162083801, 6216.285127210373, 6242.375762423755, 6272.623642581449, 5677.602567820244, 5720.3135623725, 5726.083826587746, 5766.942330576703, 5811.912821307684, 5731.770729170828, 5826.475617194473, 5841.532677385799, 5845.444682755153, 5857.004309267413, 5714.171445140431, 5749.770009199648, 5800.796972105956, 5840.795572154975, 5857.238558987326, 5597.944020559783, 5669.26299581056, 5670.177824215466, 5675.772969081232, 5762.07806750922, 5594.328680558359, 5639.605227634067, 5650.463205995465, 5656.4060773618585, 5679.148127780824, 6045.576809623328, 6058.4244496772735, 6065.636061836304, 6082.60463069899, 6098.634081955097, 6573.93426065738, 6578.3092775258865, 6585.045168450596, 6606.537542372036, 6623.966880165616, 6655.267920528738, 6656.733730650768, 6659.33406659335, 6662.067310576524, 6674.399304062657, 5470.370907345667, 6097.146399504073, 6156.6613836238985, 6157.476614487774, 6162.0, 6847.486438517031, 6859.5541289816, 6935.063766391523, 6949.096617439701, 6956.826079348057, 6461.418472337512, 6554.016897465323, 6555.475561955032, 6626.072349871022, 6649.734010639617, 6592.670366481657, 6628.337166283333, 6725.932740672629, 6733.326667333227, 6734.730610775612, 6627.801165965029, 6684.1978962523835, 6701.564398314094, 6703.530752847254, 6712.865742685217, 6546.247181574085, 6704.463642908556, 6709.597424154469, 6719.025741267586, 6749.730010799513, 5395.4604539545735, 5402.945970540244, 5418.485243901823, 5430.42980487051, 5439.129739241703, 4580.0, 4654.534546545387, 4657.767111644404, 4676.859694209179, 4677.462091859412, 5731.140328950691, 5806.622569532967, 5852.619579727304, 5879.0, 5895.734691938873, 6703.229128650268, 6707.0610114584, 6743.898841517381, 6744.123263975652, 6746.426553742888, 5812.38969908162, 5848.298204215522, 5865.120231965154, 5900.675462849498, 5914.408559144051, 5916.142159386951, 5918.171455996164, 5960.284765828128, 5979.671118088547, 5992.610480318765, 6393.328700486382, 6573.408393244631, 6654.23476300222, 6661.4004739573675, 6672.799816005528, 6699.9665001674675, 6701.128853249242, 6744.426723728538, 6773.356531129535, 6778.2205046420295, 6539.509536784855, 6541.901871471837, 6578.111954886029, 6627.867442651216, 6628.867422651617, 6619.271880093283, 6645.102911106938, 6647.302033286435, 6658.167729033871, 6666.500012499179, 6742.0, 6776.457883369417, 6817.693203805741, 6838.111045564244, 6853.725850966105, 6380.9361906380345, 6538.444232240313, 6558.1802274715665, 6620.867582648417, 6640.634765087966, 6521.054447105238, 6542.051402546699, 6542.672866356758, 6557.967210163919, 6560.44236239925, 6460.967695161494, 6473.093766872547, 6473.967630161819, 6475.611463312216, 6479.611223326616, 5983.461488466059, 6503.317151699192, 6523.804285871432, 6541.509386795914, 6545.247296560957, 6280.9685951569945, 6318.526110541819, 6323.272823625342, 6326.177596912372, 6330.683465826783], "value": 6104.489059363816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.5708424740021, 817.5912043978011, 851.7700220940346, 872.8734333521637, 875.40035075973, 39969.99999999996, 40286.59713402865, 40291.59708402915, 40400.39399409004, 40449.3932591011, 36376.0, 36437.27125457496, 36488.81755591225, 36725.81637091811, 36784.26431471376, 6726.730930762776, 6906.412954898839, 6907.861842763142, 6929.896051559231, 6935.653217339138, 6816.113905192318, 6849.1096157499705, 6935.687894044755, 6939.479539034567, 6941.791746247595, 6871.0, 7095.184053833824, 7394.149672787617, 7712.267334603203, 7763.728269510569, 7689.231076892322, 7767.0, 7769.145394006627, 7772.572508512029, 7775.922240777605, 6999.055127557765, 7479.4016478682115, 7544.132424771166, 7582.317591416799, 7685.884711729329, 37205.441918371245, 37845.62154378449, 37851.810740946115, 37913.241735165415, 38039.23921521582, 3552.7513074084823, 3581.83881725323, 3598.6581274778855, 3600.4419315006216, 3616.4032934565766, 30104.8494757527, 30421.847890760404, 30597.847010764803, 30614.38771224563, 30683.539746903814, 5004.249362595603, 5025.447200807908, 5027.49725027498, 5031.6729412588065, 5087.872803179913, 194541.0, 230110.0, 234148.0, 234803.0, 235179.8241008801, 47919.520804792206, 47965.0, 48047.75976120097, 48074.0, 48151.0, 50657.74671126695, 51127.48872511302, 51635.48364516382, 52645.47354526406, 53403.73298133485, 16209.270582823801, 16308.67382652364, 16327.59181020484, 16338.346466141222, 16361.83638163603, 13144.671383215305, 13256.270905100118, 13275.336233188302, 13277.601671949857, 13278.468861245636, 14226.786598201035, 14242.928785356007, 14262.786058209134, 14306.0, 14454.927725361305, 5867.970660146672, 5964.373740757244, 5964.7315870785915, 5980.401959803985, 6048.274207095089, 1015.9898401016043, 1019.143919107938, 1037.5019990404649, 1043.118564812732, 1044.185535282481, 23804.642930356058, 23860.761392385855, 23997.160099396788, 24125.396865078514, 31102.53346199809, 1101.2126329674322, 1103.2608152537819, 1105.1987309200765, 1119.2668801934747, 1128.7065363005513, 12354.0, 12891.548795792101, 13021.609351719464, 13072.28102454355, 13136.540221092217, 237276.0, 238969.0, 239759.0, 239893.0, 240545.0, 51501.7424912873, 51997.740011300455, 52079.47920520822, 53168.46831531713, 57282.713586431804, 1494.4769330734373, 1516.8634822865774, 1518.4305885293015, 1535.669830986321, 1537.5848520899294, 28094.066830644137, 28251.57622635621, 28498.145055648365, 28813.423731525672, 29272.414551709273, 38211.42682859704, 38492.80753596214, 38518.2296354077, 38585.0, 38587.22825543417, 212690.0, 213569.0, 213850.0, 213883.0, 213904.0, 36818.63181368152, 37194.442083369315, 37303.0, 37389.439158412104, 37407.625923740416, 42884.0, 43146.784266079725, 43532.0, 43544.0, 44031.0, 32253.838730806197, 32462.675373245966, 32699.673003270615, 32749.34501309913, 33434.83282583669, 31396.0, 31919.36161276808, 32599.18502037468, 32739.508907366886, 32789.01632951015, 35357.11607209737, 35358.11604709903, 35645.82177089098, 38229.61770382261, 39202.6079739199, 34028.48957265692, 34201.82899085488, 34400.82799585986, 34643.307133857685, 34839.65160348364, 23731.525369492167, 24496.755032449448, 25290.36774080589, 25444.872775636002, 25805.225843224733], "value": 17439.990722189945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3607028163599, 582.5572564850712, 582.6562328226346, 598.3956204233724, 609.7408601344429, 21916.89041554792, 22428.32715018548, 23298.41753956152, 23329.76670233297, 23342.766572334272, 26032.47935041303, 26579.202623921265, 26579.867100664516, 26602.33494162647, 26652.0, 6397.840053998664, 6525.151730275082, 6532.967335163317, 6533.640649764261, 6561.2782593914635, 6108.602940808833, 6403.039544068381, 6442.7745028924, 6513.804585862432, 6522.543421960465, 6381.13854629626, 6386.074019267204, 6393.0730044143575, 6402.615843049409, 6411.358864113575, 6380.68096595173, 6389.584676995981, 6391.392817682313, 6395.296517383084, 6396.552241343108, 5857.76568937242, 5952.285725712899, 5953.047512397996, 5960.523158147338, 5982.700864956735, 29587.852060739773, 30114.698853011407, 31046.534301985488, 31058.53412198819, 31180.37639247225, 1875.6530041942149, 1934.8935808530525, 1934.9709754353696, 1935.8838469691864, 1939.7963213862624, 18553.907230463898, 19308.80691193098, 19315.130819113172, 19334.516637084187, 19370.903145484182, 2316.2356422380744, 2382.8808559571953, 2388.689470368858, 2390.1634427950253, 2489.5020995800733, 137463.56341091453, 141498.0, 141620.0, 142273.0, 142374.28812855974, 14215.786763198561, 15083.924580377248, 15192.696146077016, 15256.160911149771, 15610.76583851243, 23635.172768953005, 23660.881695591757, 23682.88158559196, 23723.0, 23786.286411407684, 10261.384316941007, 10449.582016719247, 10525.631602893862, 10597.099246564128, 10675.786484270271, 9714.61141554344, 9759.658411955548, 9793.0, 9859.112679858847, 9893.653722119836, 8646.956765216259, 9278.62885484573, 9296.116868897443, 9411.482368469662, 9426.198773104226, 2732.6720793504905, 2733.8633068346503, 2796.804223704321, 2808.606795048695, 2821.901233456819, 950.8858936927475, 981.9754506137403, 986.8273052215977, 991.2466525440573, 1001.1040119093516, 20012.69980950287, 20238.34434380581, 20584.897075514527, 20964.266250681154, 21068.367948961557, 1039.1686650679426, 1047.2355180718118, 1062.0176336888348, 1063.7181146996052, 1069.561479793281, 11162.944185279022, 11510.366929818772, 11519.25124866881, 11569.537218511165, 11612.89677480638, 511075.0, 513422.0, 514337.0, 515648.0, 520086.0, 119379.0, 121892.39053804675, 123236.0, 123562.0, 124346.0, 1196.7829053583725, 1225.4975460061332, 1242.3353505874495, 1246.0343233993729, 1251.4368534159664, 17629.20668569892, 17641.0, 17861.106944652976, 18002.099895004936, 18188.36340728121, 56737.43262567487, 57245.14132287935, 57402.0, 57427.42572574221, 59017.11474327803, 71139.28860711533, 71570.28429715637, 73525.26474735184, 76545.23454765382, 76672.23327766651, 12387.75224495523, 12882.742345153232, 14589.708205835612, 15196.392144314104, 15300.846991530387, 17452.912735436243, 19171.61656766829, 19341.903290483457, 23798.286051418487, 24109.276721698378, 18115.094245287946, 18672.253109875997, 18707.158177881756, 18776.53058673544, 18785.812141878952, 16593.50219493417, 16595.004299742053, 16741.91629041847, 17176.22706978214, 17447.38934137299, 18411.907940460213, 18998.620027599645, 19216.807831921502, 19377.128029239, 19434.12546435442, 14889.702205956037, 15013.399464021317, 15126.773098403313, 15142.0, 15161.620959476102, 18443.72334414958, 18535.0732463379, 18543.258269669062, 18844.52888677794, 18852.0], "value": 12090.517364806488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.108251929947, 1361.9250941198236, 1382.3502953611803, 1390.617580165455, 1398.986010139899, 13367.866321336796, 14022.789658155136, 14060.718785624282, 14077.225752583616, 14191.92904035481, 14066.859331406682, 14309.713805723879, 14313.856861431383, 14327.92836035821, 14339.283035848219, 2597.2727636261784, 2692.569188929772, 2730.7405796449307, 2757.0, 2757.214193954723, 2744.5059889219933, 2781.860906954654, 2784.916452506428, 2785.3036740814796, 2785.387214812738, 2682.8926842926257, 2692.623032775413, 2700.7704345130687, 2703.7566619004288, 2757.310672331917, 2573.562494375961, 2596.8961241550314, 2636.762691357787, 2695.0432596428377, 2701.770349520293, 2578.961315580249, 2604.518164139621, 2607.9869600652064, 2614.333344997033, 2616.4505453854713, 13314.201147931155, 13605.31973401326, 13607.0, 13608.795868061987, 13622.046456748032, 7279.563226206445, 7606.619669016527, 7623.733169339046, 7665.3101220890385, 7672.884906726404, 4959.528844759742, 5096.872578185575, 5184.0, 5266.789328426858, 5288.709120998344, 1785.1520527749344, 1813.3743858368841, 1817.4184261036473, 1847.1410793980729, 1850.8334249917573, 22479.21322753696, 22848.200312988967, 22962.081516739312, 23049.88475057614, 23051.53896922052, 6857.417119544794, 7016.122984626922, 7017.3684368407085, 7176.7488137914925, 7225.458090643223, 18017.369392071214, 18058.0, 18069.819301807078, 18072.0, 18082.276708931757, 7587.848243035109, 7821.960890195513, 7890.0, 7893.0, 7894.64474098667, 5890.4698577128265, 5910.556708246899, 6309.905351419732, 6977.511574189758, 7216.8917466238045, 5502.312210973629, 5561.888762224733, 5651.26533550644, 5745.425457454221, 5751.511121554715, 1733.263363070715, 1745.6072383713563, 1755.7884910447806, 1765.6556971390455, 1770.504258807536, 908.3823000359687, 934.5233930695258, 936.4942930817282, 936.9812603747887, 940.2618944128826, 7239.457040721862, 7335.303146201102, 7353.301436363537, 7379.0, 7400.629968501554, 728.8360118973295, 729.4091785653637, 983.3608154699502, 1020.4999550220487, 1020.7856350166549, 4997.475265097112, 5061.164907790173, 5147.974260128675, 5209.661372010807, 5232.319798426256, 18989.430317090508, 19242.71135932962, 19578.21687132499, 19816.306429274908, 19847.900760496104, 17876.28494860217, 19138.138783754763, 19399.8060019398, 19447.611047778966, 19526.414207573795, 10555.947220264003, 10683.358998460117, 10774.461276936121, 10796.406197659204, 10820.296680715728, 7880.960595196987, 8037.156098609796, 8112.10766815638, 8208.671653134046, 8310.376721745772, 16465.83534164691, 16602.16989150562, 16776.832231678014, 16899.7465038027, 17022.233999469805, 16137.67724645524, 17235.310587576358, 17439.215235314186, 17650.64698705993, 17691.203895824976, 11501.252418592765, 11502.079833613458, 11780.882191178322, 12048.638540843789, 12054.819177712166, 13430.798538022133, 13546.729065418833, 13557.796633050315, 13570.38933248026, 13613.79579306331, 10892.509837057192, 10909.454527273763, 10984.615538456115, 11162.330260184415, 11422.0, 10068.748281293027, 10329.328593641389, 10373.636922707668, 10385.84421233667, 10702.73243168927, 9115.498647574446, 9292.907070929205, 9363.719088427359, 9368.344215905094, 9375.296852736208, 7138.0, 7220.169680486812, 7263.418926485762, 7275.963620181865, 7293.416526677959, 7118.537295075804, 7126.251743566851, 7139.571625702474, 7152.356287934111, 7269.382102521345], "value": 6450.5376868685225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.8639567316823, 512.4875124875125, 523.520978304851, 532.4515748778759, 535.6464733276036, 6232.127502149697, 6255.530835187356, 6283.246010478738, 6287.214098237726, 6331.303556608775, 5922.407759224076, 6025.770464927972, 6095.329513753483, 6110.69446527673, 6131.417515336036, 4824.662273640846, 4907.705537667734, 4924.384451943507, 4926.704397736129, 4942.876428089308, 4930.827421040264, 4961.826336078238, 4979.705276628067, 5004.499550045003, 5009.647395203293, 5120.820771273006, 5122.180451127821, 5126.7436628168625, 5142.357205349332, 5196.818111366103, 5220.269162317279, 5228.816991405301, 5233.921491177635, 5238.161894096965, 5267.1309233976735, 4867.610591152735, 4898.657094003421, 4902.730349830758, 4912.263160525914, 4913.926291105637, 6111.480524155452, 6136.447719705248, 6137.0, 6182.258129024501, 6187.54592670722, 6040.728167232485, 6106.511479081707, 6107.4808641265545, 6125.448709616111, 6140.201773769426, 6492.285848556655, 6551.639659818708, 6554.705038273241, 6636.93363066368, 6638.137042184533, 5335.1730481775385, 5342.599305052097, 5356.598255130881, 5361.927614477081, 5365.490278423544, 6932.6533673316635, 6963.16442026955, 6990.440764738809, 7036.929630703678, 7064.1876184238445, 5509.06102136974, 5509.338879334426, 5514.6691198528215, 5519.116941289455, 5537.58468114893, 5577.107662774018, 5604.047311956977, 5621.15682647598, 5626.381098079208, 5662.716864156776, 6015.187949626832, 6035.758569657164, 6063.302720187146, 6074.0, 6098.1157732128595, 6590.946567860731, 6620.337966203341, 6621.635810030398, 6623.9006414903815, 6645.700943457459, 1831.413947536802, 1897.8197071278207, 1925.1529327096032, 1948.2888745608034, 1989.3236299658186, 1436.4988586926686, 1453.1644304524941, 1476.933537990793, 1482.2514630111725, 1492.2837038221714, 5728.255326807488, 5797.739101740432, 5806.709664516842, 5806.780576079071, 5828.679422631796, 6663.13379260693, 6714.3957043866285, 6744.460443164535, 6821.420179284717, 6863.245043045261, 5883.264591926009, 5894.6757928314355, 5894.823155305347, 5898.085796701518, 5903.937291287523, 3599.784012959231, 3628.510151129564, 3633.8909832705062, 3636.78179309237, 3638.108183744438, 6618.271990081087, 6626.7017984190825, 6630.336966303427, 6649.567778094409, 6676.899846502306, 6881.483888708367, 6910.7581234656545, 6916.3429474199875, 6992.230854605989, 6994.720211191496, 6579.47364210862, 6590.9670451647435, 6615.140031795932, 6634.601923884582, 6686.0, 6703.731850725916, 6731.495137864582, 6769.255381908085, 6773.6951837168435, 6779.796606101825, 6668.099806526056, 6669.03192600402, 6680.298568650222, 6707.0, 6719.496037797087, 6543.934560654333, 6551.705173267119, 6590.90113648286, 6640.580101247958, 6653.534252602465, 4982.20284754452, 5013.674111182761, 5015.3730783652045, 5033.798648054183, 5059.924101138559, 6731.293214212437, 6732.495062870206, 6748.223954245128, 6782.898256526255, 6806.0, 6120.846978825565, 6211.689415529115, 6462.386073323027, 6488.286288508355, 6539.803805885831, 6390.233172019387, 6436.871262574628, 6449.419552240133, 6492.707828147651, 6542.985837195242, 6333.556651034383, 6340.302566717565, 6374.203224596926, 6394.26465956421, 6439.388258115471, 6295.433410993032, 6488.383603557654, 6527.836804079936, 6568.47452203813, 6594.439472644687, 6249.25008998923, 6255.31191568918, 6301.180846489927, 6356.332585078685, 6385.169927909528], "value": 5194.642155373004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.8095699903024, 916.0793402630358, 924.6717415317567, 926.1571969507747, 932.4032619123758, 18023.909880450596, 19136.0, 19180.136893839775, 19196.712049319252, 22095.66856497154, 19855.5036124097, 21221.893890530566, 21533.78466215341, 21580.0, 21590.89204553975, 982.2633025231058, 985.6747273399761, 990.6681261777277, 994.5623925472769, 994.8855881573639, 995.0894931138037, 995.3281534963907, 996.3922007575374, 997.276974193711, 997.8353571660667, 1044.3681572648552, 1044.5195210203315, 1050.7950949564838, 1051.5425789781432, 1051.5636011055403, 1039.4750650921237, 1039.8024375368693, 1039.8908114647966, 1040.0847254416142, 1047.1361127070159, 769.4306213402042, 772.2740623813597, 773.2460850670608, 776.2509178642581, 777.1257335497565, 18848.62302753951, 19304.90347548267, 19555.315563955337, 19611.705824412646, 19670.311539096063, 21270.574588508298, 21277.787222127736, 21315.893420532953, 21403.892980535154, 21868.89065554662, 15649.061056336543, 15845.60385990348, 15871.20643967797, 16901.15494225296, 17435.389761358292, 3683.778973261613, 3694.0949467380397, 3714.1086139326635, 3727.0868637183794, 3728.459373390843, 118971.40514297373, 122053.0, 126459.36770316181, 128855.35572322078, 132396.3380183093, 16690.749638755427, 17874.374396896048, 17986.0, 18022.5494362642, 18160.001199933868, 30377.0, 30540.23649408738, 31154.221144471117, 31602.683973160434, 31707.682923170934, 7711.807204819925, 8038.0, 8650.78373040679, 8680.739577812676, 8707.695230666895, 3648.835802388899, 4122.773247471418, 4298.118885628439, 4320.827166913288, 4338.023944612437, 5194.6104042196985, 5262.315898933114, 5276.657017293864, 5289.338832645919, 5848.61983971049, 1126.8197088465806, 1141.3095077478006, 1164.5225457562358, 1167.4629670351733, 1168.6435637130758, 661.351875162334, 676.4216594811463, 676.5331920974512, 683.0573808144828, 690.7202582953912, 11859.525618975316, 12391.256524608552, 12693.809592856114, 12729.618111456672, 12928.353582320846, 696.3732640623379, 704.915410150775, 706.9328413800783, 715.0561259137888, 717.5694583250008, 5653.858653533694, 5683.976884160891, 5711.514521265656, 5814.854628634233, 5866.970665146732, 102656.0, 102888.0, 103782.0, 104122.0, 106853.0, 90468.5476572613, 93067.0, 93930.53034734783, 98334.50832745933, 98697.0, 78784.60607696924, 80923.0, 83548.0, 83683.0, 83867.0, 12356.25862448256, 12384.195027323196, 12484.812727808909, 12593.559225427067, 12620.32511422789, 33579.66420335863, 34458.655413445544, 34833.65166348304, 34845.825770870986, 35617.64382356143, 44815.0, 44964.77517612391, 45212.321815173455, 45631.31553026773, 45783.0, 17666.381676641256, 18076.819231807513, 18301.816981830012, 18464.26142954267, 18540.81459185391, 19079.236830526625, 20789.272375466786, 21273.893630531747, 21325.786742133, 21343.35969920905, 19296.807031930064, 19601.313954012112, 19736.90131549333, 19746.70379944331, 19891.502712432306, 19070.33253836109, 19598.510037249183, 19651.347068146188, 19696.606067878274, 19737.80262197417, 16820.158992050594, 17611.64776704433, 18004.279828806702, 18237.81762182361, 18261.08694565293, 9116.27069834425, 9645.469499177612, 9660.71017869465, 9706.126448619658, 9935.304528683211, 14331.278544510636, 14770.926145369205, 14937.402503899722, 15121.773173402627, 15265.923670381577], "value": 9019.534248556181, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 112.0, 106.0, 107.0, 111.0, 110.0, 108.0, 101.0, 113.0, 109.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 146.0, 174.0, 117.0, 164.0, 147.0, 124.0, 177.0, 126.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 165.0, 168.0, 170.0, 177.0, 163.0, 162.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 186.0, 81.0, 74.0, 75.0, 74.0, 153.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 133.0, 79.0, 79.0, 79.0, 129.0, 79.0, 77.0, 130.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 118.0, 114.0, 114.0, 121.0, 114.0, 115.0, 119.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 158.0, 157.0, 151.0, 150.0, 150.0, 149.0, 156.0, 153.0], "value": 152.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 99.0, 94.0, 94.0, 101.0, 94.0, 99.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 59.0, 54.0, 54.0, 54.0, 56.0, 53.0, 63.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 63.0, 56.0, 54.0, 61.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 78.0, 77.0, 94.0, 78.0, 89.0, 79.0, 88.0, 92.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 125.0, 138.0, 127.0, 130.0, 130.0, 136.0, 130.0, 170.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 181.0, 174.0, 179.0, 188.0, 174.0, 177.0, 181.0, 183.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 67.0, 66.0, 69.0, 65.0, 71.0, 68.0, 68.0, 72.0, 66.0], "value": 69.2, "unit": "score"}]}]} 15:08:18 INFO - Return code: 0 15:08:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:08:18 INFO - # TBPL SUCCESS # 15:08:18 INFO - Running post-action listener: _package_coverage_data 15:08:18 INFO - Running post-action listener: _resource_record_post_action 15:08:18 INFO - [mozharness: 2017-08-08 22:08:18.223736Z] Finished run-tests step (success) 15:08:18 INFO - Running post-run listener: _resource_record_post_run 15:08:18 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437661696; Read time: 16; Write time: 300192 15:08:18 INFO - TinderboxPrint: CPU usage
13.2% 15:08:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:08:18 INFO - TinderboxPrint: I/O write bytes / time
437,661,696 / 300,192 15:08:18 INFO - TinderboxPrint: CPU idle
8,270.7 (86.8%) 15:08:18 INFO - TinderboxPrint: CPU user
1,206.6 (12.7%) 15:08:18 INFO - TinderboxPrint: Swap in / out
0 / 0 15:08:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111194112; Read time: 0; Write time: 110028 15:08:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:08:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 326467584; Read time: 0; Write time: 190164 15:08:18 INFO - Running post-run listener: _upload_blobber_files 15:08:18 INFO - Blob upload gear active. 15:08:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:08:18 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 15:08:18 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'] 15:08:18 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 15:08:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:20 INFO - (blobuploader) - INFO - Done attempting. 15:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:08:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:21 INFO - (blobuploader) - INFO - Done attempting. 15:08:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:08:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:08:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:22 INFO - (blobuploader) - INFO - Done attempting. 15:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:08:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:30 INFO - (blobuploader) - INFO - Done attempting. 15:08:30 INFO - (blobuploader) - INFO - Iteration through files over. 15:08:30 INFO - Return code: 0 15:08:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:08:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:08:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf270b9769c3fde3cee4a9c2485e928063be7596ae323205b0221561cb64bbb736c4195844798109ff8453621626cf200a65eb6c2af797ef793fd78ee1d052cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f87dcf5c5aa6f0924317b5135b69ad693f2161ae875beffdc7cd7274d7becd8366bf0f964c3652ecfc05d4cd18e0873e33dabeb7cfdcf66783897d2350d40591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f3bc27d737b708937913ffa7d186d53cb19ab6a4ba8f013ae0001653571145bfa1a19cc61fed74eb12945e46ba564c3ec01449a3eb7cea9bb2dacc255b4bef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e16fdad53ca79a34cc8be5fe35807af848c67589021cbc5117bddf9a85369c5fcd1ba7fc3301c5738bf6d23fd93b9ecb979f8f6f6c383473f7b930b686109851"} 15:08:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:08:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:08:30 INFO - Contents: 15:08:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf270b9769c3fde3cee4a9c2485e928063be7596ae323205b0221561cb64bbb736c4195844798109ff8453621626cf200a65eb6c2af797ef793fd78ee1d052cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f87dcf5c5aa6f0924317b5135b69ad693f2161ae875beffdc7cd7274d7becd8366bf0f964c3652ecfc05d4cd18e0873e33dabeb7cfdcf66783897d2350d40591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f3bc27d737b708937913ffa7d186d53cb19ab6a4ba8f013ae0001653571145bfa1a19cc61fed74eb12945e46ba564c3ec01449a3eb7cea9bb2dacc255b4bef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e16fdad53ca79a34cc8be5fe35807af848c67589021cbc5117bddf9a85369c5fcd1ba7fc3301c5738bf6d23fd93b9ecb979f8f6f6c383473f7b930b686109851"} 15:08:30 INFO - Running post-run listener: copy_logs_to_upload_dir 15:08:30 INFO - Copying logs to upload dir... 15:08:30 INFO - mkdir: /builds/slave/test/build/upload/logs 15:08:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.602606 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-08 15:08:29.883958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:08:29.887415) ========= 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=523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189 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/cf270b9769c3fde3cee4a9c2485e928063be7596ae323205b0221561cb64bbb736c4195844798109ff8453621626cf200a65eb6c2af797ef793fd78ee1d052cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f87dcf5c5aa6f0924317b5135b69ad693f2161ae875beffdc7cd7274d7becd8366bf0f964c3652ecfc05d4cd18e0873e33dabeb7cfdcf66783897d2350d40591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f3bc27d737b708937913ffa7d186d53cb19ab6a4ba8f013ae0001653571145bfa1a19cc61fed74eb12945e46ba564c3ec01449a3eb7cea9bb2dacc255b4bef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e16fdad53ca79a34cc8be5fe35807af848c67589021cbc5117bddf9a85369c5fcd1ba7fc3301c5738bf6d23fd93b9ecb979f8f6f6c383473f7b930b686109851"} build_url:https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/GaBE-UeZSkOefe_vidhhZg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf270b9769c3fde3cee4a9c2485e928063be7596ae323205b0221561cb64bbb736c4195844798109ff8453621626cf200a65eb6c2af797ef793fd78ee1d052cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f87dcf5c5aa6f0924317b5135b69ad693f2161ae875beffdc7cd7274d7becd8366bf0f964c3652ecfc05d4cd18e0873e33dabeb7cfdcf66783897d2350d40591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f3bc27d737b708937913ffa7d186d53cb19ab6a4ba8f013ae0001653571145bfa1a19cc61fed74eb12945e46ba564c3ec01449a3eb7cea9bb2dacc255b4bef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e16fdad53ca79a34cc8be5fe35807af848c67589021cbc5117bddf9a85369c5fcd1ba7fc3301c5738bf6d23fd93b9ecb979f8f6f6c383473f7b930b686109851"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:08:29.914988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:08:29.915326) ========= 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=523ca41ca1e0623de333ad52000001bf-1502226349.358164-45185189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:08:30.001213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:08:30.001948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:08:30.002664) ========= ========= Total master_lag: 0.34 =========