builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1500297135.87 results: success (0) revision: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:15.868133) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:15.868733) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:15.869010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:15.885188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:15.885464) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 06:12:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.2K=0.2s 2017-07-17 06:12:16 (58.2 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.335338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:16.234810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:16.235120) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019299 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:16.284267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 06:12:16.284617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d43779e278d2e4d3e21dba2fcb585a3bf4b1288e --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 d43779e278d2e4d3e21dba2fcb585a3bf4b1288e --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=82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 06:12:16,506 truncating revision to first 12 chars 2017-07-17 06:12:16,506 Setting DEBUG logging. 2017-07-17 06:12:16,506 attempt 1/10 2017-07-17 06:12:16,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d43779e278d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 06:12:17,902 unpacking tar archive at: mozilla-central-d43779e278d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.724600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 06:12:18.021396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:18.021727) ========= script_repo_revision: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:18.022098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:18.022362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 06:12:18.029406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-17 06:12:18.029680) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:12:18 INFO - MultiFileLogger online at 20170717 06:12:18 in /builds/slave/test 06:12:18 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 06:12:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:12:18 INFO - {'append_to_log': False, 06:12:18 INFO - 'base_work_dir': '/builds/slave/test', 06:12:18 INFO - 'blob_upload_branch': 'Firefox', 06:12:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:12:18 INFO - 'branch': 'Firefox', 06:12:18 INFO - 'buildbot_json_path': 'buildprops.json', 06:12:18 INFO - 'code_coverage': False, 06:12:18 INFO - 'config_files': ('talos/linux_config.py',), 06:12:18 INFO - 'default_actions': ('clobber', 06:12:18 INFO - 'read-buildbot-config', 06:12:18 INFO - 'download-and-extract', 06:12:18 INFO - 'populate-webroot', 06:12:18 INFO - 'create-virtualenv', 06:12:18 INFO - 'install', 06:12:18 INFO - 'setup-mitmproxy', 06:12:18 INFO - 'run-tests'), 06:12:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:12:18 INFO - 'disable_ccov_upload': False, 06:12:18 INFO - 'download_minidump_stackwalk': True, 06:12:18 INFO - 'download_symbols': 'ondemand', 06:12:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:12:18 INFO - 'tooltool.py': '/tools/tooltool.py', 06:12:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:12:18 INFO - '/tools/misc-python/virtualenv.py')}, 06:12:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:12:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:12:18 INFO - 'gecko_profile': False, 06:12:18 INFO - 'gecko_profile_interval': 0, 06:12:18 INFO - 'installer_path': 'installer.exe', 06:12:18 INFO - 'log_level': 'info', 06:12:18 INFO - 'log_name': 'talos', 06:12:18 INFO - 'log_to_console': True, 06:12:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:12:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:12:18 INFO - 'opt_config_files': (), 06:12:18 INFO - 'pip_index': False, 06:12:18 INFO - 'suite': 'dromaeojs-e10s', 06:12:18 INFO - 'system_bits': '32', 06:12:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:12:18 INFO - 'title': 'talos-linux64-ix-066', 06:12:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:12:18 INFO - 'use_talos_json': True, 06:12:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:12:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:12:18 INFO - 'work_dir': 'build'} 06:12:18 INFO - [mozharness: 2017-07-17 13:12:18.357035Z] Running clobber step. 06:12:18 INFO - Running pre-action listener: _resource_record_pre_action 06:12:18 INFO - Running main action method: clobber 06:12:18 INFO - rmtree: /builds/slave/test/build 06:12:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:12:19 INFO - Running post-action listener: _resource_record_post_action 06:12:19 INFO - [mozharness: 2017-07-17 13:12:19.906145Z] Finished clobber step (success) 06:12:19 INFO - [mozharness: 2017-07-17 13:12:19.906248Z] Running read-buildbot-config step. 06:12:19 INFO - Running pre-action listener: _resource_record_pre_action 06:12:19 INFO - Running main action method: read_buildbot_config 06:12:19 INFO - Using buildbot properties: 06:12:19 INFO - { 06:12:19 INFO - "project": "", 06:12:19 INFO - "product": "firefox", 06:12:19 INFO - "who": "archaeopteryx@coole-files.de", 06:12:19 INFO - "installer_path": "public/build/target.tar.bz2", 06:12:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:12:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:12:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:12:19 INFO - "stage_platform": "linux64-pgo", 06:12:19 INFO - "basedir": "/builds/slave/test", 06:12:19 INFO - "buildnumber": 72, 06:12:19 INFO - "platform": "ubuntu64_hw", 06:12:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:12:19 INFO - "slavebuilddir": "test", 06:12:19 INFO - "taskId": "QYQPhs_qRnasDdnC1DBpyQ", 06:12:19 INFO - "branch": "mozilla-central", 06:12:19 INFO - "script_repo_revision": "production", 06:12:19 INFO - "revision": "d43779e278d2e4d3e21dba2fcb585a3bf4b1288e", 06:12:19 INFO - "slavename": "talos-linux64-ix-066", 06:12:19 INFO - "repo_path": "mozilla-central" 06:12:19 INFO - } 06:12:19 INFO - Finding installer, test and symbols from parent task. 06:12:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QYQPhs_qRnasDdnC1DBpyQ'}, attempt #1 06:12:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QYQPhs_qRnasDdnC1DBpyQ'}, attempt #1 06:12:20 INFO - Task dependencies: OC58s0ltQJmDlTRMwlff_Q 06:12:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q'}, attempt #1 06:12:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2 06:12:21 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/test_packages.json 06:12:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.crashreporter-symbols.zip 06:12:21 INFO - Running post-action listener: _resource_record_post_action 06:12:21 INFO - [mozharness: 2017-07-17 13:12:21.326700Z] Finished read-buildbot-config step (success) 06:12:21 INFO - [mozharness: 2017-07-17 13:12:21.327073Z] Running download-and-extract step. 06:12:21 INFO - Running pre-action listener: _resource_record_pre_action 06:12:21 INFO - Running main action method: download_and_extract 06:12:21 INFO - mkdir: /builds/slave/test/build/tests 06:12:21 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')]} 06:12:21 INFO - trying https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.test_packages.json 06:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:12:22 INFO - Downloaded 989 bytes. 06:12:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:12:22 INFO - Using the following test package requirements: 06:12:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:12:22 INFO - u'common': [u'target.common.tests.zip'], 06:12:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:12:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:12:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:12:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:12:22 INFO - u'mozbase': [u'target.common.tests.zip'], 06:12:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:12:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:12:22 INFO - u'web-platform': [u'target.common.tests.zip', 06:12:22 INFO - u'target.web-platform.tests.tar.gz'], 06:12:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:12:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.common.tests.zip 06:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.common.tests.zip into memory 06:12:23 INFO - Content-Length response header: 73394155 06:12:24 INFO - Bytes received: 73394155 06:12:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:12:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.common.tests.zip 06:12:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:12:35 INFO - Fetch https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.common.tests.zip into memory 06:12:36 INFO - Content-Length response header: 73394155 06:12:36 INFO - Bytes received: 73394155 06:12:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.talos.tests.zip 06:12:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:12:52 INFO - Fetch https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.talos.tests.zip into memory 06:12:53 INFO - Content-Length response header: 14495033 06:12:53 INFO - Bytes received: 14495033 06:12: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')]} 06:12:53 INFO - trying https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2 06:12:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:12:55 INFO - Downloaded 62647847 bytes. 06:12:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2 06:12:55 INFO - mkdir: /builds/slave/test/properties 06:12:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:12:55 INFO - Writing to file /builds/slave/test/properties/build_url 06:12:55 INFO - Contents: 06:12:55 INFO - build_url:https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2 06:12:55 INFO - Running post-action listener: _resource_record_post_action 06:12:55 INFO - Running post-action listener: set_extra_try_arguments 06:12:55 INFO - [mozharness: 2017-07-17 13:12:55.080527Z] Finished download-and-extract step (success) 06:12:55 INFO - [mozharness: 2017-07-17 13:12:55.080626Z] Running populate-webroot step. 06:12:55 INFO - Running pre-action listener: _resource_record_pre_action 06:12:55 INFO - Running main action method: populate_webroot 06:12:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:12:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:12:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:12:55 INFO - '--tppagecycles', 06:12:55 INFO - '7'], 06:12:55 INFO - 'tests': ['tsvgm']}}, 06:12:55 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:12:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:12:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:12:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:12:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['damp', 'tps']}, 06:12:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'tests': ['damp', 'tps']}, 06:12:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['dromaeo_dom']}, 06:12:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:12:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:12:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:12:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:12:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['a11yr', 06:12:55 INFO - 'ts_paint', 06:12:55 INFO - 'tpaint', 06:12:55 INFO - 'sessionrestore', 06:12:55 INFO - 'sessionrestore_no_auto_restore', 06:12:55 INFO - 'tabpaint']}, 06:12:55 INFO - 'other-e10s': {'tests': ['a11yr', 06:12:55 INFO - 'ts_paint', 06:12:55 INFO - 'tpaint', 06:12:55 INFO - 'sessionrestore', 06:12:55 INFO - 'sessionrestore_many_windows', 06:12:55 INFO - 'sessionrestore_no_auto_restore', 06:12:55 INFO - 'tabpaint']}, 06:12:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:12:55 INFO - 'ts_paint', 06:12:55 INFO - 'tpaint', 06:12:55 INFO - 'sessionrestore', 06:12:55 INFO - 'sessionrestore_many_windows', 06:12:55 INFO - 'sessionrestore_no_auto_restore', 06:12:55 INFO - 'tabpaint']}, 06:12:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:12:55 INFO - 'ts_paint', 06:12:55 INFO - 'tpaint', 06:12:55 INFO - 'sessionrestore', 06:12:55 INFO - 'sessionrestore_many_windows', 06:12:55 INFO - 'sessionrestore_no_auto_restore', 06:12:55 INFO - 'tabpaint']}, 06:12:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['a11yr', 06:12:55 INFO - 'ts_paint', 06:12:55 INFO - 'tpaint', 06:12:55 INFO - 'sessionrestore', 06:12:55 INFO - 'sessionrestore_no_auto_restore', 06:12:55 INFO - 'tabpaint']}, 06:12:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['a11yr', 06:12:55 INFO - 'ts_paint', 06:12:55 INFO - 'tpaint', 06:12:55 INFO - 'sessionrestore', 06:12:55 INFO - 'sessionrestore_no_auto_restore', 06:12:55 INFO - 'tabpaint']}, 06:12:55 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 06:12:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:12:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:12:55 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:12:55 INFO - 'talos_options': ['--mitmproxy', 06:12:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:12:55 INFO - '--firstNonBlankPaint'], 06:12:55 INFO - 'tests': ['quantum_pageload_google', 06:12:55 INFO - 'quantum_pageload_youtube', 06:12:55 INFO - 'quantum_pageload_amazon', 06:12:55 INFO - 'quantum_pageload_facebook']}, 06:12:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['tsvgx', 06:12:55 INFO - 'tsvgr_opacity', 06:12:55 INFO - 'tart', 06:12:55 INFO - 'tscrollx', 06:12:55 INFO - 'cart', 06:12:55 INFO - 'tsvg_static']}, 06:12:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:12:55 INFO - 'tsvgr_opacity', 06:12:55 INFO - 'tart', 06:12:55 INFO - 'tscrollx', 06:12:55 INFO - 'cart', 06:12:55 INFO - 'tsvg_static']}, 06:12:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'talos_options': ['--disable-e10s'], 06:12:55 INFO - 'tests': ['tp5o']}, 06:12:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:12:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'talos_options': ['--disable-e10s', 06:12:55 INFO - '--xperf_path', 06:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:55 INFO - 'tests': ['tp5n']}, 06:12:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:12:55 INFO - 'talos_options': ['--xperf_path', 06:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:12:55 INFO - 'tests': ['tp5n']}}, 06:12:55 INFO - 'talos.zip': {'path': '', 06:12:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:12:55 INFO - Running post-action listener: _resource_record_post_action 06:12:55 INFO - [mozharness: 2017-07-17 13:12:55.096136Z] Finished populate-webroot step (success) 06:12:55 INFO - [mozharness: 2017-07-17 13:12:55.096228Z] Running create-virtualenv step. 06:12:55 INFO - Running pre-action listener: _resource_record_pre_action 06:12:55 INFO - Running main action method: create_virtualenv 06:12:55 INFO - Creating virtualenv /builds/slave/test/build/venv 06:12: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 06:12:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:12:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:12:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:12:55 INFO - Using real prefix '/usr' 06:12:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:12:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:12:57 INFO - Installing pip.................done. 06:12:57 INFO - Return code: 0 06:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:12:57 INFO - Reading from file tmpfile_stdout 06:12:57 INFO - Output received: 06:12: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) 06:12:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12: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')]} 06:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:12: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 06:12: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 06:12:57 INFO - Using env: {'DISPLAY': ':0', 06:12:57 INFO - 'HOME': '/home/cltbld', 06:12:57 INFO - 'LANG': 'en_US.UTF-8', 06:12:57 INFO - 'LANGUAGE': 'en_US:en', 06:12:57 INFO - 'LOGNAME': 'cltbld', 06:12:57 INFO - 'MAIL': '/var/mail/cltbld', 06:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:57 INFO - 'MOZ_NO_REMOTE': '1', 06:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:57 INFO - 'NO_EM_RESTART': '1', 06:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:57 INFO - 'PWD': '/builds/slave/test', 06:12:57 INFO - 'SHELL': '/bin/bash', 06:12:57 INFO - 'SHLVL': '1', 06:12:57 INFO - 'TERM': 'linux', 06:12:57 INFO - 'TMOUT': '86400', 06:12:57 INFO - 'USER': 'cltbld', 06:12:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:57 INFO - '_': '/tools/buildbot/bin/python'} 06:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12: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 06:12:58 INFO - Cleaning up... 06:12:58 INFO - Return code: 0 06:12:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:12: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')]} 06:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:12: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')]} 06:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:12: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:12: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 06:12: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 06:12:58 INFO - Using env: {'DISPLAY': ':0', 06:12:58 INFO - 'HOME': '/home/cltbld', 06:12:58 INFO - 'LANG': 'en_US.UTF-8', 06:12:58 INFO - 'LANGUAGE': 'en_US:en', 06:12:58 INFO - 'LOGNAME': 'cltbld', 06:12:58 INFO - 'MAIL': '/var/mail/cltbld', 06:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:12:58 INFO - 'MOZ_NO_REMOTE': '1', 06:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:12:58 INFO - 'NO_EM_RESTART': '1', 06:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:12:58 INFO - 'PWD': '/builds/slave/test', 06:12:58 INFO - 'SHELL': '/bin/bash', 06:12:58 INFO - 'SHLVL': '1', 06:12:58 INFO - 'TERM': 'linux', 06:12:58 INFO - 'TMOUT': '86400', 06:12:58 INFO - 'USER': 'cltbld', 06:12:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:12:58 INFO - '_': '/tools/buildbot/bin/python'} 06:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:12:58 INFO - Downloading/unpacking psutil>=3.1.1 06:12: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 06:12: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 06:12: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 06:12: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 06:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:12:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:12:59 INFO - Installing collected packages: psutil 06:12:59 INFO - Running setup.py install for psutil 06:12:59 INFO - building 'psutil._psutil_linux' extension 06:12: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 06:12: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 06:12:59 INFO - building 'psutil._psutil_posix' extension 06:12: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 06:12: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:12:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:12:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:00 INFO - Successfully installed psutil 06:13:00 INFO - Cleaning up... 06:13:00 INFO - Return code: 0 06:13:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13: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')]} 06:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13: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 06:13: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 06:13:00 INFO - Using env: {'DISPLAY': ':0', 06:13:00 INFO - 'HOME': '/home/cltbld', 06:13:00 INFO - 'LANG': 'en_US.UTF-8', 06:13:00 INFO - 'LANGUAGE': 'en_US:en', 06:13:00 INFO - 'LOGNAME': 'cltbld', 06:13:00 INFO - 'MAIL': '/var/mail/cltbld', 06:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:00 INFO - 'MOZ_NO_REMOTE': '1', 06:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:00 INFO - 'NO_EM_RESTART': '1', 06:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:00 INFO - 'PWD': '/builds/slave/test', 06:13:00 INFO - 'SHELL': '/bin/bash', 06:13:00 INFO - 'SHLVL': '1', 06:13:00 INFO - 'TERM': 'linux', 06:13:00 INFO - 'TMOUT': '86400', 06:13:00 INFO - 'USER': 'cltbld', 06:13:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:00 INFO - '_': '/tools/buildbot/bin/python'} 06:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:13: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 06:13: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 06:13: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 06:13: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 06:13:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:13:01 INFO - Installing collected packages: mozsystemmonitor 06:13:01 INFO - Running setup.py install for mozsystemmonitor 06:13:01 INFO - Successfully installed mozsystemmonitor 06:13:01 INFO - Cleaning up... 06:13:01 INFO - Return code: 0 06:13:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13: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')]} 06:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13: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 06:13: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 06:13:01 INFO - Using env: {'DISPLAY': ':0', 06:13:01 INFO - 'HOME': '/home/cltbld', 06:13:01 INFO - 'LANG': 'en_US.UTF-8', 06:13:01 INFO - 'LANGUAGE': 'en_US:en', 06:13:01 INFO - 'LOGNAME': 'cltbld', 06:13:01 INFO - 'MAIL': '/var/mail/cltbld', 06:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:01 INFO - 'MOZ_NO_REMOTE': '1', 06:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:01 INFO - 'NO_EM_RESTART': '1', 06:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:01 INFO - 'PWD': '/builds/slave/test', 06:13:01 INFO - 'SHELL': '/bin/bash', 06:13:01 INFO - 'SHLVL': '1', 06:13:01 INFO - 'TERM': 'linux', 06:13:01 INFO - 'TMOUT': '86400', 06:13:01 INFO - 'USER': 'cltbld', 06:13:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:01 INFO - '_': '/tools/buildbot/bin/python'} 06:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:01 INFO - Downloading/unpacking jsonschema==2.5.1 06:13: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 06:13: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 06:13: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 06:13: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 06:13:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:13:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:13:03 INFO - warning: no files found matching '*.txt' 06:13:03 INFO - no previously-included directories found matching 'build' 06:13:03 INFO - no previously-included directories found matching 'dist' 06:13:03 INFO - no previously-included directories found matching '.git*' 06:13:03 INFO - Installing collected packages: jsonschema, functools32 06:13:03 INFO - Running setup.py install for functools32 06:13:03 INFO - warning: no files found matching '*.txt' 06:13:03 INFO - no previously-included directories found matching 'build' 06:13:03 INFO - no previously-included directories found matching 'dist' 06:13:03 INFO - no previously-included directories found matching '.git*' 06:13:03 INFO - Successfully installed jsonschema functools32 06:13:03 INFO - Cleaning up... 06:13:03 INFO - Return code: 0 06:13:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13: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')]} 06:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13: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 06:13: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 06:13:03 INFO - Using env: {'DISPLAY': ':0', 06:13:03 INFO - 'HOME': '/home/cltbld', 06:13:03 INFO - 'LANG': 'en_US.UTF-8', 06:13:03 INFO - 'LANGUAGE': 'en_US:en', 06:13:03 INFO - 'LOGNAME': 'cltbld', 06:13:03 INFO - 'MAIL': '/var/mail/cltbld', 06:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:03 INFO - 'MOZ_NO_REMOTE': '1', 06:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:03 INFO - 'NO_EM_RESTART': '1', 06:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:03 INFO - 'PWD': '/builds/slave/test', 06:13:03 INFO - 'SHELL': '/bin/bash', 06:13:03 INFO - 'SHLVL': '1', 06:13:03 INFO - 'TERM': 'linux', 06:13:03 INFO - 'TMOUT': '86400', 06:13:03 INFO - 'USER': 'cltbld', 06:13:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:03 INFO - '_': '/tools/buildbot/bin/python'} 06:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:13:03 INFO - Cleaning up... 06:13:03 INFO - Return code: 0 06:13:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13: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')]} 06:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13: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 06:13: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 06:13:03 INFO - Using env: {'DISPLAY': ':0', 06:13:03 INFO - 'HOME': '/home/cltbld', 06:13:03 INFO - 'LANG': 'en_US.UTF-8', 06:13:03 INFO - 'LANGUAGE': 'en_US:en', 06:13:03 INFO - 'LOGNAME': 'cltbld', 06:13:03 INFO - 'MAIL': '/var/mail/cltbld', 06:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:03 INFO - 'MOZ_NO_REMOTE': '1', 06:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:03 INFO - 'NO_EM_RESTART': '1', 06:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:03 INFO - 'PWD': '/builds/slave/test', 06:13:03 INFO - 'SHELL': '/bin/bash', 06:13:03 INFO - 'SHLVL': '1', 06:13:03 INFO - 'TERM': 'linux', 06:13:03 INFO - 'TMOUT': '86400', 06:13:03 INFO - 'USER': 'cltbld', 06:13:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:03 INFO - '_': '/tools/buildbot/bin/python'} 06:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:13: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 06:13: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 06:13: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 06:13: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 06:13:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:13:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:13: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 06:13: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 06:13: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 06:13: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 06:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:13:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:13:06 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 06:13:06 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 06:13:06 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 06:13:06 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 06:13:06 INFO - Downloading docopt-0.6.1.tar.gz 06:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:13:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:13:06 INFO - Running setup.py install for blobuploader 06:13:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:13:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:13:06 INFO - Running setup.py install for requests 06:13:06 INFO - Running setup.py install for docopt 06:13:06 INFO - Successfully installed blobuploader requests docopt 06:13:06 INFO - Cleaning up... 06:13:06 INFO - Return code: 0 06:13:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13: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')]} 06:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13: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 06:13: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 06:13:06 INFO - Using env: {'DISPLAY': ':0', 06:13:06 INFO - 'HOME': '/home/cltbld', 06:13:06 INFO - 'LANG': 'en_US.UTF-8', 06:13:06 INFO - 'LANGUAGE': 'en_US:en', 06:13:06 INFO - 'LOGNAME': 'cltbld', 06:13:06 INFO - 'MAIL': '/var/mail/cltbld', 06:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:06 INFO - 'MOZ_NO_REMOTE': '1', 06:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:06 INFO - 'NO_EM_RESTART': '1', 06:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:06 INFO - 'PWD': '/builds/slave/test', 06:13:06 INFO - 'SHELL': '/bin/bash', 06:13:06 INFO - 'SHLVL': '1', 06:13:06 INFO - 'TERM': 'linux', 06:13:06 INFO - 'TMOUT': '86400', 06:13:06 INFO - 'USER': 'cltbld', 06:13:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:06 INFO - '_': '/tools/buildbot/bin/python'} 06:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:13:07 INFO - Running setup.py (path:/tmp/pip-RTyV5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:13:07 INFO - Running setup.py (path:/tmp/pip-1kwlDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:13:07 INFO - Running setup.py (path:/tmp/pip-NERbbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:13:07 INFO - Running setup.py (path:/tmp/pip-H6Yhjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:13:07 INFO - Running setup.py (path:/tmp/pip-uxs61t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:13:07 INFO - Running setup.py (path:/tmp/pip-kOlhW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:13:07 INFO - Running setup.py (path:/tmp/pip-HeaElk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:13:07 INFO - Running setup.py (path:/tmp/pip-z1Xv47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:13:07 INFO - Running setup.py (path:/tmp/pip-WqaLR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:13:07 INFO - Running setup.py (path:/tmp/pip-AqRSQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:13:07 INFO - Running setup.py (path:/tmp/pip-90B8xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:13:07 INFO - Running setup.py (path:/tmp/pip-lkdHBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:13:08 INFO - Running setup.py (path:/tmp/pip-xNKu2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:13:08 INFO - Running setup.py (path:/tmp/pip-HWGRph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:08 INFO - Running setup.py (path:/tmp/pip-YdyM6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:13:08 INFO - Running setup.py (path:/tmp/pip-F9QeuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:13:08 INFO - Running setup.py (path:/tmp/pip-D0yG2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:13:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:13:08 INFO - Running setup.py install for manifestparser 06:13:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:13:08 INFO - Running setup.py install for mozcrash 06:13:08 INFO - Running setup.py install for mozdebug 06:13:08 INFO - Running setup.py install for mozdevice 06:13:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:13:08 INFO - Running setup.py install for mozfile 06:13:08 INFO - Running setup.py install for mozhttpd 06:13:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:13:08 INFO - Running setup.py install for mozinfo 06:13:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Running setup.py install for mozInstall 06:13:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Running setup.py install for mozleak 06:13:09 INFO - Running setup.py install for mozlog 06:13:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Running setup.py install for moznetwork 06:13:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Running setup.py install for mozprocess 06:13:09 INFO - Running setup.py install for mozprofile 06:13:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Running setup.py install for mozrunner 06:13:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:13:09 INFO - Running setup.py install for mozscreenshot 06:13:09 INFO - Running setup.py install for moztest 06:13:10 INFO - Running setup.py install for mozversion 06:13:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:13:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:13:10 INFO - Cleaning up... 06:13:10 INFO - Return code: 0 06:13:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:10 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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13:10 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 06:13:10 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 06:13:10 INFO - Using env: {'DISPLAY': ':0', 06:13:10 INFO - 'HOME': '/home/cltbld', 06:13:10 INFO - 'LANG': 'en_US.UTF-8', 06:13:10 INFO - 'LANGUAGE': 'en_US:en', 06:13:10 INFO - 'LOGNAME': 'cltbld', 06:13:10 INFO - 'MAIL': '/var/mail/cltbld', 06:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:10 INFO - 'MOZ_NO_REMOTE': '1', 06:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:10 INFO - 'NO_EM_RESTART': '1', 06:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:10 INFO - 'PWD': '/builds/slave/test', 06:13:10 INFO - 'SHELL': '/bin/bash', 06:13:10 INFO - 'SHLVL': '1', 06:13:10 INFO - 'TERM': 'linux', 06:13:10 INFO - 'TMOUT': '86400', 06:13:10 INFO - 'USER': 'cltbld', 06:13:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:10 INFO - '_': '/tools/buildbot/bin/python'} 06:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:13:10 INFO - Running setup.py (path:/tmp/pip-PGIKXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:13:10 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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:13:10 INFO - Running setup.py (path:/tmp/pip-RTw20U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:13:10 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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:13:10 INFO - Running setup.py (path:/tmp/pip-7zSvjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:13:10 INFO - Running setup.py (path:/tmp/pip-tyyBCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:13:10 INFO - Running setup.py (path:/tmp/pip-lujQJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:13:10 INFO - Running setup.py (path:/tmp/pip-rlbjDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:13:10 INFO - Running setup.py (path:/tmp/pip-GcjG7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:13:10 INFO - Running setup.py (path:/tmp/pip-txtZae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:13:10 INFO - Running setup.py (path:/tmp/pip-4xU2G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:13: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)) 06:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:13:11 INFO - Running setup.py (path:/tmp/pip-rkjeen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:13:11 INFO - Running setup.py (path:/tmp/pip-seMqWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:13:11 INFO - Running setup.py (path:/tmp/pip-efxy2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:13:11 INFO - Running setup.py (path:/tmp/pip-kyY_Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:13:11 INFO - Running setup.py (path:/tmp/pip-AGuJLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:11 INFO - Running setup.py (path:/tmp/pip-I4mfEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:13:11 INFO - Running setup.py (path:/tmp/pip-CQgLmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:13:11 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)) 06:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:13:11 INFO - Running setup.py (path:/tmp/pip-clwA3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:13: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)) 06:13: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)) 06:13: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)) 06:13: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)) 06:13: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)) 06:13: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)) 06:13: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)) 06:13:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:13: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 06:13: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 06:13: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 06:13: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 06:13:12 INFO - Downloading blessings-1.6.tar.gz 06:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:13:12 INFO - Installing collected packages: blessings 06:13:12 INFO - Running setup.py install for blessings 06:13:12 INFO - Successfully installed blessings 06:13:12 INFO - Cleaning up... 06:13:12 INFO - Return code: 0 06:13:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:13:13 INFO - Reading from file tmpfile_stdout 06:13:13 INFO - Current package versions: 06:13:13 INFO - argparse == 1.2.1 06:13:13 INFO - blessings == 1.6 06:13:13 INFO - blobuploader == 1.2.4 06:13:13 INFO - docopt == 0.6.1 06:13:13 INFO - functools32 == 3.2.3-2 06:13:13 INFO - jsonschema == 2.5.1 06:13:13 INFO - manifestparser == 1.1 06:13:13 INFO - mozInstall == 1.13 06:13:13 INFO - mozcrash == 1.0 06:13:13 INFO - mozdebug == 0.1 06:13:13 INFO - mozdevice == 0.51 06:13:13 INFO - mozfile == 1.2 06:13:13 INFO - mozhttpd == 0.7 06:13:13 INFO - mozinfo == 0.10 06:13:13 INFO - mozleak == 0.1 06:13:13 INFO - mozlog == 3.5 06:13:13 INFO - moznetwork == 0.27 06:13:13 INFO - mozprocess == 0.25 06:13:13 INFO - mozprofile == 0.28 06:13:13 INFO - mozrunner == 6.13 06:13:13 INFO - mozscreenshot == 0.1 06:13:13 INFO - mozsystemmonitor == 0.3 06:13:13 INFO - moztest == 0.8 06:13:13 INFO - mozversion == 1.4 06:13:13 INFO - psutil == 3.1.1 06:13:13 INFO - requests == 1.2.3 06:13:13 INFO - wsgiref == 0.1.2 06:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:13 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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13:13 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 06:13:13 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 06:13:13 INFO - Using env: {'DISPLAY': ':0', 06:13:13 INFO - 'HOME': '/home/cltbld', 06:13:13 INFO - 'LANG': 'en_US.UTF-8', 06:13:13 INFO - 'LANGUAGE': 'en_US:en', 06:13:13 INFO - 'LOGNAME': 'cltbld', 06:13:13 INFO - 'MAIL': '/var/mail/cltbld', 06:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:13 INFO - 'MOZ_NO_REMOTE': '1', 06:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:13 INFO - 'NO_EM_RESTART': '1', 06:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:13 INFO - 'PWD': '/builds/slave/test', 06:13:13 INFO - 'SHELL': '/bin/bash', 06:13:13 INFO - 'SHLVL': '1', 06:13:13 INFO - 'TERM': 'linux', 06:13:13 INFO - 'TMOUT': '86400', 06:13:13 INFO - 'USER': 'cltbld', 06:13:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:13 INFO - '_': '/tools/buildbot/bin/python'} 06:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 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)) 06:13:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:13:13 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 06:13:13 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 06:13:13 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 06:13:13 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 06:13:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:13:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:13:14 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)) 06:13:14 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)) 06:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:13:14 INFO - Installing collected packages: marionette-driver, simplejson 06:13:14 INFO - Running setup.py install for marionette-driver 06:13:14 INFO - Running setup.py install for simplejson 06:13:14 INFO - building 'simplejson._speedups' extension 06:13: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 06:13:15 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 06:13:15 INFO - Successfully installed marionette-driver simplejson 06:13:15 INFO - Cleaning up... 06:13:15 INFO - Return code: 0 06:13:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13: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')]} 06:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13: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 0x140e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', '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 06:13: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 06:13: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 06:13:15 INFO - Using env: {'DISPLAY': ':0', 06:13:15 INFO - 'HOME': '/home/cltbld', 06:13:15 INFO - 'LANG': 'en_US.UTF-8', 06:13:15 INFO - 'LANGUAGE': 'en_US:en', 06:13:15 INFO - 'LOGNAME': 'cltbld', 06:13:15 INFO - 'MAIL': '/var/mail/cltbld', 06:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:15 INFO - 'MOZ_NO_REMOTE': '1', 06:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:15 INFO - 'NO_EM_RESTART': '1', 06:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:15 INFO - 'PWD': '/builds/slave/test', 06:13:15 INFO - 'SHELL': '/bin/bash', 06:13:15 INFO - 'SHLVL': '1', 06:13:15 INFO - 'TERM': 'linux', 06:13:15 INFO - 'TMOUT': '86400', 06:13:15 INFO - 'USER': 'cltbld', 06:13:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:15 INFO - '_': '/tools/buildbot/bin/python'} 06:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:13:16 INFO - Cleaning up... 06:13:16 INFO - Return code: 0 06:13:16 INFO - Running post-action listener: _resource_record_post_action 06:13:16 INFO - Running post-action listener: _start_resource_monitoring 06:13:16 INFO - Starting resource monitoring. 06:13:16 INFO - [mozharness: 2017-07-17 13:13:16.217894Z] Finished create-virtualenv step (success) 06:13:16 INFO - [mozharness: 2017-07-17 13:13:16.218405Z] Running install step. 06:13:16 INFO - Running pre-action listener: _resource_record_pre_action 06:13:16 INFO - Running main action method: install 06:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:13:16 INFO - Reading from file tmpfile_stdout 06:13:16 INFO - Detecting whether we're running mozinstall >=1.0... 06:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:13:16 INFO - Reading from file tmpfile_stdout 06:13:16 INFO - Output received: 06:13:16 INFO - Usage: mozinstall [options] installer 06:13:16 INFO - Options: 06:13:16 INFO - -h, --help show this help message and exit 06:13:16 INFO - -d DEST, --destination=DEST 06:13:16 INFO - Directory to install application into. [default: 06:13:16 INFO - "/builds/slave/test"] 06:13:16 INFO - --app=APP Application being installed. [default: firefox] 06:13:16 INFO - mkdir: /builds/slave/test/build/application 06:13:16 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'] 06:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:13:34 INFO - Reading from file tmpfile_stdout 06:13:34 INFO - Output received: 06:13:34 INFO - /builds/slave/test/build/application/firefox/firefox 06:13:34 INFO - Running post-action listener: _resource_record_post_action 06:13:34 INFO - [mozharness: 2017-07-17 13:13:34.313401Z] Finished install step (success) 06:13:34 INFO - [mozharness: 2017-07-17 13:13:34.313630Z] Running setup-mitmproxy step. 06:13:34 INFO - Running pre-action listener: _resource_record_pre_action 06:13:34 INFO - Running main action method: setup_mitmproxy 06:13:34 INFO - Skipping: mitmproxy is not required 06:13:34 INFO - Running post-action listener: _resource_record_post_action 06:13:34 INFO - [mozharness: 2017-07-17 13:13:34.314164Z] Finished setup-mitmproxy step (success) 06:13:34 INFO - [mozharness: 2017-07-17 13:13:34.314269Z] Running run-tests step. 06:13:34 INFO - Running pre-action listener: _resource_record_pre_action 06:13:34 INFO - Running pre-action listener: _set_gcov_prefix 06:13:34 INFO - Running main action method: run_tests 06:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:13:34 INFO - Python 2.7.3 06:13:34 INFO - Return code: 0 06:13:34 INFO - grabbing minidump binary from tooltool 06:13:34 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')]} 06:13:34 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 0x177cd00>, '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 0x177dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:13:34 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 06:13:34 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 06:13:34 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 06:13:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:13:34 INFO - Return code: 0 06:13:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:13:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:13:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:13:34 INFO - ENV: RUST_BACKTRACE is now 1 06:13:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:13:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:13:34 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/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 06:13:34 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/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 06:13:34 INFO - Using env: {'DISPLAY': ':0', 06:13:34 INFO - 'HOME': '/home/cltbld', 06:13:34 INFO - 'LANG': 'en_US.UTF-8', 06:13:34 INFO - 'LANGUAGE': 'en_US:en', 06:13:34 INFO - 'LOGNAME': 'cltbld', 06:13:34 INFO - 'MAIL': '/var/mail/cltbld', 06:13:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:13:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:34 INFO - 'MOZ_NO_REMOTE': '1', 06:13:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:34 INFO - 'NO_EM_RESTART': '1', 06:13:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:34 INFO - 'PWD': '/builds/slave/test', 06:13:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:13:34 INFO - 'RUST_BACKTRACE': '1', 06:13:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:13:34 INFO - 'SHELL': '/bin/bash', 06:13:34 INFO - 'SHLVL': '1', 06:13:34 INFO - 'TERM': 'linux', 06:13:34 INFO - 'TMOUT': '86400', 06:13:34 INFO - 'USER': 'cltbld', 06:13:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353', 06:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:34 INFO - '_': '/tools/buildbot/bin/python'} 06:13:34 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/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 06:13:34 INFO - mozversion application_buildid: 20170717120626 06:13:34 INFO - mozversion application_changeset: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e 06:13:34 INFO - mozversion application_display_name: Nightly 06:13:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:13:34 INFO - mozversion application_name: Firefox 06:13:34 INFO - mozversion application_remotingname: firefox 06:13:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:13:34 INFO - mozversion application_vendor: Mozilla 06:13:34 INFO - mozversion application_version: 56.0a1 06:13:34 INFO - mozversion platform_buildid: 20170717120626 06:13:34 INFO - mozversion platform_changeset: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e 06:13:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:13:34 INFO - mozversion platform_version: 56.0a1 06:13:34 INFO - using testdate: 1500297214 06:13:34 INFO - actual date: 1500297214 06:13:34 INFO - starting webserver on 'localhost:34296' 06:13:34 INFO - SUITE-START | Running 2 tests 06:13:34 INFO - TEST-START | dromaeo_css 06:13:34 INFO - Initialising browser for dromaeo_css test... 06:13:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34296/getInfo.html -profile /tmp/tmpo0PG8n/profile 06:13:34 INFO - TEST-INFO | started process 14742 (/builds/slave/test/build/application/firefox/firefox http://localhost:34296/getInfo.html) 06:13:41 INFO - TEST-INFO | 14742: exit 0 06:13:41 INFO - Browser initialized. 06:13:41 INFO - Running cycle 1/1 for dromaeo_css test... 06:13:41 INFO - TEST-INFO | started process 14951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo0PG8n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:52 INFO - PID 14951 | RSS: Main: 160088064 06:13:52 INFO - PID 14951 | 06:16:49 INFO - PID 14951 | Cycle 1(1): loaded http://localhost:34296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34296/tests/dromaeo/cssquery-ext.html) 06:16:51 INFO - PID 14951 | RSS: Main: 169275392 06:16:51 INFO - PID 14951 | 06:19:52 INFO - PID 14951 | Cycle 1(1): loaded http://localhost:34296/tests/dromaeo/cssquery-ext.html (next: http://localhost:34296/tests/dromaeo/cssquery-jquery.html) 06:19:53 INFO - PID 14951 | RSS: Main: 166600704 06:19:53 INFO - PID 14951 | 06:22:54 INFO - PID 14951 | Cycle 1(1): loaded http://localhost:34296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34296/tests/dromaeo/cssquery-mootools.html) 06:22:55 INFO - PID 14951 | RSS: Main: 170061824 06:22:55 INFO - PID 14951 | 06:25:57 INFO - PID 14951 | Cycle 1(1): loaded http://localhost:34296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34296/tests/dromaeo/cssquery-prototype.html) 06:25:57 INFO - PID 14951 | RSS: Main: 168218624 06:25:57 INFO - PID 14951 | 06:29:00 INFO - PID 14951 | Cycle 1(1): loaded http://localhost:34296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34296/tests/dromaeo/cssquery-yui.html) 06:29:01 INFO - PID 14951 | RSS: Main: 167604224 06:29:01 INFO - PID 14951 | 06:32:02 INFO - PID 14951 | Cycle 1(1): loaded http://localhost:34296/tests/dromaeo/cssquery-yui.html (next: http://localhost:34296/tests/dromaeo/cssquery-dojo.html) 06:32:03 INFO - PID 14951 | RSS: Main: 169299968 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | __start_tp_report 06:32:03 INFO - PID 14951 | _x_x_mozilla_page_load 06:32:03 INFO - PID 14951 | _x_x_mozilla_page_load_details 06:32:03 INFO - PID 14951 | |i|pagename|runs| 06:32:03 INFO - PID 14951 | |0;dojo.html;3327.633960264372;3345.715614172795;3379.966200337996;3384.6107697614766;3409.09658940381;6053.697315134236;6072.119542666316;6129.601575897564;6134.110553969677;6155.9076613850775;6137.877242455148;6166.198394208758;6167.660778657172;6172.5061995040405;6190.071489276611;5375.354957405117;5384.326959130109;5385.488378604046;5412.56699464042;5449.64577302476;5405.270288511059;5428.267183930178;5428.728563571825;5438.048341540234;5439.456054394549;5430.429804870491;5433.293671822657;5433.864153396177;5435.619506634537;5442.455754424545;5422.15956526739;5424.996375670514;5426.8371948841595;5431.022415965124;5437.401885792559;5293.126634105368;5387.4612538746205;5402.864928376783;5418;5461.808836690697;6130.04984227441;6162.13730077785;6175.814725558241;6211.378862113797;6224.937750622526;6511.218653761579;6511.967440162816;6543.607383557001;6646.93353066468;6666.966620173881;6471.385218404244;6525.412712855818;6549.115869357671;6561.982892651647;6569.80290591283;6001.369856165084;6014.097885317194;6024.8493787655225;6046.425589568984;6049.637021778707;6621.437177839889;6626.768063117768;6731.697073631698;6752.662366881636;6865.519413641097;6433.581817181868;6506.60960342381;6525.086487891699;6576.210854697467;6614.404703576605;6586.4072233498255;6615.900761488581;6662.233843108104;6674.5995240284765;6685.966570167118;6464.321246269168;6531.0856480092825;6540.8364790880605;6566.868662626721;6596;6101.725422356005;6478.449331806755;6525.706343214567;6572.901406478906;6590.736370545221;4926.3842019747535;4945.604351651859;4964.056829202512;5011.84964451067;5016.297718319438;4417.911641767147;4438.201123797748;4452.48796388413;4454.064646424287;4472.709273897186;6287.654179020198;6292.2134733158355;6295.24457065146;6297.905531416941;6300.30696623371;6560.8359791005605;6614.801555953329;6624.966875165594;6627.4366678831875;6643.136392269071;6163.291221509584;6301.14934483848;6306.432421082125;6316.652584107918;6324.841878953063;5680.7727690892725;5715.771369145271;5719.19931209631;5734.827955161351;5745.8563535911935;6059.413354324977;7024.578525288499;7033.577985320897;7120.0387947626405;7139.714411423485;6566.770163044366;6572.901406478811;6594.208694956444;6680.899786503206;6683.799486015428;6849.2808255132495;6993.405560527209;7005.124359455068;7072.434205263669;7085.468589855678;6423.839404014937;6427.775027874002;6440.710168042543;6441.3880681335195;6445.323241059621;5657.294472120768;6551.44312733404;6604.339566043357;6680.966595166993;6765.763198288037;6411.0383442484;6460.353964603502;6486.3513648636645;6510.5117116217425;6511.511636627367;6380.01265522422;6434.227892652912;6495.253045899782;6498.057781621733;6510.902336464862;6308.463780578702;6373.745050198126;6383.170187875732;6391.296957334596;6393.680315984089;5578.553715702815;6310.842228944313;6381.170447841937;6476.384743449365;6477.352264773674;6267.373262673696;6324.810255692337;6374.74501019954;6384.648844313608;6388.201474815648 06:32:03 INFO - PID 14951 | |1;ext.html;871.3696932432823;889.0675083564503;921.6820197032023;929.6420877961982;935.7567032571534;38846.8057659712;40399.79800100999;40414.39378409326;40522.7973860131;40580.39129413061;42019.15961680764;42197.15605687884;42301;42419.15161696772;42466.57533424665;6970.512064155511;7095.361417472453;7101.04135941649;7104.040954471157;7113.786586402416;6935.618540980244;7031.296870312954;7034.085568876065;7049.224585295613;7059.223485416625;7029.22678505364;7041.19026311973;7052.964735176317;7064.964675176642;7092.219855815856;6987.231404545496;7019.6139212343305;7042.823929401755;7051.259617740115;7092.964535177317;6861.073755043055;6869.7595584154815;6898.206706228798;6940.444764418834;6940.583564986117;37552.24895502102;37860;37992.24015519702;38114.618853811386;38119;3427.605825330069;3455.51622772812;3455.58532976042;3455.861765529401;3459.221675123102;29682.55476167859;29919.85040074786;29998.85000575005;30020;30068.548971765442;4739.478657347689;4848.563629273347;4954.380702412199;4973.1297023020825;5055.241713742968;209090;211205;258688;263832;276848.99999999796;49994;50208.49791502038;50241;50268.24597631038;50370;51930;52298.738506307986;52322.21516677253;52375.21437178445;52536.73731631317;16032.358705651643;16293.837061629469;16330.673386532202;16472;16543.338266469207;13440.932795336157;13515.391807368693;13521.256330901699;13525.864741352658;13558.050936434354;14274.429022838971;14424.350904209336;14484.710305793826;14552.054116482395;14615;5731.77072917087;5734.197212390269;5779.508741756914;5841.7371218295275;5905.881882362329;1055.6041484443333;1066.6160182334354;1072.84443755655;1074.3070719386108;1090.607381342716;23612.29163125109;23922.28233153008;24041.323330463656;24627.630585541232;24660.38349041288;1159.4434671357797;1160.2920084763962;1164.2003484748025;1195.3126952002633;1199.154596009811;12773.808392874114;12816.551420700418;12840;12915.031372647089;12959.222446653232;285601;286105;287469;288139;289018;46756;47505.28742068872;50415;51637.483625164015;52457.2131418029;1429.385364293343;1480.9259537023106;1488.1443170176974;1503.1206744054632;1506.954791356261;27271.86364068167;28444.57333140046;28634.42731145407;28640.570391444562;28912.710872891003;32590.51114233336;32672.673273266962;32673.509897352033;32810.50784238286;43179.13641727085;220578;222046;222459;232462;239423;33406.331873362884;33956.830215848764;34056;34130.82934585411;34261.82869085639;40277.39583906185;42466;42689.78655106829;42773.14453710971;43263.78368108139;31175.688243118188;31449.685503144676;31629;31710.524342134424;31763.523547147273;31694.841525792224;32184.517232241065;32567.837160814044;32576.51135233021;32650.51024234591;41224.175516488904;42224.36663450112;42463;42545.361819572114;42551.7872410636;32682.34635307328;33557.496637549964;34381.484277735355;34685;34710.305793883475;25495.745042549337;25619.487610248063;25825.870870645525;25911.481770364866;26161.607575885995 06:32:03 INFO - PID 14951 | |2;jquery.html;567.449573913304;567.8296511046685;573.5268403567059;585.5081731345668;606.6905878002219;22474.101035958563;23032.42418939523;23306.65040024397;23352.532949341025;23433.531329373425;26085.608715869228;26848.999999999953;28210.15369538917;28429.289267768316;28433.431331373362;6674.599524028574;6828.52200345976;6844.418224450903;6848.246692863781;6864.965675171642;6719.664016799141;6742.494312926526;6767.56010859295;6769.695363708645;6805.863882722342;4632.4672662643725;5973.701314934257;6068.96965515174;6727.529072964894;6797.150356205474;6742.2920593337485;6756.4932630052945;6760.188777346701;6786.389224969752;6814.931850681479;6611.140551728293;6622.741679080959;6632.303608121126;6649.667516624198;6658.201015878126;29621.851890740625;31980.200494987577;32104.6789532104;32527.349453011044;32579.348413031843;2184.6722991551237;2220.655798351242;2253.785890340415;2257.5033492631596;2257.5146343536217;20098.497537561532;20762.48093797667;20764.792352076438;20807.375778726662;20831.16675332985;2428.3443470263105;2439.5852705040184;2507.072383218221;2524.204875464223;2525.3812815860233;143884;145029.27485362612;147047;150487;150739;21214.36356909295;21754;22336.553268934855;22629.547409051727;24363.26910192697;46456.5354346459;46580.5341946583;46633.53366466292;46640;46711.76644116758;11773.645270945844;11976.580819671444;12043.95252807025;12096.81854772179;12146.757064858653;9671.70984870455;9699.030096990244;9736;9762.023797620323;9785.217182625373;11863.406829658656;12061.527386885668;12112.620006964205;12202.38988050594;12264.32546209967;3399.473081672345;3902.5902280260166;4165.8333666653;4266.786660666954;4517.480489743656;1023.4729114506035;1025.8615086963164;1037.2065369991963;1045.9372437653765;1056.9312994655322;20225.696614550794;20365.79634203639;20397.796022039885;20440.488987775425;20816.063277152563;1065.9040686338112;1073.7261998190568;1076.05844885725;1081.9459027048615;1089.9945500272606;11180.888191117985;11193.552257909592;11453;11484.94257528707;11557.422128893522;587633;615219;626167;638600;640019;123243.38378308051;123943.38028309801;129441.35279323543;129532.3523382377;131082.34458827644;1181;1191.4162060590422;1193.2601786892183;1223.6512593910693;1229.2010193374379;17433.47699569015;18319.633607328044;18345.72481412753;18564.164612592194;19064.714029289295;56612.716936415054;59231;60253.0962035561;62301;64163;73242;74182.62908685423;74845;75155.62422187853;76553.61723191348;19680.60638787245;19835.206591736747;19920;20016.799832001492;20218.59562808765;23160.3051908443;23436;23502.764972350058;23733.525329492968;24039.63940540928;18359.908200459446;19292.71060934059;19327;19456.319028833925;19615.31346402869;15607.453739119077;15872.52382428529;16778.412755553498;16904.32382704678;17083.487495375157;18527.907360463112;18743.250269989047;18944.242230311185;18952.336668216547;19114.235430583176;18861.056947152312;19599;19695;19729.506762331057;19810.90094549518;18918.52703682419;18947.242110315983;19161.32935347312;19186;19234.8076519233 06:32:03 INFO - PID 14951 | |3;mootools.html;1430.6494908747359;1459.2411945788183;1479.711456266028;1484.9703005939875;1498.9175595342258;14786.926065369671;15595.376184952616;15632.921835390822;15636.218189090529;15646.217689115541;14876.47932322369;15554.84445155548;16193.676126477463;16224.10767407792;16353.345866165339;2652.1910817200746;2714.3892624159603;2720.1295585412677;2726.427450235453;2731.740484653955;2549.2734570647367;2613.176849292476;2618.4632150409216;2621.3970786719065;2631.13172653025;2534.885930133139;2535.277445927911;2559.4881023795315;2581.393372557457;2582.8579428131447;2655.3759866431374;2778.4859800936892;2779.110684580935;2783.554631258989;2797.0350229170904;2650.2844232057428;2671.9332016699545;2676.6386537817534;2678.196541037681;2682.6512553368134;15039.097654140678;15181.16503592302;15201;15213.847861521353;15310.081395116218;8073.475224110414;8354.958225208835;8359.080501144868;8368.539730314831;8431.367647426467;4965.900681986376;5135.512126347991;5317.12267475866;5317.388500322435;5346.866328341784;1787.9553011174694;1820.9817901820945;1839.0988415676356;1874.0161415256962;1879.0833349983077;26751.732482675117;26781.464370712478;26799.330016749544;26923.1923042311;26930.326741831414;6966.79099627012;7000.754973576002;7039.366457018893;7089.361957423754;7133.824183624044;17976.820231797778;17996.37012704549;18014.459566212772;18123.72814407785;18137.18382672783;8217.712380066669;8324.417290789586;8328.417010809186;8353.832923341499;8372.120927302667;7567.545947243183;7693.615319234016;7723.65243564041;7820.882686759704;7889.960550197212;5159.716215608102;5390.595705322116;5431.21247419122;5445;5508.256385388001;1544.652453198044;1553.5572361877037;1568.5451219146548;1572.8269890312056;1578.48699172767;863.7408777366765;872.6553011560525;891.7815135291895;897.9281657467387;907.2469850024464;7599;7636.3890888728765;7647.961760191163;9352.906470935204;9488.810223795623;1015.7409860485529;1024.5543188712934;1037.3153718545875;1050.8108540462638;1070.4808168038496;5431.402545719968;5521.812810245817;5690.2887139107615;5702.714864256771;5826.796062137805;22171.44571385696;22250;22402.439939001655;22522.099116035177;22750;22072.558548828933;22562.210322638628;22954.770452295597;23129.653055204184;23377.649335259986;11730;12450.501979920882;12474.688132796753;12513.937430312972;12544.184627998968;8369.916300836914;8422.789430264293;8573.74278771638;8577.699780507652;8655.134486551295;18849.528761781065;19049.809501905358;19627.901860490605;20163.89918050459;20168.29410970609;18652.906735466237;19091.331803386816;20268.493287667927;20293;20605.07277172561;12816.743665126833;13139.802902956271;13143.342832858127;13153;13164.275964822027;14841.554753357417;15232.847671523587;15289.770653439984;15342.693146137239;15381.923090384924;12410.193337433038;12441.813372799234;12588.055895807667;12654.493820247088;12786.74426511446;12159.756804863677;12206.267623942593;12224.816627750768;12426.192297500633;12833.101682882108;9838.212942964403;9870.062344077302;9877.802443951225;9888.258380621339;9926.851097233692;6787.5588086774205;7024.297570242935;7126.144862616312;7153.606551639502;7233.529820561646;7221.241769614115;7285;7315.341619254293;7386.2613738625705;7387.039684840936 06:32:03 INFO - PID 14951 | |4;prototype.html;492.1436700141754;512.5028722139525;533.9679619222844;537.2559005776998;538.440022376728;5925.859294573877;5977.641341519501;6010.27876654802;6010.6340449348345;6029.9397006029985;5656.179853921179;5852.67810270435;5902.645841249528;5923.3188183358925;5945.67298798567;4631.976840115794;4638.956234847149;4652.627789776819;4707.1056499265205;4718.740469274188;4648.02526383115;4657.720536767804;4686.742229177394;4687.953120468803;4729.739864307462;4637.327587499811;4644.767761611923;4649.674522783406;4674.883127921795;4701.64737644678;4463.218936686067;4574.817007319703;4624.699394539344;4659;4680.953190468086;4219.852305169305;4221.493420789494;4233.708718840783;4266.0827921996915;4273.9358909616385;5796.913046304308;5807.883842323172;5827.737751801179;5837.270341207349;5843.9707801461145;5598.076317407623;5618.63478873876;5619.8595035124445;5628.722171149914;5633.887322253532;6313;6333.334999824998;6413.29453760086;6427.8393040173905;6446.742130314782;4779.3308936748535;4789.832355867528;4796.9760151199025;4839.7096174229655;4841.443234028096;6603.438707709851;6627.93372066278;6646;6688.832779180462;6703.195616525999;4936.950630493721;4943.826966056171;4957.652964292537;4960.611028911911;4997.9500204997485;4937.1606826839525;4958.281049247839;5000.949990500048;5051.924221136685;5079.949200508022;5388.299521062237;5466.699331536804;5475.698836564027;5531.557475401958;5611.5230205433;6231.068368805685;6314.589551679126;6331.366863313724;6343.302236753953;6359.713812878432;1702.6509565539034;1731.6796392667397;1731.6882961067129;1743.7733094697862;1746.1531157388656;1142.5144313666658;1235.8702336254564;1239.20690757915;1239.2688313894846;1240.8821161989777;5878.147668588031;6068.666223357758;6105.938940610626;6106.816795496142;6112.144299798032;6333.398327158912;6388.361163883575;6504.739810407626;6523.151990241333;6534.607923524603;6071.210742603522;6115.627326461601;6124.11200375943;6132.938670613326;6150.169727086875;3380.323935212967;3381.4758712399616;3399.7960122392738;3458.844352004166;3472.808995505221;6692.196936367667;6827.658617069226;6844.384005439534;6869.622170780555;6873.793786186422;6516.6415847128865;6595.493712389261;6621.768238111643;6654.866902662016;6677.799666010027;6737.562058466184;6795.320467953264;6822.658867056528;6870.660221256807;6874.209465911485;6418.967905160444;6420.935790642034;6458.128152699325;6462.483001359786;6528.2492513359675;6394.26465956421;6405.423511883952;6449.161608990801;6457.6771161442675;6464.838379040373;6776.796696099125;6794.76218332356;6805;6812.250652428328;6816.2502124767225;4894;4903.460619331942;4908.183971930409;4949.33184020167;4957.206846904623;6484.319146489551;6525.846470664575;6531.444827189552;6557.704703419077;6568.671566421564;6204.317525072329;6286.874262514815;6332.208473940757;6335.904961425675;6352.457992535359;6226.159468471698;6277.874442511215;6280.214973128359;6292.622442653455;6335.778247761306;6300.873982520416;6308.747650093945;6333.8733225336155;6335.4931605472375;6345;5834.329052159056;6252.843678908063;6325.652089135142;6372.58578192416;6435;6036.215292012011;6068.848278793065;6080.939190608037;6132.202813634378;6193.071039344134 06:32:03 INFO - PID 14951 | |5;yui.html;930.0652843891887;931.729798358476;933.7805615680318;955.0926619711272;959.1367769007892;18654.90672546637;18710.4386868394;19081.42755717329;19092.61814763704;19104.522386940334;19551.315703950364;21358.252461163862;21463.785362146373;21482.570348593057;21586.784132158675;1036.8755749310073;1070.4380200394778;1071.930324528907;1071.9892801071967;1075.1237741240864;1081.9567217311298;1083.5828206140652;1087.2280680716701;1089.0362029603778;1090.1061129873508;840.3403328387217;867.8134201146752;1062.139666869834;1085.9945700271487;1104.7845670094334;1095.1731442760745;1102.2725001499052;1102.7629059752192;1102.8400881872124;1104.4312179227704;806.1011971651625;810.4043528006911;811.8822770698216;812.3622955979587;813.8209593889335;19017.904910475358;20105.798942010686;20312;20397.38807835767;20583.691244631344;20511;20863.687044694343;21008.264710735202;21029.263975760776;21148.365549033555;15584.142872142027;16194.433194838242;16344.75482867746;16363.83636163635;16417.42539011129;3505.4040813061843;3582.337267605475;3583.050491619723;3584.964150358489;3596.892093237207;132355.33822330923;133238.33380833032;135982;137192;138747.99999999898;13958.162510249418;14717.55847324582;14730.852691473163;14772.335244914004;14855.2572371381;28916.566251506243;29113.854430728134;30470.390592188032;30557.847210763804;31618.841905790785;8617.35369847264;8788.780280493038;8862.379633425728;8888.955555222183;8917.242034427016;3948.703847211413;4071.5114186297833;4107.240160570304;4140.296149654566;4204.810783514749;5348.598855085884;5534.059209934321;5535.557155427637;5537.169424586345;5545.057340252167;962.8892677342055;1006.7835415385728;1007.6725064354114;1149.9080073594093;1201.1051766434064;722.6820199112374;730.2660825869966;737.181728281607;744.9962750186214;747.3199388556387;12179.695507612203;12520.436580353906;12880.162789418846;12883.420246088948;13353.332333383292;703.3880523944099;732.9010583571256;739.3789217057697;739.8483310921248;757.038561027492;5316.175992721134;5683.516901063456;5711.600187986801;5727.627704199213;5917.023691090922;124215;128281.35859320643;128541;129086;131633;108391.45804270929;111163.44418277856;112604;113227;118219.40890295494;95710;96353.51823240839;96455.035449646;96697;99968.50015749874;11859.52561897549;11880.940595296968;12025.398730063287;12043.879561204276;12228.32744199042;45632.04738926775;47273.527264726916;47406;49070.509294906595;49912.25131623101;60719.39280607137;61059.694701526205;61479;63856.36143638504;65344.34655653383;17430.215640295963;17510.474685759447;17603.471895843144;17610.471685849447;17695.823041769934;18322.26710931548;19142.330018449287;19151.52121196981;19153.808461915203;19249.32627358036;15329.6167595811;16039;16085.839141608434;16105.67788644244;16170.67658646797;17210.13949302555;21468.248611298528;22102.447438814157;22173.556528869656;22211.888940555193;18474.16866241049;18726;21368.57262854703;21394.57210855743;21434.89282553577;12169.878301216875;13144.27706476153;14747.852521474648;14876.181810000553;15108.471203507825;15332.923335383697;15778.60553486126;15844.762328565312;15964.441244556385;16211.270492827614 06:32:03 INFO - PID 14951 | __end_tp_report 06:32:03 INFO - PID 14951 | __start_cc_report 06:32:03 INFO - PID 14951 | _x_x_mozilla_cycle_collect,319 06:32:03 INFO - PID 14951 | __end_cc_report 06:32:03 INFO - PID 14951 | __startTimestamp1500298323124__endTimestamp 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | ------- Summary: start ------- 06:32:03 INFO - PID 14951 | Number of tests: 6 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | [#0] dojo.html Cycles:165 Average:6077.50 Median:6324.84 stddev:756.17 (12.0%) stddev-sans-first:727.07 06:32:03 INFO - PID 14951 | Values: 3327.6 3345.7 3380.0 3384.6 3409.1 6053.7 6072.1 6129.6 6134.1 6155.9 6137.9 6166.2 6167.7 6172.5 6190.1 5375.4 5384.3 5385.5 5412.6 5449.6 5405.3 5428.3 5428.7 5438.0 5439.5 5430.4 5433.3 5433.9 5435.6 5442.5 5422.2 5425.0 5426.8 5431.0 5437.4 5293.1 5387.5 5402.9 5418.0 5461.8 6130.0 6162.1 6175.8 6211.4 6224.9 6511.2 6512.0 6543.6 6646.9 6667.0 6471.4 6525.4 6549.1 6562.0 6569.8 6001.4 6014.1 6024.8 6046.4 6049.6 6621.4 6626.8 6731.7 6752.7 6865.5 6433.6 6506.6 6525.1 6576.2 6614.4 6586.4 6615.9 6662.2 6674.6 6686.0 6464.3 6531.1 6540.8 6566.9 6596.0 6101.7 6478.4 6525.7 6572.9 6590.7 4926.4 4945.6 4964.1 5011.8 5016.3 4417.9 4438.2 4452.5 4454.1 4472.7 6287.7 6292.2 6295.2 6297.9 6300.3 6560.8 6614.8 6625.0 6627.4 6643.1 6163.3 6301.1 6306.4 6316.7 6324.8 5680.8 5715.8 5719.2 5734.8 5745.9 6059.4 7024.6 7033.6 7120.0 7139.7 6566.8 6572.9 6594.2 6680.9 6683.8 6849.3 6993.4 7005.1 7072.4 7085.5 6423.8 6427.8 6440.7 6441.4 6445.3 5657.3 6551.4 6604.3 6681.0 6765.8 6411.0 6460.4 6486.4 6510.5 6511.5 6380.0 6434.2 6495.3 6498.1 6510.9 6308.5 6373.7 6383.2 6391.3 6393.7 5578.6 6310.8 6381.2 6476.4 6477.4 6267.4 6324.8 6374.7 6384.6 6388.2 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | [#1] ext.html Cycles:180 Average:41714.29 Median:18844.72 stddev:66384.28 (352.3%) stddev-sans-first:66499.67 06:32:03 INFO - PID 14951 | Values: 871.4 889.1 921.7 929.6 935.8 38846.8 40399.8 40414.4 40522.8 40580.4 42019.2 42197.2 42301.0 42419.2 42466.6 6970.5 7095.4 7101.0 7104.0 7113.8 6935.6 7031.3 7034.1 7049.2 7059.2 7029.2 7041.2 7053.0 7065.0 7092.2 6987.2 7019.6 7042.8 7051.3 7093.0 6861.1 6869.8 6898.2 6940.4 6940.6 37552.2 37860.0 37992.2 38114.6 38119.0 3427.6 3455.5 3455.6 3455.9 3459.2 29682.6 29919.9 29998.9 30020.0 30068.5 4739.5 4848.6 4954.4 4973.1 5055.2 209090.0 211205.0 258688.0 263832.0 276849.0 49994.0 50208.5 50241.0 50268.2 50370.0 51930.0 52298.7 52322.2 52375.2 52536.7 16032.4 16293.8 16330.7 16472.0 16543.3 13440.9 13515.4 13521.3 13525.9 13558.1 14274.4 14424.4 14484.7 14552.1 14615.0 5731.8 5734.2 5779.5 5841.7 5905.9 1055.6 1066.6 1072.8 1074.3 1090.6 23612.3 23922.3 24041.3 24627.6 24660.4 1159.4 1160.3 1164.2 1195.3 1199.2 12773.8 12816.6 12840.0 12915.0 12959.2 285601.0 286105.0 287469.0 288139.0 289018.0 46756.0 47505.3 50415.0 51637.5 52457.2 1429.4 1480.9 1488.1 1503.1 1507.0 27271.9 28444.6 28634.4 28640.6 28912.7 32590.5 32672.7 32673.5 32810.5 43179.1 220578.0 222046.0 222459.0 232462.0 239423.0 33406.3 33956.8 34056.0 34130.8 34261.8 40277.4 42466.0 42689.8 42773.1 43263.8 31175.7 31449.7 31629.0 31710.5 31763.5 31694.8 32184.5 32567.8 32576.5 32650.5 41224.2 42224.4 42463.0 42545.4 42551.8 32682.3 33557.5 34381.5 34685.0 34710.3 25495.7 25619.5 25825.9 25911.5 26161.6 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | [#2] jquery.html Cycles:180 Average:40840.91 Median:12363.94 stddev:103501.35 (837.1%) stddev-sans-first:103747.52 06:32:03 INFO - PID 14951 | Values: 567.4 567.8 573.5 585.5 606.7 22474.1 23032.4 23306.7 23352.5 23433.5 26085.6 26849.0 28210.2 28429.3 28433.4 6674.6 6828.5 6844.4 6848.2 6865.0 6719.7 6742.5 6767.6 6769.7 6805.9 4632.5 5973.7 6069.0 6727.5 6797.2 6742.3 6756.5 6760.2 6786.4 6814.9 6611.1 6622.7 6632.3 6649.7 6658.2 29621.9 31980.2 32104.7 32527.3 32579.3 2184.7 2220.7 2253.8 2257.5 2257.5 20098.5 20762.5 20764.8 20807.4 20831.2 2428.3 2439.6 2507.1 2524.2 2525.4 143884.0 145029.3 147047.0 150487.0 150739.0 21214.4 21754.0 22336.6 22629.5 24363.3 46456.5 46580.5 46633.5 46640.0 46711.8 11773.6 11976.6 12044.0 12096.8 12146.8 9671.7 9699.0 9736.0 9762.0 9785.2 11863.4 12061.5 12112.6 12202.4 12264.3 3399.5 3902.6 4165.8 4266.8 4517.5 1023.5 1025.9 1037.2 1045.9 1056.9 20225.7 20365.8 20397.8 20440.5 20816.1 1065.9 1073.7 1076.1 1081.9 1090.0 11180.9 11193.6 11453.0 11484.9 11557.4 587633.0 615219.0 626167.0 638600.0 640019.0 123243.4 123943.4 129441.4 129532.4 131082.3 1181.0 1191.4 1193.3 1223.7 1229.2 17433.5 18319.6 18345.7 18564.2 19064.7 56612.7 59231.0 60253.1 62301.0 64163.0 73242.0 74182.6 74845.0 75155.6 76553.6 19680.6 19835.2 19920.0 20016.8 20218.6 23160.3 23436.0 23502.8 23733.5 24039.6 18359.9 19292.7 19327.0 19456.3 19615.3 15607.5 15872.5 16778.4 16904.3 17083.5 18527.9 18743.3 18944.2 18952.3 19114.2 18861.1 19599.0 19695.0 19729.5 19810.9 18918.5 18947.2 19161.3 19186.0 19234.8 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | [#3] mootools.html Cycles:180 Average:9734.83 Median:2598.02 stddev:6984.24 (268.8%) stddev-sans-first:6975.96 06:32:03 INFO - PID 14951 | Values: 1430.6 1459.2 1479.7 1485.0 1498.9 14786.9 15595.4 15632.9 15636.2 15646.2 14876.5 15554.8 16193.7 16224.1 16353.3 2652.2 2714.4 2720.1 2726.4 2731.7 2549.3 2613.2 2618.5 2621.4 2631.1 2534.9 2535.3 2559.5 2581.4 2582.9 2655.4 2778.5 2779.1 2783.6 2797.0 2650.3 2671.9 2676.6 2678.2 2682.7 15039.1 15181.2 15201.0 15213.8 15310.1 8073.5 8355.0 8359.1 8368.5 8431.4 4965.9 5135.5 5317.1 5317.4 5346.9 1788.0 1821.0 1839.1 1874.0 1879.1 26751.7 26781.5 26799.3 26923.2 26930.3 6966.8 7000.8 7039.4 7089.4 7133.8 17976.8 17996.4 18014.5 18123.7 18137.2 8217.7 8324.4 8328.4 8353.8 8372.1 7567.5 7693.6 7723.7 7820.9 7890.0 5159.7 5390.6 5431.2 5445.0 5508.3 1544.7 1553.6 1568.5 1572.8 1578.5 863.7 872.7 891.8 897.9 907.2 7599.0 7636.4 7648.0 9352.9 9488.8 1015.7 1024.6 1037.3 1050.8 1070.5 5431.4 5521.8 5690.3 5702.7 5826.8 22171.4 22250.0 22402.4 22522.1 22750.0 22072.6 22562.2 22954.8 23129.7 23377.6 11730.0 12450.5 12474.7 12513.9 12544.2 8369.9 8422.8 8573.7 8577.7 8655.1 18849.5 19049.8 19627.9 20163.9 20168.3 18652.9 19091.3 20268.5 20293.0 20605.1 12816.7 13139.8 13143.3 13153.0 13164.3 14841.6 15232.8 15289.8 15342.7 15381.9 12410.2 12441.8 12588.1 12654.5 12786.7 12159.8 12206.3 12224.8 12426.2 12833.1 9838.2 9870.1 9877.8 9888.3 9926.9 6787.6 7024.3 7126.1 7153.6 7233.5 7221.2 7285.0 7315.3 7386.3 7387.0 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | [#4] prototype.html Cycles:180 Average:5387.64 Median:6020.29 stddev:1532.74 (25.5%) stddev-sans-first:1492.35 06:32:03 INFO - PID 14951 | Values: 492.1 512.5 534.0 537.3 538.4 5925.9 5977.6 6010.3 6010.6 6029.9 5656.2 5852.7 5902.6 5923.3 5945.7 4632.0 4639.0 4652.6 4707.1 4718.7 4648.0 4657.7 4686.7 4688.0 4729.7 4637.3 4644.8 4649.7 4674.9 4701.6 4463.2 4574.8 4624.7 4659.0 4681.0 4219.9 4221.5 4233.7 4266.1 4273.9 5796.9 5807.9 5827.7 5837.3 5844.0 5598.1 5618.6 5619.9 5628.7 5633.9 6313.0 6333.3 6413.3 6427.8 6446.7 4779.3 4789.8 4797.0 4839.7 4841.4 6603.4 6627.9 6646.0 6688.8 6703.2 4937.0 4943.8 4957.7 4960.6 4998.0 4937.2 4958.3 5000.9 5051.9 5079.9 5388.3 5466.7 5475.7 5531.6 5611.5 6231.1 6314.6 6331.4 6343.3 6359.7 1702.7 1731.7 1731.7 1743.8 1746.2 1142.5 1235.9 1239.2 1239.3 1240.9 5878.1 6068.7 6105.9 6106.8 6112.1 6333.4 6388.4 6504.7 6523.2 6534.6 6071.2 6115.6 6124.1 6132.9 6150.2 3380.3 3381.5 3399.8 3458.8 3472.8 6692.2 6827.7 6844.4 6869.6 6873.8 6516.6 6595.5 6621.8 6654.9 6677.8 6737.6 6795.3 6822.7 6870.7 6874.2 6419.0 6420.9 6458.1 6462.5 6528.2 6394.3 6405.4 6449.2 6457.7 6464.8 6776.8 6794.8 6805.0 6812.3 6816.3 4894.0 4903.5 4908.2 4949.3 4957.2 6484.3 6525.8 6531.4 6557.7 6568.7 6204.3 6286.9 6332.2 6335.9 6352.5 6226.2 6277.9 6280.2 6292.6 6335.8 6300.9 6308.7 6333.9 6335.5 6345.0 5834.3 6252.8 6325.7 6372.6 6435.0 6036.2 6068.8 6080.9 6132.2 6193.1 06:32:03 INFO - PID 14951 | 06:32:03 INFO - PID 14951 | [#5] yui.html Cycles:180 Average:25292.36 Median:19400.32 stddev:35806.52 (184.6%) stddev-sans-first:35860.24 06:32:03 INFO - PID 14951 | Values: 930.1 931.7 933.8 955.1 959.1 18654.9 18710.4 19081.4 19092.6 19104.5 19551.3 21358.3 21463.8 21482.6 21586.8 1036.9 1070.4 1071.9 1072.0 1075.1 1082.0 1083.6 1087.2 1089.0 1090.1 840.3 867.8 1062.1 1086.0 1104.8 1095.2 1102.3 1102.8 1102.8 1104.4 806.1 810.4 811.9 812.4 813.8 19017.9 20105.8 20312.0 20397.4 20583.7 20511.0 20863.7 21008.3 21029.3 21148.4 15584.1 16194.4 16344.8 16363.8 16417.4 3505.4 3582.3 3583.1 3585.0 3596.9 132355.3 133238.3 135982.0 137192.0 138748.0 13958.2 14717.6 14730.9 14772.3 14855.3 28916.6 29113.9 30470.4 30557.8 31618.8 8617.4 8788.8 8862.4 8889.0 8917.2 3948.7 4071.5 4107.2 4140.3 4204.8 5348.6 5534.1 5535.6 5537.2 5545.1 962.9 1006.8 1007.7 1149.9 1201.1 722.7 730.3 737.2 745.0 747.3 12179.7 12520.4 12880.2 12883.4 13353.3 703.4 732.9 739.4 739.8 757.0 5316.2 5683.5 5711.6 5727.6 5917.0 124215.0 128281.4 128541.0 129086.0 131633.0 108391.5 111163.4 112604.0 113227.0 118219.4 95710.0 96353.5 96455.0 96697.0 99968.5 11859.5 11880.9 12025.4 12043.9 12228.3 45632.0 47273.5 47406.0 49070.5 49912.3 60719.4 61059.7 61479.0 63856.4 65344.3 17430.2 17510.5 17603.5 17610.5 17695.8 18322.3 19142.3 19151.5 19153.8 19249.3 15329.6 16039.0 16085.8 16105.7 16170.7 17210.1 21468.2 22102.4 22173.6 22211.9 18474.2 18726.0 21368.6 21394.6 21434.9 12169.9 13144.3 14747.9 14876.2 15108.5 15332.9 15778.6 15844.8 15964.4 16211.3 06:32:03 INFO - PID 14951 | -------- Summary: end -------- 06:32:03 INFO - PID 14951 | 06:32:03 INFO - TEST-INFO | 14951: exit 0 06:32:03 INFO - TEST-OK | dromaeo_css | took 1108980ms 06:32:03 INFO - TEST-START | kraken 06:32:03 INFO - Initialising browser for kraken test... 06:32:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34296/getInfo.html -profile /tmp/tmpfHJV8E/profile 06:32:03 INFO - TEST-INFO | started process 15362 (/builds/slave/test/build/application/firefox/firefox http://localhost:34296/getInfo.html) 06:32:09 INFO - TEST-INFO | 15362: exit 0 06:32:09 INFO - Browser initialized. 06:32:09 INFO - Running cycle 1/1 for kraken test... 06:32:09 INFO - TEST-INFO | started process 15571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfHJV8E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:21 INFO - PID 15571 | RSS: Main: 160215040 06:32:21 INFO - PID 15571 | 06:32:23 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34296/tests/kraken/driver.html?testName=audio-beat-detection) 06:32:24 INFO - PID 15571 | RSS: Main: 166690816 06:32:24 INFO - PID 15571 | 06:32:26 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34296/tests/kraken/driver.html?testName=audio-dft) 06:32:27 INFO - PID 15571 | RSS: Main: 167518208 06:32:27 INFO - PID 15571 | 06:32:30 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34296/tests/kraken/driver.html?testName=audio-fft) 06:32:31 INFO - PID 15571 | RSS: Main: 161460224 06:32:31 INFO - PID 15571 | 06:32:33 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34296/tests/kraken/driver.html?testName=audio-oscillator) 06:32:33 INFO - PID 15571 | RSS: Main: 162377728 06:32:33 INFO - PID 15571 | 06:32:35 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:32:36 INFO - PID 15571 | RSS: Main: 162185216 06:32:36 INFO - PID 15571 | 06:32:39 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34296/tests/kraken/driver.html?testName=imaging-darkroom) 06:32:39 INFO - PID 15571 | RSS: Main: 162320384 06:32:39 INFO - PID 15571 | 06:32:43 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34296/tests/kraken/driver.html?testName=imaging-desaturate) 06:32:43 INFO - PID 15571 | RSS: Main: 165224448 06:32:43 INFO - PID 15571 | 06:32:46 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34296/tests/kraken/driver.html?testName=json-parse-financial) 06:32:47 INFO - PID 15571 | RSS: Main: 166641664 06:32:47 INFO - PID 15571 | 06:32:48 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:32:49 INFO - PID 15571 | RSS: Main: 166686720 06:32:49 INFO - PID 15571 | 06:32:50 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:32:51 INFO - PID 15571 | RSS: Main: 166883328 06:32:51 INFO - PID 15571 | 06:32:53 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:32:54 INFO - PID 15571 | RSS: Main: 166490112 06:32:54 INFO - PID 15571 | 06:32:56 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:32:57 INFO - PID 15571 | RSS: Main: 166744064 06:32:57 INFO - PID 15571 | 06:33:00 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:33:00 INFO - PID 15571 | RSS: Main: 166604800 06:33:00 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | Cycle 1(1): loaded http://localhost:34296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34296/tests/kraken/driver.html?testName=ai-astar) 06:33:02 INFO - PID 15571 | RSS: Main: 168235008 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | __start_tp_report 06:33:02 INFO - PID 15571 | _x_x_mozilla_page_load 06:33:02 INFO - PID 15571 | _x_x_mozilla_page_load_details 06:33:02 INFO - PID 15571 | |i|pagename|runs| 06:33:02 INFO - PID 15571 | |0;ai-astar;109;97;109;107;109;107;108;109;108;109 06:33:02 INFO - PID 15571 | |1;audio-beat-detection;148;117;144;181;122;153;149;117;163;119 06:33:02 INFO - PID 15571 | |2;audio-dft;162;161;161;163;161;161;162;160;170;168 06:33:02 INFO - PID 15571 | |3;audio-fft;75;77;74;74;75;158;76;75;74;76 06:33:02 INFO - PID 15571 | |4;audio-oscillator;81;81;132;81;80;81;130;80;79;124 06:33:02 INFO - PID 15571 | |5;imaging-gaussian-blur;114;113;114;114;113;114;114;114;114;114 06:33:02 INFO - PID 15571 | |6;imaging-darkroom;148;147;149;148;149;148;149;149;149;148 06:33:02 INFO - PID 15571 | |7;imaging-desaturate;95;95;95;95;94;95;95;94;95;94 06:33:02 INFO - PID 15571 | |8;json-parse-financial;50;51;50;51;53;51;46;51;48;53 06:33:02 INFO - PID 15571 | |9;json-stringify-tinderbox;54;54;54;55;57;54;54;55;55;55 06:33:02 INFO - PID 15571 | |10;stanford-crypto-aes;77;75;77;76;75;75;75;76;76;82 06:33:02 INFO - PID 15571 | |11;stanford-crypto-ccm;121;143;120;133;126;123;127;132;117;142 06:33:02 INFO - PID 15571 | |12;stanford-crypto-pbkdf2;179;178;171;173;172;177;180;172;179;172 06:33:02 INFO - PID 15571 | |13;stanford-crypto-sha256-iterative;64;62;62;64;62;62;64;61;61;61 06:33:02 INFO - PID 15571 | __end_tp_report 06:33:02 INFO - PID 15571 | __start_cc_report 06:33:02 INFO - PID 15571 | _x_x_mozilla_cycle_collect,844 06:33:02 INFO - PID 15571 | __end_cc_report 06:33:02 INFO - PID 15571 | __startTimestamp1500298382840__endTimestamp 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | ------- Summary: start ------- 06:33:02 INFO - PID 15571 | Number of tests: 14 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.00 stddev:3.68 (3.4%) stddev-sans-first:3.84 06:33:02 INFO - PID 15571 | Values: 109.0 97.0 109.0 107.0 109.0 107.0 108.0 109.0 108.0 109.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:148.50 stddev:21.97 (14.8%) stddev-sans-first:23.17 06:33:02 INFO - PID 15571 | Values: 148.0 117.0 144.0 181.0 122.0 153.0 149.0 117.0 163.0 119.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:3.35 (2.1%) stddev-sans-first:3.54 06:33:02 INFO - PID 15571 | Values: 162.0 161.0 161.0 163.0 161.0 161.0 162.0 160.0 170.0 168.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:26.23 (35.0%) stddev-sans-first:27.65 06:33:02 INFO - PID 15571 | Values: 75.0 77.0 74.0 74.0 75.0 158.0 76.0 75.0 74.0 76.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:80.50 stddev:23.39 (29.1%) stddev-sans-first:24.26 06:33:02 INFO - PID 15571 | Values: 81.0 81.0 132.0 81.0 80.0 81.0 130.0 80.0 79.0 124.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:33:02 INFO - PID 15571 | Values: 114.0 113.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:33:02 INFO - PID 15571 | Values: 148.0 147.0 149.0 148.0 149.0 148.0 149.0 149.0 149.0 148.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:33:02 INFO - PID 15571 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:2.12 (4.2%) stddev-sans-first:2.24 06:33:02 INFO - PID 15571 | Values: 50.0 51.0 50.0 51.0 53.0 51.0 46.0 51.0 48.0 53.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.97 06:33:02 INFO - PID 15571 | Values: 54.0 54.0 54.0 55.0 57.0 54.0 54.0 55.0 55.0 55.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.00 stddev:2.12 (2.8%) stddev-sans-first:2.24 06:33:02 INFO - PID 15571 | Values: 77.0 75.0 77.0 76.0 75.0 75.0 75.0 76.0 76.0 82.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.50 stddev:8.97 (6.9%) stddev-sans-first:9.11 06:33:02 INFO - PID 15571 | Values: 121.0 143.0 120.0 133.0 126.0 123.0 127.0 132.0 117.0 142.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:177.50 stddev:3.59 (2.0%) stddev-sans-first:3.55 06:33:02 INFO - PID 15571 | Values: 179.0 178.0 171.0 173.0 172.0 177.0 180.0 172.0 179.0 172.0 06:33:02 INFO - PID 15571 | 06:33:02 INFO - PID 15571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.17 06:33:02 INFO - PID 15571 | Values: 64.0 62.0 62.0 64.0 62.0 62.0 64.0 61.0 61.0 61.0 06:33:02 INFO - PID 15571 | -------- Summary: end -------- 06:33:02 INFO - PID 15571 | 06:33:03 INFO - PID 15571 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:33:03 INFO - TEST-INFO | 15571: exit 0 06:33:03 INFO - TEST-OK | kraken | took 59946ms 06:33:03 INFO - SUITE-END | took 1168s 06:33:04 INFO - Completed test suite (00:19:29) 06:33:04 INFO - javascript benchmark 06:33:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8763.095241877281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.633960264372, 3345.715614172795, 3379.966200337996, 3384.6107697614766, 3409.09658940381, 6053.697315134236, 6072.119542666316, 6129.601575897564, 6134.110553969677, 6155.9076613850775, 6137.877242455148, 6166.198394208758, 6167.660778657172, 6172.5061995040405, 6190.071489276611, 5375.354957405117, 5384.326959130109, 5385.488378604046, 5412.56699464042, 5449.64577302476, 5405.270288511059, 5428.267183930178, 5428.728563571825, 5438.048341540234, 5439.456054394549, 5430.429804870491, 5433.293671822657, 5433.864153396177, 5435.619506634537, 5442.455754424545, 5422.15956526739, 5424.996375670514, 5426.8371948841595, 5431.022415965124, 5437.401885792559, 5293.126634105368, 5387.4612538746205, 5402.864928376783, 5418.0, 5461.808836690697, 6130.04984227441, 6162.13730077785, 6175.814725558241, 6211.378862113797, 6224.937750622526, 6511.218653761579, 6511.967440162816, 6543.607383557001, 6646.93353066468, 6666.966620173881, 6471.385218404244, 6525.412712855818, 6549.115869357671, 6561.982892651647, 6569.80290591283, 6001.369856165084, 6014.097885317194, 6024.8493787655225, 6046.425589568984, 6049.637021778707, 6621.437177839889, 6626.768063117768, 6731.697073631698, 6752.662366881636, 6865.519413641097, 6433.581817181868, 6506.60960342381, 6525.086487891699, 6576.210854697467, 6614.404703576605, 6586.4072233498255, 6615.900761488581, 6662.233843108104, 6674.5995240284765, 6685.966570167118, 6464.321246269168, 6531.0856480092825, 6540.8364790880605, 6566.868662626721, 6596.0, 6101.725422356005, 6478.449331806755, 6525.706343214567, 6572.901406478906, 6590.736370545221, 4926.3842019747535, 4945.604351651859, 4964.056829202512, 5011.84964451067, 5016.297718319438, 4417.911641767147, 4438.201123797748, 4452.48796388413, 4454.064646424287, 4472.709273897186, 6287.654179020198, 6292.2134733158355, 6295.24457065146, 6297.905531416941, 6300.30696623371, 6560.8359791005605, 6614.801555953329, 6624.966875165594, 6627.4366678831875, 6643.136392269071, 6163.291221509584, 6301.14934483848, 6306.432421082125, 6316.652584107918, 6324.841878953063, 5680.7727690892725, 5715.771369145271, 5719.19931209631, 5734.827955161351, 5745.8563535911935, 6059.413354324977, 7024.578525288499, 7033.577985320897, 7120.0387947626405, 7139.714411423485, 6566.770163044366, 6572.901406478811, 6594.208694956444, 6680.899786503206, 6683.799486015428, 6849.2808255132495, 6993.405560527209, 7005.124359455068, 7072.434205263669, 7085.468589855678, 6423.839404014937, 6427.775027874002, 6440.710168042543, 6441.3880681335195, 6445.323241059621, 5657.294472120768, 6551.44312733404, 6604.339566043357, 6680.966595166993, 6765.763198288037, 6411.0383442484, 6460.353964603502, 6486.3513648636645, 6510.5117116217425, 6511.511636627367, 6380.01265522422, 6434.227892652912, 6495.253045899782, 6498.057781621733, 6510.902336464862, 6308.463780578702, 6373.745050198126, 6383.170187875732, 6391.296957334596, 6393.680315984089, 5578.553715702815, 6310.842228944313, 6381.170447841937, 6476.384743449365, 6477.352264773674, 6267.373262673696, 6324.810255692337, 6374.74501019954, 6384.648844313608, 6388.201474815648], "value": 6022.400623916014, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.3696932432823, 889.0675083564503, 921.6820197032023, 929.6420877961982, 935.7567032571534, 38846.8057659712, 40399.79800100999, 40414.39378409326, 40522.7973860131, 40580.39129413061, 42019.15961680764, 42197.15605687884, 42301.0, 42419.15161696772, 42466.57533424665, 6970.512064155511, 7095.361417472453, 7101.04135941649, 7104.040954471157, 7113.786586402416, 6935.618540980244, 7031.296870312954, 7034.085568876065, 7049.224585295613, 7059.223485416625, 7029.22678505364, 7041.19026311973, 7052.964735176317, 7064.964675176642, 7092.219855815856, 6987.231404545496, 7019.6139212343305, 7042.823929401755, 7051.259617740115, 7092.964535177317, 6861.073755043055, 6869.7595584154815, 6898.206706228798, 6940.444764418834, 6940.583564986117, 37552.24895502102, 37860.0, 37992.24015519702, 38114.618853811386, 38119.0, 3427.605825330069, 3455.51622772812, 3455.58532976042, 3455.861765529401, 3459.221675123102, 29682.55476167859, 29919.85040074786, 29998.85000575005, 30020.0, 30068.548971765442, 4739.478657347689, 4848.563629273347, 4954.380702412199, 4973.1297023020825, 5055.241713742968, 209090.0, 211205.0, 258688.0, 263832.0, 276848.99999999796, 49994.0, 50208.49791502038, 50241.0, 50268.24597631038, 50370.0, 51930.0, 52298.738506307986, 52322.21516677253, 52375.21437178445, 52536.73731631317, 16032.358705651643, 16293.837061629469, 16330.673386532202, 16472.0, 16543.338266469207, 13440.932795336157, 13515.391807368693, 13521.256330901699, 13525.864741352658, 13558.050936434354, 14274.429022838971, 14424.350904209336, 14484.710305793826, 14552.054116482395, 14615.0, 5731.77072917087, 5734.197212390269, 5779.508741756914, 5841.7371218295275, 5905.881882362329, 1055.6041484443333, 1066.6160182334354, 1072.84443755655, 1074.3070719386108, 1090.607381342716, 23612.29163125109, 23922.28233153008, 24041.323330463656, 24627.630585541232, 24660.38349041288, 1159.4434671357797, 1160.2920084763962, 1164.2003484748025, 1195.3126952002633, 1199.154596009811, 12773.808392874114, 12816.551420700418, 12840.0, 12915.031372647089, 12959.222446653232, 285601.0, 286105.0, 287469.0, 288139.0, 289018.0, 46756.0, 47505.28742068872, 50415.0, 51637.483625164015, 52457.2131418029, 1429.385364293343, 1480.9259537023106, 1488.1443170176974, 1503.1206744054632, 1506.954791356261, 27271.86364068167, 28444.57333140046, 28634.42731145407, 28640.570391444562, 28912.710872891003, 32590.51114233336, 32672.673273266962, 32673.509897352033, 32810.50784238286, 43179.13641727085, 220578.0, 222046.0, 222459.0, 232462.0, 239423.0, 33406.331873362884, 33956.830215848764, 34056.0, 34130.82934585411, 34261.82869085639, 40277.39583906185, 42466.0, 42689.78655106829, 42773.14453710971, 43263.78368108139, 31175.688243118188, 31449.685503144676, 31629.0, 31710.524342134424, 31763.523547147273, 31694.841525792224, 32184.517232241065, 32567.837160814044, 32576.51135233021, 32650.51024234591, 41224.175516488904, 42224.36663450112, 42463.0, 42545.361819572114, 42551.7872410636, 32682.34635307328, 33557.496637549964, 34381.484277735355, 34685.0, 34710.305793883475, 25495.745042549337, 25619.487610248063, 25825.870870645525, 25911.481770364866, 26161.607575885995], "value": 17539.79081897365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.449573913304, 567.8296511046685, 573.5268403567059, 585.5081731345668, 606.6905878002219, 22474.101035958563, 23032.42418939523, 23306.65040024397, 23352.532949341025, 23433.531329373425, 26085.608715869228, 26848.999999999953, 28210.15369538917, 28429.289267768316, 28433.431331373362, 6674.599524028574, 6828.52200345976, 6844.418224450903, 6848.246692863781, 6864.965675171642, 6719.664016799141, 6742.494312926526, 6767.56010859295, 6769.695363708645, 6805.863882722342, 4632.4672662643725, 5973.701314934257, 6068.96965515174, 6727.529072964894, 6797.150356205474, 6742.2920593337485, 6756.4932630052945, 6760.188777346701, 6786.389224969752, 6814.931850681479, 6611.140551728293, 6622.741679080959, 6632.303608121126, 6649.667516624198, 6658.201015878126, 29621.851890740625, 31980.200494987577, 32104.6789532104, 32527.349453011044, 32579.348413031843, 2184.6722991551237, 2220.655798351242, 2253.785890340415, 2257.5033492631596, 2257.5146343536217, 20098.497537561532, 20762.48093797667, 20764.792352076438, 20807.375778726662, 20831.16675332985, 2428.3443470263105, 2439.5852705040184, 2507.072383218221, 2524.204875464223, 2525.3812815860233, 143884.0, 145029.27485362612, 147047.0, 150487.0, 150739.0, 21214.36356909295, 21754.0, 22336.553268934855, 22629.547409051727, 24363.26910192697, 46456.5354346459, 46580.5341946583, 46633.53366466292, 46640.0, 46711.76644116758, 11773.645270945844, 11976.580819671444, 12043.95252807025, 12096.81854772179, 12146.757064858653, 9671.70984870455, 9699.030096990244, 9736.0, 9762.023797620323, 9785.217182625373, 11863.406829658656, 12061.527386885668, 12112.620006964205, 12202.38988050594, 12264.32546209967, 3399.473081672345, 3902.5902280260166, 4165.8333666653, 4266.786660666954, 4517.480489743656, 1023.4729114506035, 1025.8615086963164, 1037.2065369991963, 1045.9372437653765, 1056.9312994655322, 20225.696614550794, 20365.79634203639, 20397.796022039885, 20440.488987775425, 20816.063277152563, 1065.9040686338112, 1073.7261998190568, 1076.05844885725, 1081.9459027048615, 1089.9945500272606, 11180.888191117985, 11193.552257909592, 11453.0, 11484.94257528707, 11557.422128893522, 587633.0, 615219.0, 626167.0, 638600.0, 640019.0, 123243.38378308051, 123943.38028309801, 129441.35279323543, 129532.3523382377, 131082.34458827644, 1181.0, 1191.4162060590422, 1193.2601786892183, 1223.6512593910693, 1229.2010193374379, 17433.47699569015, 18319.633607328044, 18345.72481412753, 18564.164612592194, 19064.714029289295, 56612.716936415054, 59231.0, 60253.0962035561, 62301.0, 64163.0, 73242.0, 74182.62908685423, 74845.0, 75155.62422187853, 76553.61723191348, 19680.60638787245, 19835.206591736747, 19920.0, 20016.799832001492, 20218.59562808765, 23160.3051908443, 23436.0, 23502.764972350058, 23733.525329492968, 24039.63940540928, 18359.908200459446, 19292.71060934059, 19327.0, 19456.319028833925, 19615.31346402869, 15607.453739119077, 15872.52382428529, 16778.412755553498, 16904.32382704678, 17083.487495375157, 18527.907360463112, 18743.250269989047, 18944.242230311185, 18952.336668216547, 19114.235430583176, 18861.056947152312, 19599.0, 19695.0, 19729.506762331057, 19810.90094549518, 18918.52703682419, 18947.242110315983, 19161.32935347312, 19186.0, 19234.8076519233], "value": 13341.89846456086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.6494908747359, 1459.2411945788183, 1479.711456266028, 1484.9703005939875, 1498.9175595342258, 14786.926065369671, 15595.376184952616, 15632.921835390822, 15636.218189090529, 15646.217689115541, 14876.47932322369, 15554.84445155548, 16193.676126477463, 16224.10767407792, 16353.345866165339, 2652.1910817200746, 2714.3892624159603, 2720.1295585412677, 2726.427450235453, 2731.740484653955, 2549.2734570647367, 2613.176849292476, 2618.4632150409216, 2621.3970786719065, 2631.13172653025, 2534.885930133139, 2535.277445927911, 2559.4881023795315, 2581.393372557457, 2582.8579428131447, 2655.3759866431374, 2778.4859800936892, 2779.110684580935, 2783.554631258989, 2797.0350229170904, 2650.2844232057428, 2671.9332016699545, 2676.6386537817534, 2678.196541037681, 2682.6512553368134, 15039.097654140678, 15181.16503592302, 15201.0, 15213.847861521353, 15310.081395116218, 8073.475224110414, 8354.958225208835, 8359.080501144868, 8368.539730314831, 8431.367647426467, 4965.900681986376, 5135.512126347991, 5317.12267475866, 5317.388500322435, 5346.866328341784, 1787.9553011174694, 1820.9817901820945, 1839.0988415676356, 1874.0161415256962, 1879.0833349983077, 26751.732482675117, 26781.464370712478, 26799.330016749544, 26923.1923042311, 26930.326741831414, 6966.79099627012, 7000.754973576002, 7039.366457018893, 7089.361957423754, 7133.824183624044, 17976.820231797778, 17996.37012704549, 18014.459566212772, 18123.72814407785, 18137.18382672783, 8217.712380066669, 8324.417290789586, 8328.417010809186, 8353.832923341499, 8372.120927302667, 7567.545947243183, 7693.615319234016, 7723.65243564041, 7820.882686759704, 7889.960550197212, 5159.716215608102, 5390.595705322116, 5431.21247419122, 5445.0, 5508.256385388001, 1544.652453198044, 1553.5572361877037, 1568.5451219146548, 1572.8269890312056, 1578.48699172767, 863.7408777366765, 872.6553011560525, 891.7815135291895, 897.9281657467387, 907.2469850024464, 7599.0, 7636.3890888728765, 7647.961760191163, 9352.906470935204, 9488.810223795623, 1015.7409860485529, 1024.5543188712934, 1037.3153718545875, 1050.8108540462638, 1070.4808168038496, 5431.402545719968, 5521.812810245817, 5690.2887139107615, 5702.714864256771, 5826.796062137805, 22171.44571385696, 22250.0, 22402.439939001655, 22522.099116035177, 22750.0, 22072.558548828933, 22562.210322638628, 22954.770452295597, 23129.653055204184, 23377.649335259986, 11730.0, 12450.501979920882, 12474.688132796753, 12513.937430312972, 12544.184627998968, 8369.916300836914, 8422.789430264293, 8573.74278771638, 8577.699780507652, 8655.134486551295, 18849.528761781065, 19049.809501905358, 19627.901860490605, 20163.89918050459, 20168.29410970609, 18652.906735466237, 19091.331803386816, 20268.493287667927, 20293.0, 20605.07277172561, 12816.743665126833, 13139.802902956271, 13143.342832858127, 13153.0, 13164.275964822027, 14841.554753357417, 15232.847671523587, 15289.770653439984, 15342.693146137239, 15381.923090384924, 12410.193337433038, 12441.813372799234, 12588.055895807667, 12654.493820247088, 12786.74426511446, 12159.756804863677, 12206.267623942593, 12224.816627750768, 12426.192297500633, 12833.101682882108, 9838.212942964403, 9870.062344077302, 9877.802443951225, 9888.258380621339, 9926.851097233692, 6787.5588086774205, 7024.297570242935, 7126.144862616312, 7153.606551639502, 7233.529820561646, 7221.241769614115, 7285.0, 7315.341619254293, 7386.2613738625705, 7387.039684840936], "value": 6895.554593346036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.1436700141754, 512.5028722139525, 533.9679619222844, 537.2559005776998, 538.440022376728, 5925.859294573877, 5977.641341519501, 6010.27876654802, 6010.6340449348345, 6029.9397006029985, 5656.179853921179, 5852.67810270435, 5902.645841249528, 5923.3188183358925, 5945.67298798567, 4631.976840115794, 4638.956234847149, 4652.627789776819, 4707.1056499265205, 4718.740469274188, 4648.02526383115, 4657.720536767804, 4686.742229177394, 4687.953120468803, 4729.739864307462, 4637.327587499811, 4644.767761611923, 4649.674522783406, 4674.883127921795, 4701.64737644678, 4463.218936686067, 4574.817007319703, 4624.699394539344, 4659.0, 4680.953190468086, 4219.852305169305, 4221.493420789494, 4233.708718840783, 4266.0827921996915, 4273.9358909616385, 5796.913046304308, 5807.883842323172, 5827.737751801179, 5837.270341207349, 5843.9707801461145, 5598.076317407623, 5618.63478873876, 5619.8595035124445, 5628.722171149914, 5633.887322253532, 6313.0, 6333.334999824998, 6413.29453760086, 6427.8393040173905, 6446.742130314782, 4779.3308936748535, 4789.832355867528, 4796.9760151199025, 4839.7096174229655, 4841.443234028096, 6603.438707709851, 6627.93372066278, 6646.0, 6688.832779180462, 6703.195616525999, 4936.950630493721, 4943.826966056171, 4957.652964292537, 4960.611028911911, 4997.9500204997485, 4937.1606826839525, 4958.281049247839, 5000.949990500048, 5051.924221136685, 5079.949200508022, 5388.299521062237, 5466.699331536804, 5475.698836564027, 5531.557475401958, 5611.5230205433, 6231.068368805685, 6314.589551679126, 6331.366863313724, 6343.302236753953, 6359.713812878432, 1702.6509565539034, 1731.6796392667397, 1731.6882961067129, 1743.7733094697862, 1746.1531157388656, 1142.5144313666658, 1235.8702336254564, 1239.20690757915, 1239.2688313894846, 1240.8821161989777, 5878.147668588031, 6068.666223357758, 6105.938940610626, 6106.816795496142, 6112.144299798032, 6333.398327158912, 6388.361163883575, 6504.739810407626, 6523.151990241333, 6534.607923524603, 6071.210742603522, 6115.627326461601, 6124.11200375943, 6132.938670613326, 6150.169727086875, 3380.323935212967, 3381.4758712399616, 3399.7960122392738, 3458.844352004166, 3472.808995505221, 6692.196936367667, 6827.658617069226, 6844.384005439534, 6869.622170780555, 6873.793786186422, 6516.6415847128865, 6595.493712389261, 6621.768238111643, 6654.866902662016, 6677.799666010027, 6737.562058466184, 6795.320467953264, 6822.658867056528, 6870.660221256807, 6874.209465911485, 6418.967905160444, 6420.935790642034, 6458.128152699325, 6462.483001359786, 6528.2492513359675, 6394.26465956421, 6405.423511883952, 6449.161608990801, 6457.6771161442675, 6464.838379040373, 6776.796696099125, 6794.76218332356, 6805.0, 6812.250652428328, 6816.2502124767225, 4894.0, 4903.460619331942, 4908.183971930409, 4949.33184020167, 4957.206846904623, 6484.319146489551, 6525.846470664575, 6531.444827189552, 6557.704703419077, 6568.671566421564, 6204.317525072329, 6286.874262514815, 6332.208473940757, 6335.904961425675, 6352.457992535359, 6226.159468471698, 6277.874442511215, 6280.214973128359, 6292.622442653455, 6335.778247761306, 6300.873982520416, 6308.747650093945, 6333.8733225336155, 6335.4931605472375, 6345.0, 5834.329052159056, 6252.843678908063, 6325.652089135142, 6372.58578192416, 6435.0, 6036.215292012011, 6068.848278793065, 6080.939190608037, 6132.202813634378, 6193.071039344134], "value": 4944.067700203867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.0652843891887, 931.729798358476, 933.7805615680318, 955.0926619711272, 959.1367769007892, 18654.90672546637, 18710.4386868394, 19081.42755717329, 19092.61814763704, 19104.522386940334, 19551.315703950364, 21358.252461163862, 21463.785362146373, 21482.570348593057, 21586.784132158675, 1036.8755749310073, 1070.4380200394778, 1071.930324528907, 1071.9892801071967, 1075.1237741240864, 1081.9567217311298, 1083.5828206140652, 1087.2280680716701, 1089.0362029603778, 1090.1061129873508, 840.3403328387217, 867.8134201146752, 1062.139666869834, 1085.9945700271487, 1104.7845670094334, 1095.1731442760745, 1102.2725001499052, 1102.7629059752192, 1102.8400881872124, 1104.4312179227704, 806.1011971651625, 810.4043528006911, 811.8822770698216, 812.3622955979587, 813.8209593889335, 19017.904910475358, 20105.798942010686, 20312.0, 20397.38807835767, 20583.691244631344, 20511.0, 20863.687044694343, 21008.264710735202, 21029.263975760776, 21148.365549033555, 15584.142872142027, 16194.433194838242, 16344.75482867746, 16363.83636163635, 16417.42539011129, 3505.4040813061843, 3582.337267605475, 3583.050491619723, 3584.964150358489, 3596.892093237207, 132355.33822330923, 133238.33380833032, 135982.0, 137192.0, 138747.99999999898, 13958.162510249418, 14717.55847324582, 14730.852691473163, 14772.335244914004, 14855.2572371381, 28916.566251506243, 29113.854430728134, 30470.390592188032, 30557.847210763804, 31618.841905790785, 8617.35369847264, 8788.780280493038, 8862.379633425728, 8888.955555222183, 8917.242034427016, 3948.703847211413, 4071.5114186297833, 4107.240160570304, 4140.296149654566, 4204.810783514749, 5348.598855085884, 5534.059209934321, 5535.557155427637, 5537.169424586345, 5545.057340252167, 962.8892677342055, 1006.7835415385728, 1007.6725064354114, 1149.9080073594093, 1201.1051766434064, 722.6820199112374, 730.2660825869966, 737.181728281607, 744.9962750186214, 747.3199388556387, 12179.695507612203, 12520.436580353906, 12880.162789418846, 12883.420246088948, 13353.332333383292, 703.3880523944099, 732.9010583571256, 739.3789217057697, 739.8483310921248, 757.038561027492, 5316.175992721134, 5683.516901063456, 5711.600187986801, 5727.627704199213, 5917.023691090922, 124215.0, 128281.35859320643, 128541.0, 129086.0, 131633.0, 108391.45804270929, 111163.44418277856, 112604.0, 113227.0, 118219.40890295494, 95710.0, 96353.51823240839, 96455.035449646, 96697.0, 99968.50015749874, 11859.52561897549, 11880.940595296968, 12025.398730063287, 12043.879561204276, 12228.32744199042, 45632.04738926775, 47273.527264726916, 47406.0, 49070.509294906595, 49912.25131623101, 60719.39280607137, 61059.694701526205, 61479.0, 63856.36143638504, 65344.34655653383, 17430.215640295963, 17510.474685759447, 17603.471895843144, 17610.471685849447, 17695.823041769934, 18322.26710931548, 19142.330018449287, 19151.52121196981, 19153.808461915203, 19249.32627358036, 15329.6167595811, 16039.0, 16085.839141608434, 16105.67788644244, 16170.67658646797, 17210.13949302555, 21468.248611298528, 22102.447438814157, 22173.556528869656, 22211.888940555193, 18474.16866241049, 18726.0, 21368.57262854703, 21394.57210855743, 21434.89282553577, 12169.878301216875, 13144.27706476153, 14747.852521474648, 14876.181810000553, 15108.471203507825, 15332.923335383697, 15778.60553486126, 15844.762328565312, 15964.441244556385, 16211.270492827614], "value": 9424.339680673695, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 97.0, 109.0, 107.0, 109.0, 107.0, 108.0, 109.0, 108.0, 109.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 144.0, 181.0, 122.0, 153.0, 149.0, 117.0, 163.0, 119.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 161.0, 161.0, 162.0, 160.0, 170.0, 168.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 74.0, 75.0, 158.0, 76.0, 75.0, 74.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 132.0, 81.0, 80.0, 81.0, 130.0, 80.0, 79.0, 124.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 51.0, 53.0, 51.0, 46.0, 51.0, 48.0, 53.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 57.0, 54.0, 54.0, 55.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 76.0, 75.0, 75.0, 75.0, 76.0, 76.0, 82.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 143.0, 120.0, 133.0, 126.0, 123.0, 127.0, 132.0, 117.0, 142.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 171.0, 173.0, 172.0, 177.0, 180.0, 172.0, 179.0, 172.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 64.0, 62.0, 62.0, 64.0, 61.0, 61.0, 61.0], "value": 62.3, "unit": "score"}]}]} 06:33:04 INFO - Return code: 0 06:33:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:33:04 INFO - # TBPL SUCCESS # 06:33:04 INFO - Running post-action listener: _package_coverage_data 06:33:04 INFO - Running post-action listener: _resource_record_post_action 06:33:04 INFO - [mozharness: 2017-07-17 13:33:04.153406Z] Finished run-tests step (success) 06:33:04 INFO - Running post-run listener: _resource_record_post_run 06:33:04 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 880640; Write bytes: 440008704; Read time: 140; Write time: 336356 06:33:04 INFO - TinderboxPrint: CPU usage
13.0% 06:33:04 INFO - TinderboxPrint: I/O read bytes / time
880,640 / 140 06:33:04 INFO - TinderboxPrint: I/O write bytes / time
440,008,704 / 336,356 06:33:04 INFO - TinderboxPrint: CPU idle
8,233.0 (87.0%) 06:33:04 INFO - TinderboxPrint: CPU user
1,185.3 (12.5%) 06:33:04 INFO - TinderboxPrint: Swap in / out
0 / 0 06:33:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116920320; Read time: 0; Write time: 84764 06:33:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:33:04 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 880640; Write bytes: 321867776; Read time: 140; Write time: 251516 06:33:04 INFO - Running post-run listener: _upload_blobber_files 06:33:04 INFO - Blob upload gear active. 06:33:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:33:04 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 06:33:04 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'] 06:33:04 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 06:33:05 INFO - Traceback (most recent call last): 06:33:05 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 06:33:05 INFO - main() 06:33:05 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 06:33:05 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 06:33:05 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 06:33:05 INFO - return set(response.json().get('whitelist', [])) 06:33:05 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 06:33:05 INFO - return json.loads(self.text or self.content, **kwargs) 06:33:05 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 06:33:05 INFO - return _default_decoder.decode(s) 06:33:05 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 06:33:05 INFO - obj, end = self.raw_decode(s) 06:33:05 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 06:33:05 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 06:33:05 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 06:33:05 ERROR - Return code: 1 06:33:05 INFO - Setting buildbot property blobber_files to {} 06:33:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:33:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:33:05 INFO - Contents: 06:33:05 INFO - blobber_files:{} 06:33:05 INFO - Running post-run listener: copy_logs_to_upload_dir 06:33:05 INFO - Copying logs to upload dir... 06:33:05 INFO - mkdir: /builds/slave/test/build/upload/logs 06:33:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.045438 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-17 06:33:05.069860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:33:05.075044) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/OC58s0ltQJmDlTRMwlff_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:33:05.126596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:33:05.126925) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500297002.742559-2022101353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:33:05.176429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:33:05.176770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:33:05.177098) ========= ========= Total master_lag: 0.14 =========