builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1502865740.78 results: success (0) revision: 9ab2470a3210324bc11320531b15d195aaf05051 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.779171) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.779668) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.779995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.908398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:20.908712) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 23:42:21-- 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% 226M=0s 2017-08-15 23:42:21 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130026 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.071598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.071917) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015119 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.123178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.123539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ab2470a3210324bc11320531b15d195aaf05051 --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 9ab2470a3210324bc11320531b15d195aaf05051 --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=e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 23:42:21,504 truncating revision to first 12 chars 2017-08-15 23:42:21,504 Setting DEBUG logging. 2017-08-15 23:42:21,504 attempt 1/10 2017-08-15 23:42:21,504 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ab2470a3210?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 23:42:21,946 unpacking tar archive at: mozilla-central-9ab2470a3210/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835619 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.973689) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.974086) ========= script_repo_revision: 9ab2470a3210324bc11320531b15d195aaf05051 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.974535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.974846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 23:42:21.986324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-15 23:42:21.986653) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:42:22 INFO - MultiFileLogger online at 20170815 23:42:22 in /builds/slave/test 23:42:22 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 23:42:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:42:22 INFO - {'append_to_log': False, 23:42:22 INFO - 'base_work_dir': '/builds/slave/test', 23:42:22 INFO - 'blob_upload_branch': 'Firefox', 23:42:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:42:22 INFO - 'branch': 'Firefox', 23:42:22 INFO - 'buildbot_json_path': 'buildprops.json', 23:42:22 INFO - 'code_coverage': False, 23:42:22 INFO - 'config_files': ('talos/linux_config.py',), 23:42:22 INFO - 'default_actions': ('clobber', 23:42:22 INFO - 'read-buildbot-config', 23:42:22 INFO - 'download-and-extract', 23:42:22 INFO - 'populate-webroot', 23:42:22 INFO - 'create-virtualenv', 23:42:22 INFO - 'install', 23:42:22 INFO - 'setup-mitmproxy', 23:42:22 INFO - 'run-tests'), 23:42:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:42:22 INFO - 'disable_ccov_upload': False, 23:42:22 INFO - 'download_minidump_stackwalk': True, 23:42:22 INFO - 'download_symbols': 'ondemand', 23:42:22 INFO - 'enable_stylo': False, 23:42:22 INFO - 'enable_webrender': False, 23:42:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:42:22 INFO - 'tooltool.py': '/tools/tooltool.py', 23:42:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:42:22 INFO - '/tools/misc-python/virtualenv.py')}, 23:42:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:42:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:42:22 INFO - 'gecko_profile': False, 23:42:22 INFO - 'gecko_profile_interval': 0, 23:42:22 INFO - 'installer_path': 'installer.exe', 23:42:22 INFO - 'log_level': 'info', 23:42:22 INFO - 'log_name': 'talos', 23:42:22 INFO - 'log_to_console': True, 23:42:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:42:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:42:22 INFO - 'opt_config_files': (), 23:42:22 INFO - 'pip_index': False, 23:42:22 INFO - 'suite': 'dromaeojs-e10s', 23:42:22 INFO - 'system_bits': '32', 23:42:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:42:22 INFO - 'title': 'talos-linux64-ix-006', 23:42:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:42:22 INFO - 'use_talos_json': True, 23:42:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:42:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:42:22 INFO - 'work_dir': 'build'} 23:42:22 INFO - [mozharness: 2017-08-16 06:42:22.471075Z] Running clobber step. 23:42:22 INFO - Running pre-action listener: _resource_record_pre_action 23:42:22 INFO - Running main action method: clobber 23:42:22 INFO - rmtree: /builds/slave/test/build 23:42:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:42:24 INFO - Running post-action listener: _resource_record_post_action 23:42:24 INFO - [mozharness: 2017-08-16 06:42:24.005171Z] Finished clobber step (success) 23:42:24 INFO - [mozharness: 2017-08-16 06:42:24.005272Z] Running read-buildbot-config step. 23:42:24 INFO - Running pre-action listener: _resource_record_pre_action 23:42:24 INFO - Running main action method: read_buildbot_config 23:42:24 INFO - Using buildbot properties: 23:42:24 INFO - { 23:42:24 INFO - "project": "", 23:42:24 INFO - "product": "firefox", 23:42:24 INFO - "who": "asasaki@mozilla.com", 23:42:24 INFO - "installer_path": "public/build/target.tar.bz2", 23:42:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 23:42:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:42:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 23:42:24 INFO - "stage_platform": "linux64-stylo", 23:42:24 INFO - "basedir": "/builds/slave/test", 23:42:24 INFO - "buildnumber": 271, 23:42:24 INFO - "platform": "ubuntu64_hw_stylo", 23:42:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:42:24 INFO - "slavebuilddir": "test", 23:42:24 INFO - "taskId": "TJFLTCd4R-yAcLu3k7qh4g", 23:42:24 INFO - "branch": "mozilla-central", 23:42:24 INFO - "script_repo_revision": "production", 23:42:24 INFO - "revision": "9ab2470a3210324bc11320531b15d195aaf05051", 23:42:24 INFO - "slavename": "talos-linux64-ix-006", 23:42:24 INFO - "repo_path": "mozilla-central" 23:42:24 INFO - } 23:42:24 INFO - Finding installer, test and symbols from parent task. 23:42:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJFLTCd4R-yAcLu3k7qh4g'}, attempt #1 23:42:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJFLTCd4R-yAcLu3k7qh4g'}, attempt #1 23:42:24 INFO - Task dependencies: d3FxelQfSZeBQxstE0lcrA 23:42:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA'}, attempt #1 23:42:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json 23:42:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip 23:42:25 INFO - Running post-action listener: _resource_record_post_action 23:42:25 INFO - [mozharness: 2017-08-16 06:42:25.309616Z] Finished read-buildbot-config step (success) 23:42:25 INFO - [mozharness: 2017-08-16 06:42:25.309868Z] Running download-and-extract step. 23:42:25 INFO - Running pre-action listener: _resource_record_pre_action 23:42:25 INFO - Running main action method: download_and_extract 23:42:25 INFO - mkdir: /builds/slave/test/build/tests 23:42:25 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')]} 23:42:25 INFO - trying https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json 23:42:25 INFO - Downloading https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:42:25 INFO - Downloaded 989 bytes. 23:42:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:42:25 INFO - Using the following test package requirements: 23:42:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:42:25 INFO - u'common': [u'target.common.tests.zip'], 23:42:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:42:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:42:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:42:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:42:25 INFO - u'mozbase': [u'target.common.tests.zip'], 23:42:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:42:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:42:25 INFO - u'web-platform': [u'target.common.tests.zip', 23:42:25 INFO - u'target.web-platform.tests.tar.gz'], 23:42:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:42:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 23:42:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip 23:42:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:42:25 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip into memory 23:42:28 INFO - Content-Length response header: 54003984 23:42:28 INFO - Bytes received: 54003984 23:42:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 23:42:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip 23:42:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:42:39 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip into memory 23:42:40 INFO - Content-Length response header: 54003984 23:42:40 INFO - Bytes received: 54003984 23:42:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip 23:42:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:42:52 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip into memory 23:42:53 INFO - Content-Length response header: 14496050 23:42:53 INFO - Bytes received: 14496050 23:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:53 INFO - trying https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:42:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:42:55 INFO - Downloaded 61840933 bytes. 23:42:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:55 INFO - mkdir: /builds/slave/test/properties 23:42:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:42:55 INFO - Writing to file /builds/slave/test/properties/build_url 23:42:55 INFO - Contents: 23:42:55 INFO - build_url:https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:55 INFO - Running post-action listener: _resource_record_post_action 23:42:55 INFO - Running post-action listener: set_extra_try_arguments 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.180028Z] Finished download-and-extract step (success) 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.180237Z] Running populate-webroot step. 23:42:55 INFO - Running pre-action listener: _resource_record_pre_action 23:42:55 INFO - Running main action method: populate_webroot 23:42:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:42:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:42:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:42:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'tests': ['damp', 'tps']}, 23:42:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:42:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:42:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:42:55 INFO - 'other-e10s': {'tests': ['a11yr', 23:42:55 INFO - 'ts_paint', 23:42:55 INFO - 'tpaint', 23:42:55 INFO - 'sessionrestore', 23:42:55 INFO - 'sessionrestore_many_windows', 23:42:55 INFO - 'sessionrestore_no_auto_restore', 23:42:55 INFO - 'tabpaint']}, 23:42:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:42:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:42:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:42:55 INFO - 'tsvgr_opacity', 23:42:55 INFO - 'tart', 23:42:55 INFO - 'tscrollx', 23:42:55 INFO - 'tsvg_static']}, 23:42:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:42:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:55 INFO - 'talos_options': ['--mitmproxy', 23:42:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:55 INFO - '--firstNonBlankPaint'], 23:42:55 INFO - 'tests': ['tp6_google', 23:42:55 INFO - 'tp6_youtube', 23:42:55 INFO - 'tp6_amazon', 23:42:55 INFO - 'tp6_facebook']}, 23:42:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:55 INFO - 'talos_options': ['--stylo', 23:42:55 INFO - '--mitmproxy', 23:42:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:55 INFO - '--firstNonBlankPaint'], 23:42:55 INFO - 'tests': ['tp6_google', 23:42:55 INFO - 'tp6_youtube', 23:42:55 INFO - 'tp6_amazon', 23:42:55 INFO - 'tp6_facebook']}, 23:42:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:55 INFO - 'talos_options': ['--stylo', 23:42:55 INFO - '--stylo-threads=1', 23:42:55 INFO - '--mitmproxy', 23:42:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:55 INFO - '--firstNonBlankPaint'], 23:42:55 INFO - 'tests': ['tp6_google', 23:42:55 INFO - 'tp6_youtube', 23:42:55 INFO - 'tp6_amazon', 23:42:55 INFO - 'tp6_facebook']}, 23:42:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:42:55 INFO - 'talos_options': ['--xperf_path', 23:42:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:42:55 INFO - 'tests': ['tp5n']}}} 23:42:55 INFO - Running post-action listener: _resource_record_post_action 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.194302Z] Finished populate-webroot step (success) 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.194393Z] Running create-virtualenv step. 23:42:55 INFO - Running pre-action listener: _resource_record_pre_action 23:42:55 INFO - Running main action method: create_virtualenv 23:42:55 INFO - Creating virtualenv /builds/slave/test/build/venv 23:42:55 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 23:42:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:42:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:42:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:42:55 INFO - Using real prefix '/usr' 23:42:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:42:55 INFO - Installing distribute.............................................................................................................................................................................................done. 23:42:57 INFO - Installing pip.................done. 23:42:57 INFO - Return code: 0 23:42:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:42:57 INFO - Reading from file tmpfile_stdout 23:42:57 INFO - Output received: 23:42:57 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) 23:42:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:57 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:42:57 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 23:42:57 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 23:42:57 INFO - Using env: {'DISPLAY': ':0', 23:42:57 INFO - 'HOME': '/home/cltbld', 23:42:57 INFO - 'LANG': 'en_US.UTF-8', 23:42:57 INFO - 'LANGUAGE': 'en_US:en', 23:42:57 INFO - 'LOGNAME': 'cltbld', 23:42:57 INFO - 'MAIL': '/var/mail/cltbld', 23:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:57 INFO - 'MOZ_NO_REMOTE': '1', 23:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:57 INFO - 'NO_EM_RESTART': '1', 23:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:57 INFO - 'PWD': '/builds/slave/test', 23:42:57 INFO - 'SHELL': '/bin/bash', 23:42:57 INFO - 'SHLVL': '1', 23:42:57 INFO - 'TERM': 'linux', 23:42:57 INFO - 'TMOUT': '86400', 23:42:57 INFO - 'USER': 'cltbld', 23:42:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:57 INFO - '_': '/tools/buildbot/bin/python'} 23:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:58 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 23:42:58 INFO - Cleaning up... 23:42:58 INFO - Return code: 0 23:42:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:58 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:42:58 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 23:42:58 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 23:42:58 INFO - Using env: {'DISPLAY': ':0', 23:42:58 INFO - 'HOME': '/home/cltbld', 23:42:58 INFO - 'LANG': 'en_US.UTF-8', 23:42:58 INFO - 'LANGUAGE': 'en_US:en', 23:42:58 INFO - 'LOGNAME': 'cltbld', 23:42:58 INFO - 'MAIL': '/var/mail/cltbld', 23:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:58 INFO - 'MOZ_NO_REMOTE': '1', 23:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:58 INFO - 'NO_EM_RESTART': '1', 23:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:58 INFO - 'PWD': '/builds/slave/test', 23:42:58 INFO - 'SHELL': '/bin/bash', 23:42:58 INFO - 'SHLVL': '1', 23:42:58 INFO - 'TERM': 'linux', 23:42:58 INFO - 'TMOUT': '86400', 23:42:58 INFO - 'USER': 'cltbld', 23:42:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:58 INFO - '_': '/tools/buildbot/bin/python'} 23:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:58 INFO - Downloading/unpacking psutil>=3.1.1 23:42:58 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 23:42:58 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 23:42:58 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 23:42:58 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 23:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:42:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:59 INFO - Installing collected packages: psutil 23:42:59 INFO - Running setup.py install for psutil 23:42:59 INFO - building 'psutil._psutil_linux' extension 23:42:59 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 23:42:59 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 23:42:59 INFO - building 'psutil._psutil_posix' extension 23:42:59 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 23:43:00 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 23:43:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:43:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:43:00 INFO - Successfully installed psutil 23:43:00 INFO - Cleaning up... 23:43:00 INFO - Return code: 0 23:43:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:43:00 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')]} 23:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:00 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')]} 23:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:00 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:00 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 23:43:00 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 23:43:00 INFO - Using env: {'DISPLAY': ':0', 23:43:00 INFO - 'HOME': '/home/cltbld', 23:43:00 INFO - 'LANG': 'en_US.UTF-8', 23:43:00 INFO - 'LANGUAGE': 'en_US:en', 23:43:00 INFO - 'LOGNAME': 'cltbld', 23:43:00 INFO - 'MAIL': '/var/mail/cltbld', 23:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:00 INFO - 'MOZ_NO_REMOTE': '1', 23:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:00 INFO - 'NO_EM_RESTART': '1', 23:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:00 INFO - 'PWD': '/builds/slave/test', 23:43:00 INFO - 'SHELL': '/bin/bash', 23:43:00 INFO - 'SHLVL': '1', 23:43:00 INFO - 'TERM': 'linux', 23:43:00 INFO - 'TMOUT': '86400', 23:43:00 INFO - 'USER': 'cltbld', 23:43:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:00 INFO - '_': '/tools/buildbot/bin/python'} 23:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:43:00 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 23:43:00 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 23:43:00 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 23:43:00 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 23:43:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:43:01 INFO - Installing collected packages: mozsystemmonitor 23:43:01 INFO - Running setup.py install for mozsystemmonitor 23:43:01 INFO - Successfully installed mozsystemmonitor 23:43:01 INFO - Cleaning up... 23:43:01 INFO - Return code: 0 23:43:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:43: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')]} 23:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43: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')]} 23:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:01 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:01 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 23:43:01 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 23:43:01 INFO - Using env: {'DISPLAY': ':0', 23:43:01 INFO - 'HOME': '/home/cltbld', 23:43:01 INFO - 'LANG': 'en_US.UTF-8', 23:43:01 INFO - 'LANGUAGE': 'en_US:en', 23:43:01 INFO - 'LOGNAME': 'cltbld', 23:43:01 INFO - 'MAIL': '/var/mail/cltbld', 23:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:01 INFO - 'MOZ_NO_REMOTE': '1', 23:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:01 INFO - 'NO_EM_RESTART': '1', 23:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:01 INFO - 'PWD': '/builds/slave/test', 23:43:01 INFO - 'SHELL': '/bin/bash', 23:43:01 INFO - 'SHLVL': '1', 23:43:01 INFO - 'TERM': 'linux', 23:43:01 INFO - 'TMOUT': '86400', 23:43:01 INFO - 'USER': 'cltbld', 23:43:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:01 INFO - '_': '/tools/buildbot/bin/python'} 23:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:01 INFO - Downloading/unpacking jsonschema==2.5.1 23:43:01 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 23:43:01 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 23:43:01 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 23:43:01 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 23:43:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:43:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:43:03 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 23:43:03 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 23:43:03 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 23:43:03 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 23:43:03 INFO - Downloading functools32-3.2.3-2.tar.gz 23:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:43:03 INFO - warning: no files found matching '*.txt' 23:43:03 INFO - no previously-included directories found matching 'build' 23:43:03 INFO - no previously-included directories found matching 'dist' 23:43:03 INFO - no previously-included directories found matching '.git*' 23:43:03 INFO - Installing collected packages: jsonschema, functools32 23:43:03 INFO - Running setup.py install for functools32 23:43:03 INFO - warning: no files found matching '*.txt' 23:43:03 INFO - no previously-included directories found matching 'build' 23:43:03 INFO - no previously-included directories found matching 'dist' 23:43:03 INFO - no previously-included directories found matching '.git*' 23:43:03 INFO - Successfully installed jsonschema functools32 23:43:03 INFO - Cleaning up... 23:43:03 INFO - Return code: 0 23:43:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:03 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:03 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 23:43:03 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 23:43:03 INFO - Using env: {'DISPLAY': ':0', 23:43:03 INFO - 'HOME': '/home/cltbld', 23:43:03 INFO - 'LANG': 'en_US.UTF-8', 23:43:03 INFO - 'LANGUAGE': 'en_US:en', 23:43:03 INFO - 'LOGNAME': 'cltbld', 23:43:03 INFO - 'MAIL': '/var/mail/cltbld', 23:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:03 INFO - 'MOZ_NO_REMOTE': '1', 23:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:03 INFO - 'NO_EM_RESTART': '1', 23:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:03 INFO - 'PWD': '/builds/slave/test', 23:43:03 INFO - 'SHELL': '/bin/bash', 23:43:03 INFO - 'SHLVL': '1', 23:43:03 INFO - 'TERM': 'linux', 23:43:03 INFO - 'TMOUT': '86400', 23:43:03 INFO - 'USER': 'cltbld', 23:43:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:03 INFO - '_': '/tools/buildbot/bin/python'} 23:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:43:03 INFO - Cleaning up... 23:43:03 INFO - Return code: 0 23:43:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:03 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:03 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 23:43:03 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 23:43:03 INFO - Using env: {'DISPLAY': ':0', 23:43:03 INFO - 'HOME': '/home/cltbld', 23:43:03 INFO - 'LANG': 'en_US.UTF-8', 23:43:03 INFO - 'LANGUAGE': 'en_US:en', 23:43:03 INFO - 'LOGNAME': 'cltbld', 23:43:03 INFO - 'MAIL': '/var/mail/cltbld', 23:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:03 INFO - 'MOZ_NO_REMOTE': '1', 23:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:03 INFO - 'NO_EM_RESTART': '1', 23:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:03 INFO - 'PWD': '/builds/slave/test', 23:43:03 INFO - 'SHELL': '/bin/bash', 23:43:03 INFO - 'SHLVL': '1', 23:43:03 INFO - 'TERM': 'linux', 23:43:03 INFO - 'TMOUT': '86400', 23:43:03 INFO - 'USER': 'cltbld', 23:43:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:03 INFO - '_': '/tools/buildbot/bin/python'} 23:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:03 INFO - Downloading/unpacking blobuploader==1.2.4 23:43:03 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 23:43:03 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 23:43:03 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 23:43:03 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 23:43:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:43:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:43: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 23:43: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 23:43: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 23:43: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 23:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:43:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:43: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 23:43: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 23:43: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 23:43: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 23:43:05 INFO - Downloading docopt-0.6.1.tar.gz 23:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:43:05 INFO - Installing collected packages: blobuploader, requests, docopt 23:43:05 INFO - Running setup.py install for blobuploader 23:43:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:43:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:43:05 INFO - Running setup.py install for requests 23:43:06 INFO - Running setup.py install for docopt 23:43:06 INFO - Successfully installed blobuploader requests docopt 23:43:06 INFO - Cleaning up... 23:43:06 INFO - Return code: 0 23:43:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:06 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')]} 23:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:06 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')]} 23:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:06 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:06 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 23:43:06 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 23:43:06 INFO - Using env: {'DISPLAY': ':0', 23:43:06 INFO - 'HOME': '/home/cltbld', 23:43:06 INFO - 'LANG': 'en_US.UTF-8', 23:43:06 INFO - 'LANGUAGE': 'en_US:en', 23:43:06 INFO - 'LOGNAME': 'cltbld', 23:43:06 INFO - 'MAIL': '/var/mail/cltbld', 23:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:06 INFO - 'MOZ_NO_REMOTE': '1', 23:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:06 INFO - 'NO_EM_RESTART': '1', 23:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:06 INFO - 'PWD': '/builds/slave/test', 23:43:06 INFO - 'SHELL': '/bin/bash', 23:43:06 INFO - 'SHLVL': '1', 23:43:06 INFO - 'TERM': 'linux', 23:43:06 INFO - 'TMOUT': '86400', 23:43:06 INFO - 'USER': 'cltbld', 23:43:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:06 INFO - '_': '/tools/buildbot/bin/python'} 23:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:06 INFO - Running setup.py (path:/tmp/pip-JVoZPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:06 INFO - Running setup.py (path:/tmp/pip-duvGwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:06 INFO - Running setup.py (path:/tmp/pip-3e9gNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:06 INFO - Running setup.py (path:/tmp/pip-mMra5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:06 INFO - Running setup.py (path:/tmp/pip-BUqLJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:06 INFO - Running setup.py (path:/tmp/pip-OiJ2mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:07 INFO - Running setup.py (path:/tmp/pip-yIopJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:07 INFO - Running setup.py (path:/tmp/pip-idSpQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:07 INFO - Running setup.py (path:/tmp/pip-h8IF1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:07 INFO - Running setup.py (path:/tmp/pip-gPhIjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:07 INFO - Running setup.py (path:/tmp/pip-2WsVjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:07 INFO - Running setup.py (path:/tmp/pip-8ZnOG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:07 INFO - Running setup.py (path:/tmp/pip-3dEuWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:07 INFO - Running setup.py (path:/tmp/pip-QkG7Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:07 INFO - Running setup.py (path:/tmp/pip-p1SLGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:07 INFO - Running setup.py (path:/tmp/pip-eizL8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:07 INFO - Running setup.py (path:/tmp/pip-CaFzxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:43:07 INFO - Running setup.py install for manifestparser 23:43:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:43:07 INFO - Running setup.py install for mozcrash 23:43:07 INFO - Running setup.py install for mozdebug 23:43:08 INFO - Running setup.py install for mozdevice 23:43:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozfile 23:43:08 INFO - Running setup.py install for mozhttpd 23:43:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozinfo 23:43:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozInstall 23:43:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozleak 23:43:08 INFO - Running setup.py install for mozlog 23:43:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for moznetwork 23:43:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:43:08 INFO - Running setup.py install for mozprocess 23:43:09 INFO - Running setup.py install for mozprofile 23:43:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:43:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:43:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:43:09 INFO - Running setup.py install for mozrunner 23:43:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:43:09 INFO - Running setup.py install for mozscreenshot 23:43:09 INFO - Running setup.py install for moztest 23:43:09 INFO - Running setup.py install for mozversion 23:43:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:43:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:43:09 INFO - Cleaning up... 23:43:09 INFO - Return code: 0 23:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43: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')]} 23:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43: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')]} 23:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:09 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:09 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 23:43:09 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 23:43:09 INFO - Using env: {'DISPLAY': ':0', 23:43:09 INFO - 'HOME': '/home/cltbld', 23:43:09 INFO - 'LANG': 'en_US.UTF-8', 23:43:09 INFO - 'LANGUAGE': 'en_US:en', 23:43:09 INFO - 'LOGNAME': 'cltbld', 23:43:09 INFO - 'MAIL': '/var/mail/cltbld', 23:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:09 INFO - 'MOZ_NO_REMOTE': '1', 23:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:09 INFO - 'NO_EM_RESTART': '1', 23:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:09 INFO - 'PWD': '/builds/slave/test', 23:43:09 INFO - 'SHELL': '/bin/bash', 23:43:09 INFO - 'SHLVL': '1', 23:43:09 INFO - 'TERM': 'linux', 23:43:09 INFO - 'TMOUT': '86400', 23:43:09 INFO - 'USER': 'cltbld', 23:43:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:09 INFO - '_': '/tools/buildbot/bin/python'} 23:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:43:09 INFO - Running setup.py (path:/tmp/pip-8ZQ_Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:43:09 INFO - Running setup.py (path:/tmp/pip-dUKb9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:43:09 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)) 23:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:43:09 INFO - Running setup.py (path:/tmp/pip-lIVEbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:43:10 INFO - Running setup.py (path:/tmp/pip-pyD8j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:43:10 INFO - Running setup.py (path:/tmp/pip-i7syX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:43:10 INFO - Running setup.py (path:/tmp/pip-SeEnYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:43:10 INFO - Running setup.py (path:/tmp/pip-QqbybC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:43:10 INFO - Running setup.py (path:/tmp/pip-epeYs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:43:10 INFO - Running setup.py (path:/tmp/pip-UsCrGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:43:10 INFO - Running setup.py (path:/tmp/pip-dvEkNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:43:10 INFO - Running setup.py (path:/tmp/pip-nrm1gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:43:10 INFO - Running setup.py (path:/tmp/pip-M0ugCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:43:10 INFO - Running setup.py (path:/tmp/pip-efwK0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:43:10 INFO - Running setup.py (path:/tmp/pip-f2Zn_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:10 INFO - Running setup.py (path:/tmp/pip-O3lKlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:43:10 INFO - Running setup.py (path:/tmp/pip-gcltbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:43:10 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)) 23:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:43:10 INFO - Running setup.py (path:/tmp/pip-18uOzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:43:11 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)) 23:43:11 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)) 23:43:11 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)) 23:43:11 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)) 23:43:11 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)) 23:43:11 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)) 23:43:11 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)) 23:43:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:43: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 23:43: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 23:43: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 23:43: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 23:43:12 INFO - Downloading blessings-1.6.tar.gz 23:43:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:43:12 INFO - Installing collected packages: blessings 23:43:12 INFO - Running setup.py install for blessings 23:43:12 INFO - Successfully installed blessings 23:43:12 INFO - Cleaning up... 23:43:12 INFO - Return code: 0 23:43:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:43:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:12 INFO - Reading from file tmpfile_stdout 23:43:12 INFO - Current package versions: 23:43:12 INFO - argparse == 1.2.1 23:43:12 INFO - blessings == 1.6 23:43:12 INFO - blobuploader == 1.2.4 23:43:12 INFO - docopt == 0.6.1 23:43:12 INFO - functools32 == 3.2.3-2 23:43:12 INFO - jsonschema == 2.5.1 23:43:12 INFO - manifestparser == 1.1 23:43:12 INFO - mozInstall == 1.13 23:43:12 INFO - mozcrash == 1.0 23:43:12 INFO - mozdebug == 0.1 23:43:12 INFO - mozdevice == 0.51 23:43:12 INFO - mozfile == 1.2 23:43:12 INFO - mozhttpd == 0.7 23:43:12 INFO - mozinfo == 0.10 23:43:12 INFO - mozleak == 0.1 23:43:12 INFO - mozlog == 3.5 23:43:12 INFO - moznetwork == 0.27 23:43:12 INFO - mozprocess == 0.25 23:43:12 INFO - mozprofile == 0.28 23:43:12 INFO - mozrunner == 6.13 23:43:12 INFO - mozscreenshot == 0.1 23:43:12 INFO - mozsystemmonitor == 0.3 23:43:12 INFO - moztest == 0.8 23:43:12 INFO - mozversion == 1.4 23:43:12 INFO - psutil == 3.1.1 23:43:12 INFO - requests == 1.2.3 23:43:12 INFO - wsgiref == 0.1.2 23:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:43:12 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')]} 23:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:12 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')]} 23:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:12 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:12 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 23:43:12 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 23:43:12 INFO - Using env: {'DISPLAY': ':0', 23:43:12 INFO - 'HOME': '/home/cltbld', 23:43:12 INFO - 'LANG': 'en_US.UTF-8', 23:43:12 INFO - 'LANGUAGE': 'en_US:en', 23:43:12 INFO - 'LOGNAME': 'cltbld', 23:43:12 INFO - 'MAIL': '/var/mail/cltbld', 23:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:12 INFO - 'MOZ_NO_REMOTE': '1', 23:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:12 INFO - 'NO_EM_RESTART': '1', 23:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:12 INFO - 'PWD': '/builds/slave/test', 23:43:12 INFO - 'SHELL': '/bin/bash', 23:43:12 INFO - 'SHLVL': '1', 23:43:12 INFO - 'TERM': 'linux', 23:43:12 INFO - 'TMOUT': '86400', 23:43:12 INFO - 'USER': 'cltbld', 23:43:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:12 INFO - '_': '/tools/buildbot/bin/python'} 23:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 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)) 23:43:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:43: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 23:43: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 23:43: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 23:43: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 23:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:43:13 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)) 23:43:13 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)) 23:43:13 INFO - Installing collected packages: simplejson 23:43:13 INFO - Running setup.py install for simplejson 23:43:14 INFO - building 'simplejson._speedups' extension 23:43:14 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 23:43:14 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 23:43:14 INFO - Successfully installed simplejson 23:43:14 INFO - Cleaning up... 23:43:15 INFO - Return code: 0 23:43:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:43:15 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')]} 23:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:43:15 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')]} 23:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:43:15 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a3ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', '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 23:43:15 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 23:43:15 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 23:43:15 INFO - Using env: {'DISPLAY': ':0', 23:43:15 INFO - 'HOME': '/home/cltbld', 23:43:15 INFO - 'LANG': 'en_US.UTF-8', 23:43:15 INFO - 'LANGUAGE': 'en_US:en', 23:43:15 INFO - 'LOGNAME': 'cltbld', 23:43:15 INFO - 'MAIL': '/var/mail/cltbld', 23:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:15 INFO - 'MOZ_NO_REMOTE': '1', 23:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:15 INFO - 'NO_EM_RESTART': '1', 23:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:15 INFO - 'PWD': '/builds/slave/test', 23:43:15 INFO - 'SHELL': '/bin/bash', 23:43:15 INFO - 'SHLVL': '1', 23:43:15 INFO - 'TERM': 'linux', 23:43:15 INFO - 'TMOUT': '86400', 23:43:15 INFO - 'USER': 'cltbld', 23:43:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:15 INFO - '_': '/tools/buildbot/bin/python'} 23:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:43:15 INFO - Cleaning up... 23:43:15 INFO - Return code: 0 23:43:15 INFO - Running post-action listener: _resource_record_post_action 23:43:15 INFO - Running post-action listener: _start_resource_monitoring 23:43:15 INFO - Starting resource monitoring. 23:43:15 INFO - [mozharness: 2017-08-16 06:43:15.291371Z] Finished create-virtualenv step (success) 23:43:15 INFO - [mozharness: 2017-08-16 06:43:15.291896Z] Running install step. 23:43:15 INFO - Running pre-action listener: _resource_record_pre_action 23:43:15 INFO - Running main action method: install 23:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:43:15 INFO - Reading from file tmpfile_stdout 23:43:15 INFO - Detecting whether we're running mozinstall >=1.0... 23:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:43:15 INFO - Reading from file tmpfile_stdout 23:43:15 INFO - Output received: 23:43:15 INFO - Usage: mozinstall [options] installer 23:43:15 INFO - Options: 23:43:15 INFO - -h, --help show this help message and exit 23:43:15 INFO - -d DEST, --destination=DEST 23:43:15 INFO - Directory to install application into. [default: 23:43:15 INFO - "/builds/slave/test"] 23:43:15 INFO - --app=APP Application being installed. [default: firefox] 23:43:15 INFO - mkdir: /builds/slave/test/build/application 23:43:15 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'] 23:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:43:33 INFO - Reading from file tmpfile_stdout 23:43:33 INFO - Output received: 23:43:33 INFO - /builds/slave/test/build/application/firefox/firefox 23:43:33 INFO - Running post-action listener: _resource_record_post_action 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.667022Z] Finished install step (success) 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.667304Z] Running setup-mitmproxy step. 23:43:33 INFO - Running pre-action listener: _resource_record_pre_action 23:43:33 INFO - Running main action method: setup_mitmproxy 23:43:33 INFO - Skipping: mitmproxy is not required 23:43:33 INFO - Running post-action listener: _resource_record_post_action 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.668466Z] Finished setup-mitmproxy step (success) 23:43:33 INFO - [mozharness: 2017-08-16 06:43:33.668689Z] Running run-tests step. 23:43:33 INFO - Running pre-action listener: _resource_record_pre_action 23:43:33 INFO - Running pre-action listener: _set_gcov_prefix 23:43:33 INFO - Running main action method: run_tests 23:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:43:33 INFO - Python 2.7.3 23:43:33 INFO - Return code: 0 23:43:33 INFO - grabbing minidump binary from tooltool 23:43:33 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')]} 23:43:33 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 0x28a10b0>, '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 0x28a1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:43:33 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 23:43:33 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 23:43:33 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 23:43:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:43:33 INFO - Return code: 0 23:43:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:43:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:43:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:43:33 INFO - ENV: RUST_BACKTRACE is now full 23:43:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:43:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:43:33 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/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 23:43:33 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/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 23:43:33 INFO - Using env: {'DISPLAY': ':0', 23:43:33 INFO - 'HOME': '/home/cltbld', 23:43:33 INFO - 'LANG': 'en_US.UTF-8', 23:43:33 INFO - 'LANGUAGE': 'en_US:en', 23:43:33 INFO - 'LOGNAME': 'cltbld', 23:43:33 INFO - 'MAIL': '/var/mail/cltbld', 23:43:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:43:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:33 INFO - 'MOZ_NO_REMOTE': '1', 23:43:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:33 INFO - 'NO_EM_RESTART': '1', 23:43:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:33 INFO - 'PWD': '/builds/slave/test', 23:43:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:43:33 INFO - 'RUST_BACKTRACE': 'full', 23:43:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:43:33 INFO - 'SHELL': '/bin/bash', 23:43:33 INFO - 'SHLVL': '1', 23:43:33 INFO - 'STYLO_FORCE_ENABLED': '1', 23:43:33 INFO - 'TERM': 'linux', 23:43:33 INFO - 'TMOUT': '86400', 23:43:33 INFO - 'USER': 'cltbld', 23:43:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589', 23:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:33 INFO - '_': '/tools/buildbot/bin/python'} 23:43:33 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/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 23:43:34 INFO - mozversion application_buildid: 20170816055606 23:43:34 INFO - mozversion application_changeset: 9ab2470a3210324bc11320531b15d195aaf05051 23:43:34 INFO - mozversion application_display_name: Nightly 23:43:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:43:34 INFO - mozversion application_name: Firefox 23:43:34 INFO - mozversion application_remotingname: firefox 23:43:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:43:34 INFO - mozversion application_vendor: Mozilla 23:43:34 INFO - mozversion application_version: 57.0a1 23:43:34 INFO - mozversion platform_buildid: 20170816055606 23:43:34 INFO - mozversion platform_changeset: 9ab2470a3210324bc11320531b15d195aaf05051 23:43:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:43:34 INFO - mozversion platform_version: 57.0a1 23:43:34 INFO - using testdate: 1502865814 23:43:34 INFO - actual date: 1502865814 23:43:34 INFO - starting webserver on 'localhost:48260' 23:43:34 INFO - SUITE-START | Running 2 tests 23:43:34 INFO - TEST-START | dromaeo_css 23:43:34 INFO - Initialising browser for dromaeo_css test... 23:43:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48260/getInfo.html -profile /tmp/tmppJW6tE/profile 23:43:34 INFO - TEST-INFO | started process 28984 (/builds/slave/test/build/application/firefox/firefox http://localhost:48260/getInfo.html) 23:43:40 INFO - TEST-INFO | 28984: exit 0 23:43:40 INFO - Browser initialized. 23:43:40 INFO - Running cycle 1/1 for dromaeo_css test... 23:43:40 INFO - TEST-INFO | started process 29174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppJW6tE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:41 INFO - PID 29174 | 23:43:41 INFO - PID 29174 | (/builds/slave/test/build/application/firefox/firefox:29228): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:43:41 INFO - PID 29174 | 23:43:51 INFO - PID 29174 | RSS: Main: 167858176 23:43:51 INFO - PID 29174 | 23:46:51 INFO - PID 29174 | Cycle 1(1): loaded http://localhost:48260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48260/tests/dromaeo/cssquery-ext.html) 23:46:52 INFO - PID 29174 | RSS: Main: 174948352 23:46:52 INFO - PID 29174 | 23:49:53 INFO - PID 29174 | Cycle 1(1): loaded http://localhost:48260/tests/dromaeo/cssquery-ext.html (next: http://localhost:48260/tests/dromaeo/cssquery-jquery.html) 23:49:54 INFO - PID 29174 | RSS: Main: 172650496 23:49:54 INFO - PID 29174 | 23:52:56 INFO - PID 29174 | Cycle 1(1): loaded http://localhost:48260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48260/tests/dromaeo/cssquery-mootools.html) 23:52:56 INFO - PID 29174 | RSS: Main: 173961216 23:52:56 INFO - PID 29174 | 23:55:58 INFO - PID 29174 | Cycle 1(1): loaded http://localhost:48260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48260/tests/dromaeo/cssquery-prototype.html) 23:55:59 INFO - PID 29174 | RSS: Main: 172941312 23:55:59 INFO - PID 29174 | 23:59:03 INFO - PID 29174 | Cycle 1(1): loaded http://localhost:48260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48260/tests/dromaeo/cssquery-yui.html) 23:59:03 INFO - PID 29174 | RSS: Main: 176238592 23:59:03 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | Cycle 1(1): loaded http://localhost:48260/tests/dromaeo/cssquery-yui.html (next: http://localhost:48260/tests/dromaeo/cssquery-dojo.html) 00:02:05 INFO - PID 29174 | RSS: Main: 176586752 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | __start_tp_report 00:02:05 INFO - PID 29174 | _x_x_mozilla_page_load 00:02:05 INFO - PID 29174 | _x_x_mozilla_page_load_details 00:02:05 INFO - PID 29174 | |i|pagename|runs| 00:02:05 INFO - PID 29174 | |0;dojo.html;3105.3013072058775;3117.5011998080313;3136.7333776628993;3138.1056398926303;3186.5379519969606;6179.598326108806;6285.182926219585;6316.210473690789;6330.430261276484;6338.271098823637;6051;6136.723847426865;6157.445829875311;6168.969155154218;6178.783742569011;5642.379338272786;5664.716764161796;5668.631538949955;5678.34699009613;5719.714014299289;5682.034054210773;5685.1756495308155;5691.630044047124;5702.401247868956;5717.656940583557;5729.140628905656;5738.0532212184935;5754.136879468092;5764.221830052952;5785.27684039495;5653.547716182696;5728.8854222915725;5733;5748.109043098327;5798.9130163047585;5485.670859748388;5582.106862901916;5584.692841893694;5676.687782171979;5678.687672178028;5863.275920030073;6136.171616831715;6148.231471066117;6149.046897730859;6228.22147231596;6603.075569420285;6634.568753031086;6703.363180497894;6723.462123030145;6725.6973436195485;6570.441512471446;6608.801735947929;6684.997250412428;6701.463882889406;6800.013997970266;6219.1604133442315;6222.191115155046;6223.813285601439;6226.968865155645;6227.470664993481;6881.41507971828;6915.654217289216;6923.446124310144;6928.930710692828;6930.272321406281;6513.478921686348;6536.084948107269;6543.280239173687;6590.637514936629;6592.077109204715;6507.642079685568;6521;6612.669366531654;6637.070810086591;6701.597904125768;6553.377429144223;6555.541112122201;6555.770548030796;6562.737490500422;6572.868542629216;6608.041833934052;6623.503237257225;6626.469882409396;6628.53600247978;6631.767888123893;5404.946035523035;5421.864453388618;5435.565154787608;5437.673739575638;5445.37378201504;4667.136579732693;4680.7191568506;4682.812687492462;4683.1336202802595;4694.2723877799;5752.13717942312;5763.9135412968835;5767.423257674283;5778.739956701958;5798.10129429939;6570.540062195696;6671.766488172891;6674.466042716571;6675.732970681215;6677.065210870482;5720.885582288331;5760.308762948473;5811.738471768781;5814.069748840166;5820.126980952891;5770.798022069207;5884.882302353929;5887.175795388649;5899.587028908021;5950.077737950624;6410.262819775692;6451.645159516272;6453.580517266362;6465.903011454832;6483.870322593428;6597.505187111082;6638.601683898982;6663.733450661919;6690.498212634169;6720.0255962886085;6437.163168788027;6465.450436712932;6475.449586785176;6501.317361677145;6505.316941721051;6417.935820641734;6435.163428754232;6463.903041454288;6556.901646475211;6566.507511936719;6476.579022363531;6598.3401659833635;6632.436242919406;6661.333866613494;6675.833104172434;6471.708773105127;6491.318411566906;6543.051257567721;6557.114789503356;6558.606483610999;6442.903356449563;6448.645324507197;6482.448991835558;6547.901781473186;6567.343265673395;6210.875782484415;6319.083732858801;6341.936580634135;6498.707558159799;6499.1876015498065;6489.707963141765;6497.285298617054;6542.214934207926;6593.901091483727;6608.834779130368;6188.3502232266765;6287.46556542699;6298.779542715983;6350.68246587678;6372.58578192416 00:02:05 INFO - PID 29174 | |1;ext.html;816.5672193737321;823.3207603726927;853.9530325832079;871.7297637732299;875.9518226497543;43275.35086973694;43910.78044609781;44139;44191.33712994304;44208.3368749469;39892.20215595686;40097.19805603886;40125.19749605006;40300.39549406761;40434.39348409769;6994.755183568576;7113.181984071821;7119.8220044498785;7121.323474269936;7121.8219544511285;7022;7066.434685225169;7070.681819318143;7082.291770822928;7082.610456424894;7741.109772376164;7931.682732690714;7934.087579928296;7937.12691603926;7940.325072368855;7842.568658723768;7905.960470197612;7911.920880791176;7913;7921.247481489249;7506.249375062504;7754.961225193894;7755.689772409097;7760.961195193988;7826.5695386753705;40689;41068.794656026825;41073.794631026954;41081.79459102715;41210.587894120974;3538.2569660371355;3585.372559802024;3585.623509531488;3587.641235876418;3591.94612080819;32177.678223217703;32225.1943701407;32267;32279.354412911845;32282.838585807156;4976.45259021511;4999.075171093323;5003.774830132653;5015.849524514234;5030.597552195815;215896;216899.99999999843;217269;217789;218181.9999999984;50366.748166258934;50436.24345634819;50518.24222636663;50617.493825061276;50650.49349506458;53273.7336313316;53439.19841202385;53517;53579.73210134002;53844.73077634587;16214.51356459308;16228.43200488001;16264.918675406547;16367.91816040912;16423.6715265694;13199.934000329937;13244.668883277802;13247.271400072896;13250.403731832092;13262.27057511846;14426;14434.422623094959;14458.204798736171;14499.710005799825;14644.926775366055;5474.479924407175;5542.445755424506;5554.1391084381985;5685.971570142123;5705.486506214461;1001.3090967232587;1012.4633944009687;1017.7353887989028;1022.8516865054675;1026.5175367577226;23491;23539.764602353756;23583.646245306336;23681.289561313188;23860.64209036866;1103.3435106111851;1103.586155191803;1107.7562936154034;1119.462657924201;1122.091106203961;12529.498820047096;12556.623301300975;12658.746825063447;12710.745785084246;12716.491340346467;230426;230870;231386;231603;231849;54973.45026549683;55564.72217638886;58482.707586462646;59679.70160149172;59789;1445.515752222996;1456.2136446318868;1461.2547600723708;1463.3488097796378;1495.5289083938524;27947.301317467227;28070;28732.71267287384;28868.855655721585;29021.12936611905;34788.47817282692;36382.454263186606;39659.80170099131;39757;39783.80108099557;201734;201872;202544;202937;203218;36562;36660.08349791277;36884.63115368812;36925.63074369222;37112.81443592765;43715.78142109396;44944.77527612341;45013.77493112513;45301.546984529734;45609.087818244116;34028.48957265692;34036.48945265773;34162.14594635154;34190.658093418744;34306;35355;35813.82093089622;36099.639003610675;36231.09422264464;36647;39157.216855662155;39571;39610.207795843344;39614.40578391269;39657;34911.825440872635;34914.82542587271;35008.824955875054;35274.39465530436;35335.46996794999;24314.87842560776;25059.624105638795;25404.364890877874;25710.742892570834;25896.741032589434 00:02:05 INFO - PID 29174 | |2;jquery.html;551.2062629813066;560.2716468590834;573.4609467100923;580.7734983356492;595.4105435618737;22568.66147007792;22570.322890313277;23365.649515257264;23399.181028664;23432.297031089052;26183.607245891326;26761.330966725793;26771.732282677167;26813.32966675834;26844;6555.606663600187;6641;6704.430123439489;6706.798796036127;6711.228208755982;6007.849803754919;6507.772227972022;6532.412082912537;6558.475321974231;6620.867582648344;6487.286398496161;6490.123833282517;6491.967540162316;6498.3826536478955;6499.155109835715;6465.385788350122;6471.579347342407;6475.740970361227;6478.028295755627;6480.74077036918;5977.671228082454;6022.939770602326;6044.96977515114;6051.727672254759;6058.666773327465;28893.855530722423;29737;30380.69619303801;30387.848060759778;30697.693023069707;1895.810418958107;1910;1912.9808701912941;1925.6245032218724;1934.139308007937;19620.607587848306;20130.79869201304;20178;20293.49266268355;20330.898345508325;2354.6114891042957;2414.5774489464275;2417.6373543968543;2443.169322430382;2490.2280293109193;137350;139928;140790;141825.99999999898;142026;13824.239666818221;14504.927475362767;15080.321385537678;15106.54680359591;15795.131267780152;23824.880875595856;23873.16443924489;23881.283561493183;23898.64152037721;23924.760752392252;10303.227257955683;10347.948260258801;10401;10432.426216558162;10559;9642.084002019797;9673.70978870635;9714;9777.902220977841;9837.55730992107;7947.5231486111015;11474.598389056342;11517.193796434336;11913.642590722293;11951.521939122338;4383.364412160219;4395.7582332972;4405.867823965286;4511.842085526991;4601.723896566216;958.3531116496337;967.6419724701906;981.2199301555138;981.9214462842956;985.1281615769952;19480.318188863323;19717.30989415392;19912.103955322043;20113.899430503046;24143.308408972756;1020.7805321855836;1051.3113910388709;1051.4690081508788;1055.7307886488895;1062.5909025025421;11148.275362101438;11168.553257869757;11452.427378631035;11497.885021149848;11572.94213528927;519545;520453;526337;528565;534672;114138;116126;119652;119816.40091799485;119952.40023799826;1221.2611370121126;1237.6905773556791;1264.7723409786142;1272.236658005208;1283.140296001681;20505.17979280812;20581.279655211994;20726.481837954172;20908.37274881756;21113.366599002056;57045.42954570401;57090;57275.71362143163;57744.71127644335;58411;70847;72495.27504724886;73218;73695;73754.26245737475;12509.249445033327;13308.667283317995;14336.426542938583;14879.404823806926;15090.471833485775;23769.286921392384;23812.88093559521;24364.147254845997;25123;25410;19610.50973725668;19641.31255406054;19894.801051989296;19913.60172796507;20008.2997095101;17293.13534323304;17810.376636817648;17914.46256612304;17974.82025179784;18180;18114.27542898269;18534.536636584195;18544.165512552237;19455.61088778188;20103.698444523052;14760.114393136446;15156.469523566622;15164.317605707549;15188.772168417261;15208.543743687707;18936.242550297833;18967.241310347432;19014.904925475283;19138.904305478383;19249.711254331476 00:02:05 INFO - PID 29174 | |3;mootools.html;1334.6529902225423;1370.7943808428734;1401.558509069643;1407.7958695989075;1413.4134334251294;12068.939655301732;13545.7968130478;14206.21865797382;14209.999999999975;14210.715785684293;12130.81803772942;12278.079144064208;13927.651808704788;14321.713565728705;14323.856761432382;2652.4695060987783;2709.6206531085663;2711.3628297350206;2715.0090217070724;2715.6876959149754;2494.1519883239694;2529.6584961030303;2593.5461294273523;2603.713591504933;2701.4732127235197;2676.1436340371088;2688.045743760966;2688.368233465134;2694.0570800219866;2695.4070104576963;2596.545604519211;2624.1733853836076;2625.343664083979;2632.565626671597;2636.4068084680985;2657.5747880339245;2669.079167687164;2680.6113113598612;2680.9731902681115;2683.946321073587;13720.108192967426;13956.860431395758;14023.088499247517;14044.087134336236;14048.789268160986;7379.778606641809;7618.047744031996;7624.237576242387;7635.809104772369;7638.312551870303;5053.418856831475;5201.24581935621;5260.184671375943;5318.547923426513;5322.509697284767;1869.6073824496873;1893.5834116494486;1906.066027646457;1930.5559721264046;1936.66108431024;22322.77677223223;22486.88756556207;22509.324720258253;22525.887370563043;22563.097476100935;6458.515611329169;6491.350864913471;6720.529562930646;6736.326367363323;6774.390304872585;14960;15661.216939152997;15699.529014129594;15724.29240684172;15739.763903541456;7498.887516687145;7665.540067595962;7677.0403699537555;7690.846183076419;7695.769126926201;6887.139107611549;7115.857682846417;7120.537165084356;7129.18014428337;7177.210506844243;5046.823361182414;5213.348331458567;5234.97382513085;5245.10833158364;5280.498352656491;1478.6007777899906;1491.6121808329913;1499.730048591264;1500.46733409638;1501.6546194375355;858.1761508951477;893.3701740273092;905.0903841639242;905.9728208153766;908.7546362482093;7238.846980067006;7268.600226987566;7286.198518162998;7323.633818309063;7352.676518226664;688.617817111508;713.8893471511924;724.9927500724925;726.6838925067613;735.6101266328855;4823.155947709137;4874.293227481995;5195.571217915028;5270.578353731692;5342.54588359986;17641.117944102745;19109.617807643768;19115.13981870819;19116.904415477835;19119;18590.721139182922;18791.718124228148;18832.52918677044;18873.056347182584;18885.81114188868;9412.717618471457;10111.090001899864;10177.643782467578;10199.439030853226;10244.334118282288;8026.518408895485;8196.508209507449;8350.498970061815;8399.748007559783;8513.106123856905;16173.191340433166;16694;16696.916515417346;16860.325586976385;16907.661846763243;16999.7450038252;17038.403655871985;17129.400470983455;17145.142742863056;17262.654746905242;10964.671059868217;11168.888311116785;11173.832392514281;11187.496562654538;11191.552337906392;13121.671958201121;13243.139195952232;13256.204627722367;13258;13261.867381326063;10485.633002844865;10512.632057877938;10514.737131571772;10574.84137737919;10809.891901081202;10606.787864242518;10641.201909856636;10689.572417103229;10898.618548350769;10919.290246133976;9321.673741419017;9393.248540116638;9412.388194767318;9503.76240593963;9524.904750952679;7192;7228.855422891618;7306.634668266459;7322.780316590511;7338.486305958531;7304.598247096461;7352.669129889061;7365.705371785283;7381.33567978863;7402.814929626802 00:02:05 INFO - PID 29174 | |4;prototype.html;500.3270601041598;501.20558914121114;529.3013222546238;532.893421315737;539.072794792956;6177.536684748645;6188.288346840115;6206.6586337751405;6254.562180647356;6289.874202515947;5933.22868027157;6107.236595425572;6122;6146.723397447115;6148.077788331752;4970.130227210242;4993.350864387625;4997.175466048097;5001.799928002884;5022.045811295842;4888.902221955559;5019.14674505335;5023.7236951967625;5050.419201791786;5054.241863720453;4971.701697898137;4982.153033984231;4998.175301075318;5009.599232061444;5032.4212715537815;4984.675996060263;5012.573931215851;5012.598992080661;5018.272350509174;5026.944341688213;4484.2376795944765;4486.842960496367;4500.639948804121;4507.504174540831;4535.841245556389;6151.87696246077;6158.538109641795;6196.628202307876;6216.813495595139;6218;5674.716264186815;5716.1997320375185;5753.4178101022135;5782.710864456761;5787.942120578825;6476.514261430411;6517.348265173492;6530.6408147551865;6539.574927629689;6573.638449885254;4855.198892182786;4863.8297659582095;4890.266460030988;4909.2881532177635;4914.926276105825;6855.760048398282;6943.201531823855;6957.373836354753;6960.269171736945;6981.406580440668;4993.675411098339;5005.893988132085;5014.648974571818;5063.873403164876;5071.239314102841;5061.164907790247;5070.366204224472;5090.312807770903;5130.204818253177;5132.178851383761;5698.601097923106;5713.771629064669;5739.397363276796;5746.770129194869;5790.160426738099;6448.903266451007;6528.183977002875;6579.901301480481;6594.648097140075;6623.668816559153;1665.300573759024;1710.9828901711073;1715.9056251906266;1745.865187628052;1746.3713063297203;1202.729385888168;1224.7795396828478;1245.2217364147407;1246.4889395347864;1255.6798016505916;5707.71461426927;5713.342965558931;5721.799737009268;5760.308762948473;5769.68266745333;6444.806655800334;6584.341565843473;6641.468682505388;6728.42808361285;6761.492888033417;5728.656280623176;5837.591368604242;5843.1235314703135;5845.7369418376275;5863.442972917566;3548.7515873889097;3598.5321908151773;3604.4773507841214;3619.0952261934517;3636.2363903580545;6493.31820158886;6534.738610455529;6595.208574971034;6611.471082313404;6625.536212465177;6841.281665425158;6932.549384290106;6936.2023367312395;6965.129358830146;6974.4420446364165;6444.420002199825;6491.772787952399;6500.609963402211;6518.185226846645;6606.48050948275;6676.332366763285;6700.93299067003;6715.966420167868;6737.730490780314;6808.127764864702;6687.230968438497;6722.932770672231;6724.562903411263;6741.898871516833;6749.426298764463;6452.548321617442;6460.547761656639;6614.074029635951;6614.933850661432;6650.800475985729;4898.363212782316;4906.607471402351;4925.1873440881855;4962.652614317108;4983.825566105169;6682.9331706682315;6765.729370825112;6796.592204467748;6798.320167983162;6811.863762724817;6446.065320528403;6532.771353002622;6570.211574610886;6589.209294884645;6629.337066293332;6223.813285601439;6349.619022858643;6431.517636177212;6466.515011374072;6515.348465153446;6239.188905442264;6289.654069026247;6324.810255692337;6370.1718776558755;6410.615363078044;6435.420812126931;6486.708098135501;6500.804975850732;6544.345565443417;6545.312742162005;6217.409346112112;6223.751049957951;6272.5922815016875;6311.9269724147925;6340.556161068681 00:02:05 INFO - PID 29174 | |5;yui.html;821.7411515372658;839.3327304792689;845.5265051571124;894.8657701344797;913.2465715784475;18953.431397058077;19725.802741972577;19741.40775776729;19747.703784443245;19839.900800496012;20137;21206.469838254012;21897.890510547466;21931.12275508978;22091.116355345806;1000.1698590170159;1023.3041531758402;1026.3226270661328;1028.5371582787739;1029.0686928329874;994.1053052252958;1003.2876657573132;1003.7741508160678;1003.9799204015916;1031.4842578710645;1066.029912779371;1067.647676266834;1070.4701172919415;1070.8875568065357;1079.2499213046935;1061.6178175856685;1063.5745701719336;1064.302881612545;1064.4092528646597;1072.8766191887917;781.5857595474407;781.8983532140842;782.1357400072894;784.3254800871304;792.2077922077922;19717.408477745692;19821.306254281175;19995.000249987443;20056;20127.496812579804;21090.367288981353;21785;21948.780512194833;22446.438839029153;22487;16767.748483772753;17015.82984170167;17082.487525374134;17199.22603482846;17742.290308387648;3581.964180358189;3615.1504396466808;3624.4382120771324;3626.2928728897878;3638.326909521747;120226;121777.39111304386;127537;128737;131726;17295;17559.12204389801;17929.551761206076;18045;18067.54831129232;32296.515552266734;32316.676833231835;32617.184570385456;32884.67115328864;33048.50427243593;9079.45523268606;9090.590923408463;9122.771930701785;9138.68014619485;9165.77085572866;3891.0855948851995;3908.7068469864876;4011.719179657396;4045.7572545647354;4052.392141178788;4869.391326084239;5064.11378008847;5315.760790764425;5988.341282458926;6207.386079619331;1060.3054998975683;1068.6793961811425;1089.8528698625585;1100.350793032115;1103.7461383881753;655.1025095619033;671.3152584363921;684.9041134241211;686.2862622872157;690.5925503952692;10751.784964300827;11408.543658253742;11608.535658573732;12359.752804943852;12486.387659476773;643.4852118305337;652.7617419641797;653.3074940563018;655.1712084213474;670.0786418674322;5373.140297552451;5404.29744133268;5458.263134476874;5465.988792073479;5558.471945165203;106084;106547;107633;108747.45626271817;112810.43594781973;94591;96355.51822240844;96997;98434;99389;84726.15273847182;87057;88355;89773;90161.54919225493;11874.703132421413;12313.384330783247;12403.875961240272;12470.875291246972;12770.489180432678;37900.43149352817;38862.80568597139;39234.803825980685;39479.80260098796;42144.578554215295;48326.75836620794;50833.491665082875;51108.48891511037;51621.22568161406;52776.208356875446;18279.634407312045;18298.45104646863;18659.253629855197;18787.718184226975;18853.434396968114;21663.241786537397;21782.237621683165;22166.778332216472;22569.5486090274;22752.772472275065;20214.898925505866;20287.391378258675;21011.36965891026;21212.893935530225;21269.255576054762;19506.31727889517;20186.192552297744;20348.89825550863;20499.180032798522;20650.483737906674;20407.795922041183;20464.38606841797;20494.89752551228;20739.377818665464;21221.257255995966;13450.327483625975;14204.715905682035;14207.786883196553;14385.928070359581;14388.446065815531;14138.22239776822;14156.646083847987;14249.002569820013;14253.928730356281;14361.281935902955 00:02:05 INFO - PID 29174 | __end_tp_report 00:02:05 INFO - PID 29174 | __start_cc_report 00:02:05 INFO - PID 29174 | _x_x_mozilla_cycle_collect,361 00:02:05 INFO - PID 29174 | __end_cc_report 00:02:05 INFO - PID 29174 | __startTimestamp1502866925854__endTimestamp 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | ------- Summary: start ------- 00:02:05 INFO - PID 29174 | Number of tests: 6 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | [#0] dojo.html Cycles:165 Average:6123.84 Median:6372.59 stddev:713.25 (11.2%) stddev-sans-first:674.99 00:02:05 INFO - PID 29174 | Values: 3105.3 3117.5 3136.7 3138.1 3186.5 6179.6 6285.2 6316.2 6330.4 6338.3 6051.0 6136.7 6157.4 6169.0 6178.8 5642.4 5664.7 5668.6 5678.3 5719.7 5682.0 5685.2 5691.6 5702.4 5717.7 5729.1 5738.1 5754.1 5764.2 5785.3 5653.5 5728.9 5733.0 5748.1 5798.9 5485.7 5582.1 5584.7 5676.7 5678.7 5863.3 6136.2 6148.2 6149.0 6228.2 6603.1 6634.6 6703.4 6723.5 6725.7 6570.4 6608.8 6685.0 6701.5 6800.0 6219.2 6222.2 6223.8 6227.0 6227.5 6881.4 6915.7 6923.4 6928.9 6930.3 6513.5 6536.1 6543.3 6590.6 6592.1 6507.6 6521.0 6612.7 6637.1 6701.6 6553.4 6555.5 6555.8 6562.7 6572.9 6608.0 6623.5 6626.5 6628.5 6631.8 5404.9 5421.9 5435.6 5437.7 5445.4 4667.1 4680.7 4682.8 4683.1 4694.3 5752.1 5763.9 5767.4 5778.7 5798.1 6570.5 6671.8 6674.5 6675.7 6677.1 5720.9 5760.3 5811.7 5814.1 5820.1 5770.8 5884.9 5887.2 5899.6 5950.1 6410.3 6451.6 6453.6 6465.9 6483.9 6597.5 6638.6 6663.7 6690.5 6720.0 6437.2 6465.5 6475.4 6501.3 6505.3 6417.9 6435.2 6463.9 6556.9 6566.5 6476.6 6598.3 6632.4 6661.3 6675.8 6471.7 6491.3 6543.1 6557.1 6558.6 6442.9 6448.6 6482.4 6547.9 6567.3 6210.9 6319.1 6341.9 6498.7 6499.2 6489.7 6497.3 6542.2 6593.9 6608.8 6188.4 6287.5 6298.8 6350.7 6372.6 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | [#1] ext.html Cycles:180 Average:39584.13 Median:36472.23 stddev:56309.67 (154.4%) stddev-sans-first:56392.39 00:02:05 INFO - PID 29174 | Values: 816.6 823.3 854.0 871.7 876.0 43275.4 43910.8 44139.0 44191.3 44208.3 39892.2 40097.2 40125.2 40300.4 40434.4 6994.8 7113.2 7119.8 7121.3 7121.8 7022.0 7066.4 7070.7 7082.3 7082.6 7741.1 7931.7 7934.1 7937.1 7940.3 7842.6 7906.0 7911.9 7913.0 7921.2 7506.2 7755.0 7755.7 7761.0 7826.6 40689.0 41068.8 41073.8 41081.8 41210.6 3538.3 3585.4 3585.6 3587.6 3591.9 32177.7 32225.2 32267.0 32279.4 32282.8 4976.5 4999.1 5003.8 5015.8 5030.6 215896.0 216900.0 217269.0 217789.0 218182.0 50366.7 50436.2 50518.2 50617.5 50650.5 53273.7 53439.2 53517.0 53579.7 53844.7 16214.5 16228.4 16264.9 16367.9 16423.7 13199.9 13244.7 13247.3 13250.4 13262.3 14426.0 14434.4 14458.2 14499.7 14644.9 5474.5 5542.4 5554.1 5686.0 5705.5 1001.3 1012.5 1017.7 1022.9 1026.5 23491.0 23539.8 23583.6 23681.3 23860.6 1103.3 1103.6 1107.8 1119.5 1122.1 12529.5 12556.6 12658.7 12710.7 12716.5 230426.0 230870.0 231386.0 231603.0 231849.0 54973.5 55564.7 58482.7 59679.7 59789.0 1445.5 1456.2 1461.3 1463.3 1495.5 27947.3 28070.0 28732.7 28868.9 29021.1 34788.5 36382.5 39659.8 39757.0 39783.8 201734.0 201872.0 202544.0 202937.0 203218.0 36562.0 36660.1 36884.6 36925.6 37112.8 43715.8 44944.8 45013.8 45301.5 45609.1 34028.5 34036.5 34162.1 34190.7 34306.0 35355.0 35813.8 36099.6 36231.1 36647.0 39157.2 39571.0 39610.2 39614.4 39657.0 34911.8 34914.8 35008.8 35274.4 35335.5 24314.9 25059.6 25404.4 25710.7 25896.7 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | [#2] jquery.html Cycles:180 Average:36419.67 Median:23382.42 stddev:88194.02 (377.2%) stddev-sans-first:88400.31 00:02:05 INFO - PID 29174 | Values: 551.2 560.3 573.5 580.8 595.4 22568.7 22570.3 23365.6 23399.2 23432.3 26183.6 26761.3 26771.7 26813.3 26844.0 6555.6 6641.0 6704.4 6706.8 6711.2 6007.8 6507.8 6532.4 6558.5 6620.9 6487.3 6490.1 6492.0 6498.4 6499.2 6465.4 6471.6 6475.7 6478.0 6480.7 5977.7 6022.9 6045.0 6051.7 6058.7 28893.9 29737.0 30380.7 30387.8 30697.7 1895.8 1910.0 1913.0 1925.6 1934.1 19620.6 20130.8 20178.0 20293.5 20330.9 2354.6 2414.6 2417.6 2443.2 2490.2 137350.0 139928.0 140790.0 141826.0 142026.0 13824.2 14504.9 15080.3 15106.5 15795.1 23824.9 23873.2 23881.3 23898.6 23924.8 10303.2 10347.9 10401.0 10432.4 10559.0 9642.1 9673.7 9714.0 9777.9 9837.6 7947.5 11474.6 11517.2 11913.6 11951.5 4383.4 4395.8 4405.9 4511.8 4601.7 958.4 967.6 981.2 981.9 985.1 19480.3 19717.3 19912.1 20113.9 24143.3 1020.8 1051.3 1051.5 1055.7 1062.6 11148.3 11168.6 11452.4 11497.9 11572.9 519545.0 520453.0 526337.0 528565.0 534672.0 114138.0 116126.0 119652.0 119816.4 119952.4 1221.3 1237.7 1264.8 1272.2 1283.1 20505.2 20581.3 20726.5 20908.4 21113.4 57045.4 57090.0 57275.7 57744.7 58411.0 70847.0 72495.3 73218.0 73695.0 73754.3 12509.2 13308.7 14336.4 14879.4 15090.5 23769.3 23812.9 24364.1 25123.0 25410.0 19610.5 19641.3 19894.8 19913.6 20008.3 17293.1 17810.4 17914.5 17974.8 18180.0 18114.3 18534.5 18544.2 19455.6 20103.7 14760.1 15156.5 15164.3 15188.8 15208.5 18936.2 18967.2 19014.9 19138.9 19249.7 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | [#3] mootools.html Cycles:180 Average:8610.55 Median:2628.95 stddev:5789.14 (220.2%) stddev-sans-first:5779.56 00:02:05 INFO - PID 29174 | Values: 1334.7 1370.8 1401.6 1407.8 1413.4 12068.9 13545.8 14206.2 14210.0 14210.7 12130.8 12278.1 13927.7 14321.7 14323.9 2652.5 2709.6 2711.4 2715.0 2715.7 2494.2 2529.7 2593.5 2603.7 2701.5 2676.1 2688.0 2688.4 2694.1 2695.4 2596.5 2624.2 2625.3 2632.6 2636.4 2657.6 2669.1 2680.6 2681.0 2683.9 13720.1 13956.9 14023.1 14044.1 14048.8 7379.8 7618.0 7624.2 7635.8 7638.3 5053.4 5201.2 5260.2 5318.5 5322.5 1869.6 1893.6 1906.1 1930.6 1936.7 22322.8 22486.9 22509.3 22525.9 22563.1 6458.5 6491.4 6720.5 6736.3 6774.4 14960.0 15661.2 15699.5 15724.3 15739.8 7498.9 7665.5 7677.0 7690.8 7695.8 6887.1 7115.9 7120.5 7129.2 7177.2 5046.8 5213.3 5235.0 5245.1 5280.5 1478.6 1491.6 1499.7 1500.5 1501.7 858.2 893.4 905.1 906.0 908.8 7238.8 7268.6 7286.2 7323.6 7352.7 688.6 713.9 725.0 726.7 735.6 4823.2 4874.3 5195.6 5270.6 5342.5 17641.1 19109.6 19115.1 19116.9 19119.0 18590.7 18791.7 18832.5 18873.1 18885.8 9412.7 10111.1 10177.6 10199.4 10244.3 8026.5 8196.5 8350.5 8399.7 8513.1 16173.2 16694.0 16696.9 16860.3 16907.7 16999.7 17038.4 17129.4 17145.1 17262.7 10964.7 11168.9 11173.8 11187.5 11191.6 13121.7 13243.1 13256.2 13258.0 13261.9 10485.6 10512.6 10514.7 10574.8 10809.9 10606.8 10641.2 10689.6 10898.6 10919.3 9321.7 9393.2 9412.4 9503.8 9524.9 7192.0 7228.9 7306.6 7322.8 7338.5 7304.6 7352.7 7365.7 7381.3 7402.8 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | [#4] prototype.html Cycles:180 Average:5516.30 Median:6155.21 stddev:1544.03 (25.1%) stddev-sans-first:1501.76 00:02:05 INFO - PID 29174 | Values: 500.3 501.2 529.3 532.9 539.1 6177.5 6188.3 6206.7 6254.6 6289.9 5933.2 6107.2 6122.0 6146.7 6148.1 4970.1 4993.4 4997.2 5001.8 5022.0 4888.9 5019.1 5023.7 5050.4 5054.2 4971.7 4982.2 4998.2 5009.6 5032.4 4984.7 5012.6 5012.6 5018.3 5026.9 4484.2 4486.8 4500.6 4507.5 4535.8 6151.9 6158.5 6196.6 6216.8 6218.0 5674.7 5716.2 5753.4 5782.7 5787.9 6476.5 6517.3 6530.6 6539.6 6573.6 4855.2 4863.8 4890.3 4909.3 4914.9 6855.8 6943.2 6957.4 6960.3 6981.4 4993.7 5005.9 5014.6 5063.9 5071.2 5061.2 5070.4 5090.3 5130.2 5132.2 5698.6 5713.8 5739.4 5746.8 5790.2 6448.9 6528.2 6579.9 6594.6 6623.7 1665.3 1711.0 1715.9 1745.9 1746.4 1202.7 1224.8 1245.2 1246.5 1255.7 5707.7 5713.3 5721.8 5760.3 5769.7 6444.8 6584.3 6641.5 6728.4 6761.5 5728.7 5837.6 5843.1 5845.7 5863.4 3548.8 3598.5 3604.5 3619.1 3636.2 6493.3 6534.7 6595.2 6611.5 6625.5 6841.3 6932.5 6936.2 6965.1 6974.4 6444.4 6491.8 6500.6 6518.2 6606.5 6676.3 6700.9 6716.0 6737.7 6808.1 6687.2 6722.9 6724.6 6741.9 6749.4 6452.5 6460.5 6614.1 6614.9 6650.8 4898.4 4906.6 4925.2 4962.7 4983.8 6682.9 6765.7 6796.6 6798.3 6811.9 6446.1 6532.8 6570.2 6589.2 6629.3 6223.8 6349.6 6431.5 6466.5 6515.3 6239.2 6289.7 6324.8 6370.2 6410.6 6435.4 6486.7 6500.8 6544.3 6545.3 6217.4 6223.8 6272.6 6311.9 6340.6 00:02:05 INFO - PID 29174 | 00:02:05 INFO - PID 29174 | [#5] yui.html Cycles:180 Average:23647.70 Median:20875.37 stddev:31376.95 (150.3%) stddev-sans-first:31418.15 00:02:05 INFO - PID 29174 | Values: 821.7 839.3 845.5 894.9 913.2 18953.4 19725.8 19741.4 19747.7 19839.9 20137.0 21206.5 21897.9 21931.1 22091.1 1000.2 1023.3 1026.3 1028.5 1029.1 994.1 1003.3 1003.8 1004.0 1031.5 1066.0 1067.6 1070.5 1070.9 1079.2 1061.6 1063.6 1064.3 1064.4 1072.9 781.6 781.9 782.1 784.3 792.2 19717.4 19821.3 19995.0 20056.0 20127.5 21090.4 21785.0 21948.8 22446.4 22487.0 16767.7 17015.8 17082.5 17199.2 17742.3 3582.0 3615.2 3624.4 3626.3 3638.3 120226.0 121777.4 127537.0 128737.0 131726.0 17295.0 17559.1 17929.6 18045.0 18067.5 32296.5 32316.7 32617.2 32884.7 33048.5 9079.5 9090.6 9122.8 9138.7 9165.8 3891.1 3908.7 4011.7 4045.8 4052.4 4869.4 5064.1 5315.8 5988.3 6207.4 1060.3 1068.7 1089.9 1100.4 1103.7 655.1 671.3 684.9 686.3 690.6 10751.8 11408.5 11608.5 12359.8 12486.4 643.5 652.8 653.3 655.2 670.1 5373.1 5404.3 5458.3 5466.0 5558.5 106084.0 106547.0 107633.0 108747.5 112810.4 94591.0 96355.5 96997.0 98434.0 99389.0 84726.2 87057.0 88355.0 89773.0 90161.5 11874.7 12313.4 12403.9 12470.9 12770.5 37900.4 38862.8 39234.8 39479.8 42144.6 48326.8 50833.5 51108.5 51621.2 52776.2 18279.6 18298.5 18659.3 18787.7 18853.4 21663.2 21782.2 22166.8 22569.5 22752.8 20214.9 20287.4 21011.4 21212.9 21269.3 19506.3 20186.2 20348.9 20499.2 20650.5 20407.8 20464.4 20494.9 20739.4 21221.3 13450.3 14204.7 14207.8 14385.9 14388.4 14138.2 14156.6 14249.0 14253.9 14361.3 00:02:05 INFO - PID 29174 | -------- Summary: end -------- 00:02:05 INFO - PID 29174 | 00:02:06 INFO - TEST-INFO | 29174: exit 0 00:02:06 INFO - TEST-OK | dromaeo_css | took 1112518ms 00:02:06 INFO - TEST-START | kraken 00:02:06 INFO - Initialising browser for kraken test... 00:02:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48260/getInfo.html -profile /tmp/tmppGRBHe/profile 00:02:06 INFO - TEST-INFO | started process 29551 (/builds/slave/test/build/application/firefox/firefox http://localhost:48260/getInfo.html) 00:02:12 INFO - TEST-INFO | 29551: exit 0 00:02:12 INFO - Browser initialized. 00:02:12 INFO - Running cycle 1/1 for kraken test... 00:02:12 INFO - TEST-INFO | started process 29742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppGRBHe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:02:13 INFO - PID 29742 | 00:02:13 INFO - PID 29742 | (/builds/slave/test/build/application/firefox/firefox:29796): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:02:13 INFO - PID 29742 | 00:02:23 INFO - PID 29742 | RSS: Main: 167329792 00:02:23 INFO - PID 29742 | 00:02:26 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48260/tests/kraken/driver.html?testName=audio-beat-detection) 00:02:27 INFO - PID 29742 | RSS: Main: 173727744 00:02:27 INFO - PID 29742 | 00:02:30 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48260/tests/kraken/driver.html?testName=audio-dft) 00:02:30 INFO - PID 29742 | RSS: Main: 173838336 00:02:30 INFO - PID 29742 | 00:02:33 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48260/tests/kraken/driver.html?testName=audio-fft) 00:02:34 INFO - PID 29742 | RSS: Main: 169762816 00:02:34 INFO - PID 29742 | 00:02:36 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48260/tests/kraken/driver.html?testName=audio-oscillator) 00:02:37 INFO - PID 29742 | RSS: Main: 170233856 00:02:37 INFO - PID 29742 | 00:02:39 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:02:40 INFO - PID 29742 | RSS: Main: 170868736 00:02:40 INFO - PID 29742 | 00:02:43 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48260/tests/kraken/driver.html?testName=imaging-darkroom) 00:02:43 INFO - PID 29742 | RSS: Main: 172875776 00:02:43 INFO - PID 29742 | 00:02:47 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48260/tests/kraken/driver.html?testName=imaging-desaturate) 00:02:47 INFO - PID 29742 | RSS: Main: 172724224 00:02:47 INFO - PID 29742 | 00:02:50 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48260/tests/kraken/driver.html?testName=json-parse-financial) 00:02:51 INFO - PID 29742 | RSS: Main: 173408256 00:02:51 INFO - PID 29742 | 00:02:53 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:02:53 INFO - PID 29742 | RSS: Main: 173473792 00:02:53 INFO - PID 29742 | 00:02:55 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:02:56 INFO - PID 29742 | RSS: Main: 173957120 00:02:56 INFO - PID 29742 | 00:02:58 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:02:59 INFO - PID 29742 | RSS: Main: 173723648 00:02:59 INFO - PID 29742 | 00:03:01 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:03:02 INFO - PID 29742 | RSS: Main: 174350336 00:03:02 INFO - PID 29742 | 00:03:05 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:03:06 INFO - PID 29742 | RSS: Main: 174243840 00:03:06 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | Cycle 1(1): loaded http://localhost:48260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48260/tests/kraken/driver.html?testName=ai-astar) 00:03:08 INFO - PID 29742 | RSS: Main: 175820800 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | __start_tp_report 00:03:08 INFO - PID 29742 | _x_x_mozilla_page_load 00:03:08 INFO - PID 29742 | _x_x_mozilla_page_load_details 00:03:08 INFO - PID 29742 | |i|pagename|runs| 00:03:08 INFO - PID 29742 | |0;ai-astar;98;108;103;110;112;108;114;104;108;119 00:03:08 INFO - PID 29742 | |1;audio-beat-detection;148;119;141;173;123;151;155;117;179;125 00:03:08 INFO - PID 29742 | |2;audio-dft;164;163;162;167;163;161;172;170;162;164 00:03:08 INFO - PID 29742 | |3;audio-fft;75;79;87;181;75;75;75;74;160;76 00:03:08 INFO - PID 29742 | |4;audio-oscillator;78;77;134;79;88;83;134;79;79;126 00:03:08 INFO - PID 29742 | |5;imaging-gaussian-blur;114;115;114;114;114;113;114;114;116;116 00:03:08 INFO - PID 29742 | |6;imaging-darkroom;150;150;153;156;152;152;150;150;151;153 00:03:08 INFO - PID 29742 | |7;imaging-desaturate;93;94;94;97;94;94;94;95;94;94 00:03:08 INFO - PID 29742 | |8;json-parse-financial;60;59;53;53;55;53;59;54;53;53 00:03:08 INFO - PID 29742 | |9;json-stringify-tinderbox;54;53;58;53;53;54;54;54;53;54 00:03:08 INFO - PID 29742 | |10;stanford-crypto-aes;77;78;78;79;86;78;80;80;80;76 00:03:08 INFO - PID 29742 | |11;stanford-crypto-ccm;138;127;130;127;124;140;122;126;126;158 00:03:08 INFO - PID 29742 | |12;stanford-crypto-pbkdf2;187;179;185;184;182;177;188;176;189;178 00:03:08 INFO - PID 29742 | |13;stanford-crypto-sha256-iterative;70;70;68;67;78;70;67;73;69;70 00:03:08 INFO - PID 29742 | __end_tp_report 00:03:08 INFO - PID 29742 | __start_cc_report 00:03:08 INFO - PID 29742 | _x_x_mozilla_cycle_collect,957 00:03:08 INFO - PID 29742 | __end_cc_report 00:03:08 INFO - PID 29742 | __startTimestamp1502866988352__endTimestamp 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | ------- Summary: start ------- 00:03:08 INFO - PID 29742 | Number of tests: 14 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#0] ai-astar Cycles:10 Average:108.40 Median:111.00 stddev:5.93 (5.3%) stddev-sans-first:4.95 00:03:08 INFO - PID 29742 | Values: 98.0 108.0 103.0 110.0 112.0 108.0 114.0 104.0 108.0 119.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.50 stddev:22.13 (14.8%) stddev-sans-first:23.40 00:03:08 INFO - PID 29742 | Values: 148.0 119.0 141.0 173.0 123.0 151.0 155.0 117.0 179.0 125.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:3.68 (2.2%) stddev-sans-first:3.89 00:03:08 INFO - PID 29742 | Values: 164.0 163.0 162.0 167.0 163.0 161.0 172.0 170.0 162.0 164.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#3] audio-fft Cycles:10 Average:95.70 Median:75.00 stddev:39.91 (53.2%) stddev-sans-first:41.63 00:03:08 INFO - PID 29742 | Values: 75.0 79.0 87.0 181.0 75.0 75.0 75.0 74.0 160.0 76.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:79.00 stddev:24.88 (31.5%) stddev-sans-first:25.55 00:03:08 INFO - PID 29742 | Values: 78.0 77.0 134.0 79.0 88.0 83.0 134.0 79.0 79.0 126.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 00:03:08 INFO - PID 29742 | Values: 114.0 115.0 114.0 114.0 114.0 113.0 114.0 114.0 116.0 116.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:1.95 (1.3%) stddev-sans-first:1.96 00:03:08 INFO - PID 29742 | Values: 150.0 150.0 153.0 156.0 152.0 152.0 150.0 150.0 151.0 153.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.06 (1.1%) stddev-sans-first:1.01 00:03:08 INFO - PID 29742 | Values: 93.0 94.0 94.0 97.0 94.0 94.0 94.0 95.0 94.0 94.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:2.94 (5.4%) stddev-sans-first:2.55 00:03:08 INFO - PID 29742 | Values: 60.0 59.0 53.0 53.0 55.0 53.0 59.0 54.0 53.0 53.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:1.49 (2.8%) stddev-sans-first:1.58 00:03:08 INFO - PID 29742 | Values: 54.0 53.0 58.0 53.0 53.0 54.0 54.0 54.0 53.0 54.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.50 stddev:2.74 (3.4%) stddev-sans-first:2.79 00:03:08 INFO - PID 29742 | Values: 77.0 78.0 78.0 79.0 86.0 78.0 80.0 80.0 80.0 76.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:128.50 stddev:10.88 (8.5%) stddev-sans-first:11.31 00:03:08 INFO - PID 29742 | Values: 138.0 127.0 130.0 127.0 124.0 140.0 122.0 126.0 126.0 158.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:184.50 stddev:4.79 (2.6%) stddev-sans-first:4.80 00:03:08 INFO - PID 29742 | Values: 187.0 179.0 185.0 184.0 182.0 177.0 188.0 176.0 189.0 178.0 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:3.26 (4.7%) stddev-sans-first:3.46 00:03:08 INFO - PID 29742 | Values: 70.0 70.0 68.0 67.0 78.0 70.0 67.0 73.0 69.0 70.0 00:03:08 INFO - PID 29742 | -------- Summary: end -------- 00:03:08 INFO - PID 29742 | 00:03:08 INFO - PID 29742 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:03:08 INFO - TEST-INFO | 29742: exit 0 00:03:08 INFO - TEST-OK | kraken | took 62432ms 00:03:08 INFO - SUITE-END | took 1174s 00:03:09 INFO - Completed test suite (00:19:34) 00:03:09 INFO - javascript benchmark 00:03:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8574.755315648383, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.3013072058775, 3117.5011998080313, 3136.7333776628993, 3138.1056398926303, 3186.5379519969606, 6179.598326108806, 6285.182926219585, 6316.210473690789, 6330.430261276484, 6338.271098823637, 6051.0, 6136.723847426865, 6157.445829875311, 6168.969155154218, 6178.783742569011, 5642.379338272786, 5664.716764161796, 5668.631538949955, 5678.34699009613, 5719.714014299289, 5682.034054210773, 5685.1756495308155, 5691.630044047124, 5702.401247868956, 5717.656940583557, 5729.140628905656, 5738.0532212184935, 5754.136879468092, 5764.221830052952, 5785.27684039495, 5653.547716182696, 5728.8854222915725, 5733.0, 5748.109043098327, 5798.9130163047585, 5485.670859748388, 5582.106862901916, 5584.692841893694, 5676.687782171979, 5678.687672178028, 5863.275920030073, 6136.171616831715, 6148.231471066117, 6149.046897730859, 6228.22147231596, 6603.075569420285, 6634.568753031086, 6703.363180497894, 6723.462123030145, 6725.6973436195485, 6570.441512471446, 6608.801735947929, 6684.997250412428, 6701.463882889406, 6800.013997970266, 6219.1604133442315, 6222.191115155046, 6223.813285601439, 6226.968865155645, 6227.470664993481, 6881.41507971828, 6915.654217289216, 6923.446124310144, 6928.930710692828, 6930.272321406281, 6513.478921686348, 6536.084948107269, 6543.280239173687, 6590.637514936629, 6592.077109204715, 6507.642079685568, 6521.0, 6612.669366531654, 6637.070810086591, 6701.597904125768, 6553.377429144223, 6555.541112122201, 6555.770548030796, 6562.737490500422, 6572.868542629216, 6608.041833934052, 6623.503237257225, 6626.469882409396, 6628.53600247978, 6631.767888123893, 5404.946035523035, 5421.864453388618, 5435.565154787608, 5437.673739575638, 5445.37378201504, 4667.136579732693, 4680.7191568506, 4682.812687492462, 4683.1336202802595, 4694.2723877799, 5752.13717942312, 5763.9135412968835, 5767.423257674283, 5778.739956701958, 5798.10129429939, 6570.540062195696, 6671.766488172891, 6674.466042716571, 6675.732970681215, 6677.065210870482, 5720.885582288331, 5760.308762948473, 5811.738471768781, 5814.069748840166, 5820.126980952891, 5770.798022069207, 5884.882302353929, 5887.175795388649, 5899.587028908021, 5950.077737950624, 6410.262819775692, 6451.645159516272, 6453.580517266362, 6465.903011454832, 6483.870322593428, 6597.505187111082, 6638.601683898982, 6663.733450661919, 6690.498212634169, 6720.0255962886085, 6437.163168788027, 6465.450436712932, 6475.449586785176, 6501.317361677145, 6505.316941721051, 6417.935820641734, 6435.163428754232, 6463.903041454288, 6556.901646475211, 6566.507511936719, 6476.579022363531, 6598.3401659833635, 6632.436242919406, 6661.333866613494, 6675.833104172434, 6471.708773105127, 6491.318411566906, 6543.051257567721, 6557.114789503356, 6558.606483610999, 6442.903356449563, 6448.645324507197, 6482.448991835558, 6547.901781473186, 6567.343265673395, 6210.875782484415, 6319.083732858801, 6341.936580634135, 6498.707558159799, 6499.1876015498065, 6489.707963141765, 6497.285298617054, 6542.214934207926, 6593.901091483727, 6608.834779130368, 6188.3502232266765, 6287.46556542699, 6298.779542715983, 6350.68246587678, 6372.58578192416], "value": 6070.7378769868255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.5672193737321, 823.3207603726927, 853.9530325832079, 871.7297637732299, 875.9518226497543, 43275.35086973694, 43910.78044609781, 44139.0, 44191.33712994304, 44208.3368749469, 39892.20215595686, 40097.19805603886, 40125.19749605006, 40300.39549406761, 40434.39348409769, 6994.755183568576, 7113.181984071821, 7119.8220044498785, 7121.323474269936, 7121.8219544511285, 7022.0, 7066.434685225169, 7070.681819318143, 7082.291770822928, 7082.610456424894, 7741.109772376164, 7931.682732690714, 7934.087579928296, 7937.12691603926, 7940.325072368855, 7842.568658723768, 7905.960470197612, 7911.920880791176, 7913.0, 7921.247481489249, 7506.249375062504, 7754.961225193894, 7755.689772409097, 7760.961195193988, 7826.5695386753705, 40689.0, 41068.794656026825, 41073.794631026954, 41081.79459102715, 41210.587894120974, 3538.2569660371355, 3585.372559802024, 3585.623509531488, 3587.641235876418, 3591.94612080819, 32177.678223217703, 32225.1943701407, 32267.0, 32279.354412911845, 32282.838585807156, 4976.45259021511, 4999.075171093323, 5003.774830132653, 5015.849524514234, 5030.597552195815, 215896.0, 216899.99999999843, 217269.0, 217789.0, 218181.9999999984, 50366.748166258934, 50436.24345634819, 50518.24222636663, 50617.493825061276, 50650.49349506458, 53273.7336313316, 53439.19841202385, 53517.0, 53579.73210134002, 53844.73077634587, 16214.51356459308, 16228.43200488001, 16264.918675406547, 16367.91816040912, 16423.6715265694, 13199.934000329937, 13244.668883277802, 13247.271400072896, 13250.403731832092, 13262.27057511846, 14426.0, 14434.422623094959, 14458.204798736171, 14499.710005799825, 14644.926775366055, 5474.479924407175, 5542.445755424506, 5554.1391084381985, 5685.971570142123, 5705.486506214461, 1001.3090967232587, 1012.4633944009687, 1017.7353887989028, 1022.8516865054675, 1026.5175367577226, 23491.0, 23539.764602353756, 23583.646245306336, 23681.289561313188, 23860.64209036866, 1103.3435106111851, 1103.586155191803, 1107.7562936154034, 1119.462657924201, 1122.091106203961, 12529.498820047096, 12556.623301300975, 12658.746825063447, 12710.745785084246, 12716.491340346467, 230426.0, 230870.0, 231386.0, 231603.0, 231849.0, 54973.45026549683, 55564.72217638886, 58482.707586462646, 59679.70160149172, 59789.0, 1445.515752222996, 1456.2136446318868, 1461.2547600723708, 1463.3488097796378, 1495.5289083938524, 27947.301317467227, 28070.0, 28732.71267287384, 28868.855655721585, 29021.12936611905, 34788.47817282692, 36382.454263186606, 39659.80170099131, 39757.0, 39783.80108099557, 201734.0, 201872.0, 202544.0, 202937.0, 203218.0, 36562.0, 36660.08349791277, 36884.63115368812, 36925.63074369222, 37112.81443592765, 43715.78142109396, 44944.77527612341, 45013.77493112513, 45301.546984529734, 45609.087818244116, 34028.48957265692, 34036.48945265773, 34162.14594635154, 34190.658093418744, 34306.0, 35355.0, 35813.82093089622, 36099.639003610675, 36231.09422264464, 36647.0, 39157.216855662155, 39571.0, 39610.207795843344, 39614.40578391269, 39657.0, 34911.825440872635, 34914.82542587271, 35008.824955875054, 35274.39465530436, 35335.46996794999, 24314.87842560776, 25059.624105638795, 25404.364890877874, 25710.742892570834, 25896.741032589434], "value": 17737.67344690329, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.2062629813066, 560.2716468590834, 573.4609467100923, 580.7734983356492, 595.4105435618737, 22568.66147007792, 22570.322890313277, 23365.649515257264, 23399.181028664, 23432.297031089052, 26183.607245891326, 26761.330966725793, 26771.732282677167, 26813.32966675834, 26844.0, 6555.606663600187, 6641.0, 6704.430123439489, 6706.798796036127, 6711.228208755982, 6007.849803754919, 6507.772227972022, 6532.412082912537, 6558.475321974231, 6620.867582648344, 6487.286398496161, 6490.123833282517, 6491.967540162316, 6498.3826536478955, 6499.155109835715, 6465.385788350122, 6471.579347342407, 6475.740970361227, 6478.028295755627, 6480.74077036918, 5977.671228082454, 6022.939770602326, 6044.96977515114, 6051.727672254759, 6058.666773327465, 28893.855530722423, 29737.0, 30380.69619303801, 30387.848060759778, 30697.693023069707, 1895.810418958107, 1910.0, 1912.9808701912941, 1925.6245032218724, 1934.139308007937, 19620.607587848306, 20130.79869201304, 20178.0, 20293.49266268355, 20330.898345508325, 2354.6114891042957, 2414.5774489464275, 2417.6373543968543, 2443.169322430382, 2490.2280293109193, 137350.0, 139928.0, 140790.0, 141825.99999999898, 142026.0, 13824.239666818221, 14504.927475362767, 15080.321385537678, 15106.54680359591, 15795.131267780152, 23824.880875595856, 23873.16443924489, 23881.283561493183, 23898.64152037721, 23924.760752392252, 10303.227257955683, 10347.948260258801, 10401.0, 10432.426216558162, 10559.0, 9642.084002019797, 9673.70978870635, 9714.0, 9777.902220977841, 9837.55730992107, 7947.5231486111015, 11474.598389056342, 11517.193796434336, 11913.642590722293, 11951.521939122338, 4383.364412160219, 4395.7582332972, 4405.867823965286, 4511.842085526991, 4601.723896566216, 958.3531116496337, 967.6419724701906, 981.2199301555138, 981.9214462842956, 985.1281615769952, 19480.318188863323, 19717.30989415392, 19912.103955322043, 20113.899430503046, 24143.308408972756, 1020.7805321855836, 1051.3113910388709, 1051.4690081508788, 1055.7307886488895, 1062.5909025025421, 11148.275362101438, 11168.553257869757, 11452.427378631035, 11497.885021149848, 11572.94213528927, 519545.0, 520453.0, 526337.0, 528565.0, 534672.0, 114138.0, 116126.0, 119652.0, 119816.40091799485, 119952.40023799826, 1221.2611370121126, 1237.6905773556791, 1264.7723409786142, 1272.236658005208, 1283.140296001681, 20505.17979280812, 20581.279655211994, 20726.481837954172, 20908.37274881756, 21113.366599002056, 57045.42954570401, 57090.0, 57275.71362143163, 57744.71127644335, 58411.0, 70847.0, 72495.27504724886, 73218.0, 73695.0, 73754.26245737475, 12509.249445033327, 13308.667283317995, 14336.426542938583, 14879.404823806926, 15090.471833485775, 23769.286921392384, 23812.88093559521, 24364.147254845997, 25123.0, 25410.0, 19610.50973725668, 19641.31255406054, 19894.801051989296, 19913.60172796507, 20008.2997095101, 17293.13534323304, 17810.376636817648, 17914.46256612304, 17974.82025179784, 18180.0, 18114.27542898269, 18534.536636584195, 18544.165512552237, 19455.61088778188, 20103.698444523052, 14760.114393136446, 15156.469523566622, 15164.317605707549, 15188.772168417261, 15208.543743687707, 18936.242550297833, 18967.241310347432, 19014.904925475283, 19138.904305478383, 19249.711254331476], "value": 12475.204859785383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.6529902225423, 1370.7943808428734, 1401.558509069643, 1407.7958695989075, 1413.4134334251294, 12068.939655301732, 13545.7968130478, 14206.21865797382, 14209.999999999975, 14210.715785684293, 12130.81803772942, 12278.079144064208, 13927.651808704788, 14321.713565728705, 14323.856761432382, 2652.4695060987783, 2709.6206531085663, 2711.3628297350206, 2715.0090217070724, 2715.6876959149754, 2494.1519883239694, 2529.6584961030303, 2593.5461294273523, 2603.713591504933, 2701.4732127235197, 2676.1436340371088, 2688.045743760966, 2688.368233465134, 2694.0570800219866, 2695.4070104576963, 2596.545604519211, 2624.1733853836076, 2625.343664083979, 2632.565626671597, 2636.4068084680985, 2657.5747880339245, 2669.079167687164, 2680.6113113598612, 2680.9731902681115, 2683.946321073587, 13720.108192967426, 13956.860431395758, 14023.088499247517, 14044.087134336236, 14048.789268160986, 7379.778606641809, 7618.047744031996, 7624.237576242387, 7635.809104772369, 7638.312551870303, 5053.418856831475, 5201.24581935621, 5260.184671375943, 5318.547923426513, 5322.509697284767, 1869.6073824496873, 1893.5834116494486, 1906.066027646457, 1930.5559721264046, 1936.66108431024, 22322.77677223223, 22486.88756556207, 22509.324720258253, 22525.887370563043, 22563.097476100935, 6458.515611329169, 6491.350864913471, 6720.529562930646, 6736.326367363323, 6774.390304872585, 14960.0, 15661.216939152997, 15699.529014129594, 15724.29240684172, 15739.763903541456, 7498.887516687145, 7665.540067595962, 7677.0403699537555, 7690.846183076419, 7695.769126926201, 6887.139107611549, 7115.857682846417, 7120.537165084356, 7129.18014428337, 7177.210506844243, 5046.823361182414, 5213.348331458567, 5234.97382513085, 5245.10833158364, 5280.498352656491, 1478.6007777899906, 1491.6121808329913, 1499.730048591264, 1500.46733409638, 1501.6546194375355, 858.1761508951477, 893.3701740273092, 905.0903841639242, 905.9728208153766, 908.7546362482093, 7238.846980067006, 7268.600226987566, 7286.198518162998, 7323.633818309063, 7352.676518226664, 688.617817111508, 713.8893471511924, 724.9927500724925, 726.6838925067613, 735.6101266328855, 4823.155947709137, 4874.293227481995, 5195.571217915028, 5270.578353731692, 5342.54588359986, 17641.117944102745, 19109.617807643768, 19115.13981870819, 19116.904415477835, 19119.0, 18590.721139182922, 18791.718124228148, 18832.52918677044, 18873.056347182584, 18885.81114188868, 9412.717618471457, 10111.090001899864, 10177.643782467578, 10199.439030853226, 10244.334118282288, 8026.518408895485, 8196.508209507449, 8350.498970061815, 8399.748007559783, 8513.106123856905, 16173.191340433166, 16694.0, 16696.916515417346, 16860.325586976385, 16907.661846763243, 16999.7450038252, 17038.403655871985, 17129.400470983455, 17145.142742863056, 17262.654746905242, 10964.671059868217, 11168.888311116785, 11173.832392514281, 11187.496562654538, 11191.552337906392, 13121.671958201121, 13243.139195952232, 13256.204627722367, 13258.0, 13261.867381326063, 10485.633002844865, 10512.632057877938, 10514.737131571772, 10574.84137737919, 10809.891901081202, 10606.787864242518, 10641.201909856636, 10689.572417103229, 10898.618548350769, 10919.290246133976, 9321.673741419017, 9393.248540116638, 9412.388194767318, 9503.76240593963, 9524.904750952679, 7192.0, 7228.855422891618, 7306.634668266459, 7322.780316590511, 7338.486305958531, 7304.598247096461, 7352.669129889061, 7365.705371785283, 7381.33567978863, 7402.814929626802], "value": 6296.829686793246, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.3270601041598, 501.20558914121114, 529.3013222546238, 532.893421315737, 539.072794792956, 6177.536684748645, 6188.288346840115, 6206.6586337751405, 6254.562180647356, 6289.874202515947, 5933.22868027157, 6107.236595425572, 6122.0, 6146.723397447115, 6148.077788331752, 4970.130227210242, 4993.350864387625, 4997.175466048097, 5001.799928002884, 5022.045811295842, 4888.902221955559, 5019.14674505335, 5023.7236951967625, 5050.419201791786, 5054.241863720453, 4971.701697898137, 4982.153033984231, 4998.175301075318, 5009.599232061444, 5032.4212715537815, 4984.675996060263, 5012.573931215851, 5012.598992080661, 5018.272350509174, 5026.944341688213, 4484.2376795944765, 4486.842960496367, 4500.639948804121, 4507.504174540831, 4535.841245556389, 6151.87696246077, 6158.538109641795, 6196.628202307876, 6216.813495595139, 6218.0, 5674.716264186815, 5716.1997320375185, 5753.4178101022135, 5782.710864456761, 5787.942120578825, 6476.514261430411, 6517.348265173492, 6530.6408147551865, 6539.574927629689, 6573.638449885254, 4855.198892182786, 4863.8297659582095, 4890.266460030988, 4909.2881532177635, 4914.926276105825, 6855.760048398282, 6943.201531823855, 6957.373836354753, 6960.269171736945, 6981.406580440668, 4993.675411098339, 5005.893988132085, 5014.648974571818, 5063.873403164876, 5071.239314102841, 5061.164907790247, 5070.366204224472, 5090.312807770903, 5130.204818253177, 5132.178851383761, 5698.601097923106, 5713.771629064669, 5739.397363276796, 5746.770129194869, 5790.160426738099, 6448.903266451007, 6528.183977002875, 6579.901301480481, 6594.648097140075, 6623.668816559153, 1665.300573759024, 1710.9828901711073, 1715.9056251906266, 1745.865187628052, 1746.3713063297203, 1202.729385888168, 1224.7795396828478, 1245.2217364147407, 1246.4889395347864, 1255.6798016505916, 5707.71461426927, 5713.342965558931, 5721.799737009268, 5760.308762948473, 5769.68266745333, 6444.806655800334, 6584.341565843473, 6641.468682505388, 6728.42808361285, 6761.492888033417, 5728.656280623176, 5837.591368604242, 5843.1235314703135, 5845.7369418376275, 5863.442972917566, 3548.7515873889097, 3598.5321908151773, 3604.4773507841214, 3619.0952261934517, 3636.2363903580545, 6493.31820158886, 6534.738610455529, 6595.208574971034, 6611.471082313404, 6625.536212465177, 6841.281665425158, 6932.549384290106, 6936.2023367312395, 6965.129358830146, 6974.4420446364165, 6444.420002199825, 6491.772787952399, 6500.609963402211, 6518.185226846645, 6606.48050948275, 6676.332366763285, 6700.93299067003, 6715.966420167868, 6737.730490780314, 6808.127764864702, 6687.230968438497, 6722.932770672231, 6724.562903411263, 6741.898871516833, 6749.426298764463, 6452.548321617442, 6460.547761656639, 6614.074029635951, 6614.933850661432, 6650.800475985729, 4898.363212782316, 4906.607471402351, 4925.1873440881855, 4962.652614317108, 4983.825566105169, 6682.9331706682315, 6765.729370825112, 6796.592204467748, 6798.320167983162, 6811.863762724817, 6446.065320528403, 6532.771353002622, 6570.211574610886, 6589.209294884645, 6629.337066293332, 6223.813285601439, 6349.619022858643, 6431.517636177212, 6466.515011374072, 6515.348465153446, 6239.188905442264, 6289.654069026247, 6324.810255692337, 6370.1718776558755, 6410.615363078044, 6435.420812126931, 6486.708098135501, 6500.804975850732, 6544.345565443417, 6545.312742162005, 6217.409346112112, 6223.751049957951, 6272.5922815016875, 6311.9269724147925, 6340.556161068681], "value": 5062.658831671877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.7411515372658, 839.3327304792689, 845.5265051571124, 894.8657701344797, 913.2465715784475, 18953.431397058077, 19725.802741972577, 19741.40775776729, 19747.703784443245, 19839.900800496012, 20137.0, 21206.469838254012, 21897.890510547466, 21931.12275508978, 22091.116355345806, 1000.1698590170159, 1023.3041531758402, 1026.3226270661328, 1028.5371582787739, 1029.0686928329874, 994.1053052252958, 1003.2876657573132, 1003.7741508160678, 1003.9799204015916, 1031.4842578710645, 1066.029912779371, 1067.647676266834, 1070.4701172919415, 1070.8875568065357, 1079.2499213046935, 1061.6178175856685, 1063.5745701719336, 1064.302881612545, 1064.4092528646597, 1072.8766191887917, 781.5857595474407, 781.8983532140842, 782.1357400072894, 784.3254800871304, 792.2077922077922, 19717.408477745692, 19821.306254281175, 19995.000249987443, 20056.0, 20127.496812579804, 21090.367288981353, 21785.0, 21948.780512194833, 22446.438839029153, 22487.0, 16767.748483772753, 17015.82984170167, 17082.487525374134, 17199.22603482846, 17742.290308387648, 3581.964180358189, 3615.1504396466808, 3624.4382120771324, 3626.2928728897878, 3638.326909521747, 120226.0, 121777.39111304386, 127537.0, 128737.0, 131726.0, 17295.0, 17559.12204389801, 17929.551761206076, 18045.0, 18067.54831129232, 32296.515552266734, 32316.676833231835, 32617.184570385456, 32884.67115328864, 33048.50427243593, 9079.45523268606, 9090.590923408463, 9122.771930701785, 9138.68014619485, 9165.77085572866, 3891.0855948851995, 3908.7068469864876, 4011.719179657396, 4045.7572545647354, 4052.392141178788, 4869.391326084239, 5064.11378008847, 5315.760790764425, 5988.341282458926, 6207.386079619331, 1060.3054998975683, 1068.6793961811425, 1089.8528698625585, 1100.350793032115, 1103.7461383881753, 655.1025095619033, 671.3152584363921, 684.9041134241211, 686.2862622872157, 690.5925503952692, 10751.784964300827, 11408.543658253742, 11608.535658573732, 12359.752804943852, 12486.387659476773, 643.4852118305337, 652.7617419641797, 653.3074940563018, 655.1712084213474, 670.0786418674322, 5373.140297552451, 5404.29744133268, 5458.263134476874, 5465.988792073479, 5558.471945165203, 106084.0, 106547.0, 107633.0, 108747.45626271817, 112810.43594781973, 94591.0, 96355.51822240844, 96997.0, 98434.0, 99389.0, 84726.15273847182, 87057.0, 88355.0, 89773.0, 90161.54919225493, 11874.703132421413, 12313.384330783247, 12403.875961240272, 12470.875291246972, 12770.489180432678, 37900.43149352817, 38862.80568597139, 39234.803825980685, 39479.80260098796, 42144.578554215295, 48326.75836620794, 50833.491665082875, 51108.48891511037, 51621.22568161406, 52776.208356875446, 18279.634407312045, 18298.45104646863, 18659.253629855197, 18787.718184226975, 18853.434396968114, 21663.241786537397, 21782.237621683165, 22166.778332216472, 22569.5486090274, 22752.772472275065, 20214.898925505866, 20287.391378258675, 21011.36965891026, 21212.893935530225, 21269.255576054762, 19506.31727889517, 20186.192552297744, 20348.89825550863, 20499.180032798522, 20650.483737906674, 20407.795922041183, 20464.38606841797, 20494.89752551228, 20739.377818665464, 21221.257255995966, 13450.327483625975, 14204.715905682035, 14207.786883196553, 14385.928070359581, 14388.446065815531, 14138.22239776822, 14156.646083847987, 14249.002569820013, 14253.928730356281, 14361.281935902955], "value": 9281.442931862457, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 103.0, 110.0, 112.0, 108.0, 114.0, 104.0, 108.0, 119.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 141.0, 173.0, 123.0, 151.0, 155.0, 117.0, 179.0, 125.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 167.0, 163.0, 161.0, 172.0, 170.0, 162.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 87.0, 181.0, 75.0, 75.0, 75.0, 74.0, 160.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 134.0, 79.0, 88.0, 83.0, 134.0, 79.0, 79.0, 126.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 116.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 153.0, 156.0, 152.0, 152.0, 150.0, 150.0, 151.0, 153.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 97.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 53.0, 53.0, 55.0, 53.0, 59.0, 54.0, 53.0, 53.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 58.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 79.0, 86.0, 78.0, 80.0, 80.0, 80.0, 76.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 127.0, 130.0, 127.0, 124.0, 140.0, 122.0, 126.0, 126.0, 158.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 179.0, 185.0, 184.0, 182.0, 177.0, 188.0, 176.0, 189.0, 178.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 67.0, 78.0, 70.0, 67.0, 73.0, 69.0, 70.0], "value": 70.2, "unit": "score"}]}]} 00:03:09 INFO - Return code: 0 00:03:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:03:09 INFO - # TBPL SUCCESS # 00:03:09 INFO - Running post-action listener: _package_coverage_data 00:03:09 INFO - Running post-action listener: _resource_record_post_action 00:03:09 INFO - [mozharness: 2017-08-16 07:03:09.154272Z] Finished run-tests step (success) 00:03:09 INFO - Running post-run listener: _resource_record_post_run 00:03:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 430178304; Read time: 156; Write time: 275760 00:03:09 INFO - TinderboxPrint: CPU usage
13.1% 00:03:09 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 156 00:03:09 INFO - TinderboxPrint: I/O write bytes / time
430,178,304 / 275,760 00:03:09 INFO - TinderboxPrint: CPU idle
8,262.5 (86.9%) 00:03:09 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 00:03:09 INFO - TinderboxPrint: Swap in / out
0 / 0 00:03:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107143168; Read time: 0; Write time: 83348 00:03:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:03:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323035136; Read time: 144; Write time: 192412 00:03:09 INFO - Running post-run listener: _upload_blobber_files 00:03:09 INFO - Blob upload gear active. 00:03:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:03:09 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 00:03:09 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'] 00:03:09 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 00:03:10 INFO - (blobuploader) - INFO - Open directory for files ... 00:03:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:03:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:11 INFO - (blobuploader) - INFO - Done attempting. 00:03:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:03:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:17 INFO - (blobuploader) - INFO - Done attempting. 00:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:03:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:18 INFO - (blobuploader) - INFO - Done attempting. 00:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:19 INFO - (blobuploader) - INFO - Done attempting. 00:03:19 INFO - (blobuploader) - INFO - Iteration through files over. 00:03:19 INFO - Return code: 0 00:03:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:03:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:03:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4de98eed60229c516f3e68c973c411bd50e5dc483b90509fafb86a69c2a0a6f6b76487bb35a5865f9ce4d7a96efbac73eb07b5705696330bf290108580ff140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac6a69875dbecc262c60cc0e4fa135d8399a299bf4ecb41c43a652609ab5d5d786c13ae61f3bc9a3ec7ed63c2352acd3312638eabb84566186c7d63a8681bde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bdc1a10c05e5afcac5ab69b713473d3d61a06d6e82bb0e862e2940e1b34b1a1e1c529cc710c037dbda766ae25739c890f7b7811e0d109bce6ca6a30a1247a9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeff9438b06c6fcf8230f8aa30e69efc0be009c87cf3e0c963a52b0848f0503a7d205a5548cdf680c2c5784dc5c7c2e16cbbbc1a6540cb139e7cabd0b685d810"} 00:03:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:03:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:03:19 INFO - Contents: 00:03:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4de98eed60229c516f3e68c973c411bd50e5dc483b90509fafb86a69c2a0a6f6b76487bb35a5865f9ce4d7a96efbac73eb07b5705696330bf290108580ff140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac6a69875dbecc262c60cc0e4fa135d8399a299bf4ecb41c43a652609ab5d5d786c13ae61f3bc9a3ec7ed63c2352acd3312638eabb84566186c7d63a8681bde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bdc1a10c05e5afcac5ab69b713473d3d61a06d6e82bb0e862e2940e1b34b1a1e1c529cc710c037dbda766ae25739c890f7b7811e0d109bce6ca6a30a1247a9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeff9438b06c6fcf8230f8aa30e69efc0be009c87cf3e0c963a52b0848f0503a7d205a5548cdf680c2c5784dc5c7c2e16cbbbc1a6540cb139e7cabd0b685d810"} 00:03:19 INFO - Running post-run listener: copy_logs_to_upload_dir 00:03:19 INFO - Copying logs to upload dir... 00:03:19 INFO - mkdir: /builds/slave/test/build/upload/logs 00:03:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.074934 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-16 00:03:19.080211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:19.083593) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4de98eed60229c516f3e68c973c411bd50e5dc483b90509fafb86a69c2a0a6f6b76487bb35a5865f9ce4d7a96efbac73eb07b5705696330bf290108580ff140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac6a69875dbecc262c60cc0e4fa135d8399a299bf4ecb41c43a652609ab5d5d786c13ae61f3bc9a3ec7ed63c2352acd3312638eabb84566186c7d63a8681bde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bdc1a10c05e5afcac5ab69b713473d3d61a06d6e82bb0e862e2940e1b34b1a1e1c529cc710c037dbda766ae25739c890f7b7811e0d109bce6ca6a30a1247a9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeff9438b06c6fcf8230f8aa30e69efc0be009c87cf3e0c963a52b0848f0503a7d205a5548cdf680c2c5784dc5c7c2e16cbbbc1a6540cb139e7cabd0b685d810"} build_url:https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4de98eed60229c516f3e68c973c411bd50e5dc483b90509fafb86a69c2a0a6f6b76487bb35a5865f9ce4d7a96efbac73eb07b5705696330bf290108580ff140", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac6a69875dbecc262c60cc0e4fa135d8399a299bf4ecb41c43a652609ab5d5d786c13ae61f3bc9a3ec7ed63c2352acd3312638eabb84566186c7d63a8681bde", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bdc1a10c05e5afcac5ab69b713473d3d61a06d6e82bb0e862e2940e1b34b1a1e1c529cc710c037dbda766ae25739c890f7b7811e0d109bce6ca6a30a1247a9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eeff9438b06c6fcf8230f8aa30e69efc0be009c87cf3e0c963a52b0848f0503a7d205a5548cdf680c2c5784dc5c7c2e16cbbbc1a6540cb139e7cabd0b685d810"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:19.112359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:19.112750) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502863025.5740-2121142589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:19.198635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 00:03:19.198989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 00:03:19.199346) ========= ========= Total master_lag: 0.20 =========