builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1501495040.7 results: success (0) revision: b1dcb20102b7598ec4d467530cd20ba9e8754de6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:20.701457) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:20.701861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:20.702144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:20.785320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:20.785576) ========= 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=ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 02:57:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 50.3M=0s 2017-07-31 02:57:21 (50.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218425 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.039788) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.040099) ========= 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=ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017063 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.092418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.092708) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1dcb20102b7598ec4d467530cd20ba9e8754de6 --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 b1dcb20102b7598ec4d467530cd20ba9e8754de6 --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=ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 02:57:21,165 truncating revision to first 12 chars 2017-07-31 02:57:21,165 Setting DEBUG logging. 2017-07-31 02:57:21,165 attempt 1/10 2017-07-31 02:57:21,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1dcb20102b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 02:57:21,486 unpacking tar archive at: mozilla-central-b1dcb20102b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635283 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.740198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.740483) ========= script_repo_revision: b1dcb20102b7598ec4d467530cd20ba9e8754de6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.740861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.741137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 02:57:21.752219) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-31 02:57:21.752572) ========= /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=ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:57:22 INFO - MultiFileLogger online at 20170731 02:57:22 in /builds/slave/test 02:57:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:57:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:22 INFO - {'append_to_log': False, 02:57:22 INFO - 'base_work_dir': '/builds/slave/test', 02:57:22 INFO - 'blob_upload_branch': 'Firefox', 02:57:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:22 INFO - 'branch': 'Firefox', 02:57:22 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:22 INFO - 'code_coverage': False, 02:57:22 INFO - 'config_files': ('talos/linux_config.py',), 02:57:22 INFO - 'default_actions': ('clobber', 02:57:22 INFO - 'read-buildbot-config', 02:57:22 INFO - 'download-and-extract', 02:57:22 INFO - 'populate-webroot', 02:57:22 INFO - 'create-virtualenv', 02:57:22 INFO - 'install', 02:57:22 INFO - 'setup-mitmproxy', 02:57:22 INFO - 'run-tests'), 02:57:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:22 INFO - 'disable_ccov_upload': False, 02:57:22 INFO - 'download_minidump_stackwalk': True, 02:57:22 INFO - 'download_symbols': 'ondemand', 02:57:22 INFO - 'enable_stylo': False, 02:57:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:57:22 INFO - 'tooltool.py': '/tools/tooltool.py', 02:57:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:57:22 INFO - '/tools/misc-python/virtualenv.py')}, 02:57:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:22 INFO - 'gecko_profile': False, 02:57:22 INFO - 'gecko_profile_interval': 0, 02:57:22 INFO - 'installer_path': 'installer.exe', 02:57:22 INFO - 'log_level': 'info', 02:57:22 INFO - 'log_name': 'talos', 02:57:22 INFO - 'log_to_console': True, 02:57:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:57:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:57:22 INFO - 'opt_config_files': (), 02:57:22 INFO - 'pip_index': False, 02:57:22 INFO - 'suite': 'dromaeojs-e10s', 02:57:22 INFO - 'system_bits': '32', 02:57:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:22 INFO - 'title': 'talos-linux64-ix-084', 02:57:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:22 INFO - 'use_talos_json': True, 02:57:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:22 INFO - 'work_dir': 'build'} 02:57:22 INFO - [mozharness: 2017-07-31 09:57:22.022708Z] Running clobber step. 02:57:22 INFO - Running pre-action listener: _resource_record_pre_action 02:57:22 INFO - Running main action method: clobber 02:57:22 INFO - rmtree: /builds/slave/test/build 02:57:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:23 INFO - Running post-action listener: _resource_record_post_action 02:57:23 INFO - [mozharness: 2017-07-31 09:57:23.000764Z] Finished clobber step (success) 02:57:23 INFO - [mozharness: 2017-07-31 09:57:23.000867Z] Running read-buildbot-config step. 02:57:23 INFO - Running pre-action listener: _resource_record_pre_action 02:57:23 INFO - Running main action method: read_buildbot_config 02:57:23 INFO - Using buildbot properties: 02:57:23 INFO - { 02:57:23 INFO - "project": "", 02:57:23 INFO - "product": "firefox", 02:57:23 INFO - "who": "archaeopteryx@coole-files.de", 02:57:23 INFO - "installer_path": "public/build/target.tar.bz2", 02:57:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:57:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:57:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:57:23 INFO - "stage_platform": "linux64-stylosequential", 02:57:23 INFO - "basedir": "/builds/slave/test", 02:57:23 INFO - "buildnumber": 160, 02:57:23 INFO - "platform": "ubuntu64_hw_styloseq", 02:57:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:57:23 INFO - "slavebuilddir": "test", 02:57:23 INFO - "taskId": "ZqcUT6bcRmaR6m9xECAe_Q", 02:57:23 INFO - "branch": "mozilla-central", 02:57:23 INFO - "script_repo_revision": "production", 02:57:23 INFO - "revision": "b1dcb20102b7598ec4d467530cd20ba9e8754de6", 02:57:23 INFO - "slavename": "talos-linux64-ix-084", 02:57:23 INFO - "repo_path": "mozilla-central" 02:57:23 INFO - } 02:57:23 INFO - Finding installer, test and symbols from parent task. 02:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqcUT6bcRmaR6m9xECAe_Q'}, attempt #1 02:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqcUT6bcRmaR6m9xECAe_Q'}, attempt #1 02:57:23 INFO - Task dependencies: OypQKKTlTgyj1Ao4ZC_kMg 02:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg'}, attempt #1 02:57:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2 02:57:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.test_packages.json 02:57:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.crashreporter-symbols.zip 02:57:24 INFO - Running post-action listener: _resource_record_post_action 02:57:24 INFO - [mozharness: 2017-07-31 09:57:24.386325Z] Finished read-buildbot-config step (success) 02:57:24 INFO - [mozharness: 2017-07-31 09:57:24.386548Z] Running download-and-extract step. 02:57:24 INFO - Running pre-action listener: _resource_record_pre_action 02:57:24 INFO - Running main action method: download_and_extract 02:57:24 INFO - mkdir: /builds/slave/test/build/tests 02:57:24 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')]} 02:57:24 INFO - trying https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.test_packages.json 02:57:24 INFO - Downloading https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:57:24 INFO - Downloaded 989 bytes. 02:57:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:57:24 INFO - Using the following test package requirements: 02:57:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:57:24 INFO - u'common': [u'target.common.tests.zip'], 02:57:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:57:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:57:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:57:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:57:24 INFO - u'mozbase': [u'target.common.tests.zip'], 02:57:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:57:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:57:24 INFO - u'web-platform': [u'target.common.tests.zip', 02:57:24 INFO - u'target.web-platform.tests.tar.gz'], 02:57:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:57:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:57:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.common.tests.zip 02:57:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:57:24 INFO - Fetch https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.common.tests.zip into memory 02:57:27 INFO - Content-Length response header: 72389793 02:57:27 INFO - Bytes received: 72389793 02:57:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:57:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.common.tests.zip 02:57:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:57:38 INFO - Fetch https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.common.tests.zip into memory 02:57:39 INFO - Content-Length response header: 72389793 02:57:39 INFO - Bytes received: 72389793 02:57:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.talos.tests.zip 02:57:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:57:52 INFO - Fetch https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.talos.tests.zip into memory 02:57:53 INFO - Content-Length response header: 14496686 02:57:53 INFO - Bytes received: 14496686 02:57: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')]} 02:57:53 INFO - trying https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2 02:57:53 INFO - Downloading https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:57:55 INFO - Downloaded 62271564 bytes. 02:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2 02:57:55 INFO - mkdir: /builds/slave/test/properties 02:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:55 INFO - Contents: 02:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2 02:57:55 INFO - Running post-action listener: _resource_record_post_action 02:57:55 INFO - Running post-action listener: set_extra_try_arguments 02:57:55 INFO - [mozharness: 2017-07-31 09:57:55.280525Z] Finished download-and-extract step (success) 02:57:55 INFO - [mozharness: 2017-07-31 09:57:55.280623Z] Running populate-webroot step. 02:57:55 INFO - Running pre-action listener: _resource_record_pre_action 02:57:55 INFO - Running main action method: populate_webroot 02:57:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:55 INFO - 'tests': ['damp', 'tps']}, 02:57:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:57:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:57:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:57:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:55 INFO - 'ts_paint', 02:57:55 INFO - 'tpaint', 02:57:55 INFO - 'sessionrestore', 02:57:55 INFO - 'sessionrestore_many_windows', 02:57:55 INFO - 'sessionrestore_no_auto_restore', 02:57:55 INFO - 'tabpaint']}, 02:57:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:57:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:57:55 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:55 INFO - 'talos_options': ['--mitmproxy', 02:57:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:55 INFO - '--firstNonBlankPaint'], 02:57:55 INFO - 'tests': ['quantum_pageload_google', 02:57:55 INFO - 'quantum_pageload_youtube', 02:57:55 INFO - 'quantum_pageload_amazon', 02:57:55 INFO - 'quantum_pageload_facebook']}, 02:57:55 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:55 INFO - 'talos_options': ['--stylo', 02:57:55 INFO - '--mitmproxy', 02:57:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:55 INFO - '--firstNonBlankPaint'], 02:57:55 INFO - 'tests': ['quantum_pageload_google', 02:57:55 INFO - 'quantum_pageload_youtube', 02:57:55 INFO - 'quantum_pageload_amazon', 02:57:55 INFO - 'quantum_pageload_facebook']}, 02:57:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:55 INFO - 'tsvgr_opacity', 02:57:55 INFO - 'tart', 02:57:55 INFO - 'tscrollx', 02:57:55 INFO - 'cart', 02:57:55 INFO - 'tsvg_static']}, 02:57:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:55 INFO - 'talos_options': ['--stylo', 02:57:55 INFO - '--stylo-threads=1', 02:57:55 INFO - '--mitmproxy', 02:57:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:55 INFO - '--firstNonBlankPaint'], 02:57:55 INFO - 'tests': ['tp6_google', 02:57:55 INFO - 'tp6_youtube', 02:57:55 INFO - 'tp6_amazon', 02:57:55 INFO - 'tp6_facebook']}, 02:57:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:55 INFO - 'talos_options': ['--xperf_path', 02:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:55 INFO - 'tests': ['tp5n']}}} 02:57:55 INFO - Running post-action listener: _resource_record_post_action 02:57:55 INFO - [mozharness: 2017-07-31 09:57:55.289251Z] Finished populate-webroot step (success) 02:57:55 INFO - [mozharness: 2017-07-31 09:57:55.289342Z] Running create-virtualenv step. 02:57:55 INFO - Running pre-action listener: _resource_record_pre_action 02:57:55 INFO - Running main action method: create_virtualenv 02:57:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57: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 02:57:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:57:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:55 INFO - Using real prefix '/usr' 02:57:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:56 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:57 INFO - Installing pip.................done. 02:57:57 INFO - Return code: 0 02:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:58 INFO - Reading from file tmpfile_stdout 02:57:58 INFO - Output received: 02:57:58 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) 02:57:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57: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')]} 02:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:57: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', 'pip>=1.5'] in /builds/slave/test/build 02:57: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 pip>=1.5 02:57:58 INFO - Using env: {'DISPLAY': ':0', 02:57:58 INFO - 'HOME': '/home/cltbld', 02:57:58 INFO - 'LANG': 'en_US.UTF-8', 02:57:58 INFO - 'LANGUAGE': 'en_US:en', 02:57:58 INFO - 'LOGNAME': 'cltbld', 02:57:58 INFO - 'MAIL': '/var/mail/cltbld', 02:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:58 INFO - 'MOZ_NO_REMOTE': '1', 02:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:58 INFO - 'NO_EM_RESTART': '1', 02:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:58 INFO - 'PWD': '/builds/slave/test', 02:57:58 INFO - 'SHELL': '/bin/bash', 02:57:58 INFO - 'SHLVL': '1', 02:57:58 INFO - 'TERM': 'linux', 02:57:58 INFO - 'TMOUT': '86400', 02:57:58 INFO - 'USER': 'cltbld', 02:57:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:58 INFO - '_': '/tools/buildbot/bin/python'} 02:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57: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 02:57:58 INFO - Cleaning up... 02:57:58 INFO - Return code: 0 02:57:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57: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')]} 02:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57: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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:57: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 02:57: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 02:57:58 INFO - Using env: {'DISPLAY': ':0', 02:57:58 INFO - 'HOME': '/home/cltbld', 02:57:58 INFO - 'LANG': 'en_US.UTF-8', 02:57:58 INFO - 'LANGUAGE': 'en_US:en', 02:57:58 INFO - 'LOGNAME': 'cltbld', 02:57:58 INFO - 'MAIL': '/var/mail/cltbld', 02:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:58 INFO - 'MOZ_NO_REMOTE': '1', 02:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:58 INFO - 'NO_EM_RESTART': '1', 02:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:58 INFO - 'PWD': '/builds/slave/test', 02:57:58 INFO - 'SHELL': '/bin/bash', 02:57:58 INFO - 'SHLVL': '1', 02:57:58 INFO - 'TERM': 'linux', 02:57:58 INFO - 'TMOUT': '86400', 02:57:58 INFO - 'USER': 'cltbld', 02:57:58 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:58 INFO - '_': '/tools/buildbot/bin/python'} 02:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:58 INFO - Downloading/unpacking psutil>=3.1.1 02:57: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 02:57: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 02:57: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 02:57: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 02:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:59 INFO - Installing collected packages: psutil 02:57:59 INFO - Running setup.py install for psutil 02:57:59 INFO - building 'psutil._psutil_linux' extension 02:57: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 02:58:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:58:01 INFO - building 'psutil._psutil_posix' extension 02:58:01 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 02:58:01 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 02:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:01 INFO - Successfully installed psutil 02:58:01 INFO - Cleaning up... 02:58:01 INFO - Return code: 0 02:58:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58: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')]} 02:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:58: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 mozsystemmonitor==0.3 02:58:01 INFO - Using env: {'DISPLAY': ':0', 02:58:01 INFO - 'HOME': '/home/cltbld', 02:58:01 INFO - 'LANG': 'en_US.UTF-8', 02:58:01 INFO - 'LANGUAGE': 'en_US:en', 02:58:01 INFO - 'LOGNAME': 'cltbld', 02:58:01 INFO - 'MAIL': '/var/mail/cltbld', 02:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:01 INFO - 'MOZ_NO_REMOTE': '1', 02:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:01 INFO - 'NO_EM_RESTART': '1', 02:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:01 INFO - 'PWD': '/builds/slave/test', 02:58:01 INFO - 'SHELL': '/bin/bash', 02:58:01 INFO - 'SHLVL': '1', 02:58:01 INFO - 'TERM': 'linux', 02:58:01 INFO - 'TMOUT': '86400', 02:58:01 INFO - 'USER': 'cltbld', 02:58:01 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:01 INFO - '_': '/tools/buildbot/bin/python'} 02:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:58: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 02:58: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 02:58: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 02:58: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 02:58:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:58:02 INFO - Installing collected packages: mozsystemmonitor 02:58:02 INFO - Running setup.py install for mozsystemmonitor 02:58:02 INFO - Successfully installed mozsystemmonitor 02:58:02 INFO - Cleaning up... 02:58:02 INFO - Return code: 0 02:58:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:58:02 INFO - Using env: {'DISPLAY': ':0', 02:58:02 INFO - 'HOME': '/home/cltbld', 02:58:02 INFO - 'LANG': 'en_US.UTF-8', 02:58:02 INFO - 'LANGUAGE': 'en_US:en', 02:58:02 INFO - 'LOGNAME': 'cltbld', 02:58:02 INFO - 'MAIL': '/var/mail/cltbld', 02:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:02 INFO - 'MOZ_NO_REMOTE': '1', 02:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:02 INFO - 'NO_EM_RESTART': '1', 02:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:02 INFO - 'PWD': '/builds/slave/test', 02:58:02 INFO - 'SHELL': '/bin/bash', 02:58:02 INFO - 'SHLVL': '1', 02:58:02 INFO - 'TERM': 'linux', 02:58:02 INFO - 'TMOUT': '86400', 02:58:02 INFO - 'USER': 'cltbld', 02:58:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:02 INFO - '_': '/tools/buildbot/bin/python'} 02:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:58: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 02:58: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 02:58: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 02:58: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 02:58:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:04 INFO - warning: no files found matching '*.txt' 02:58:04 INFO - no previously-included directories found matching 'build' 02:58:04 INFO - no previously-included directories found matching 'dist' 02:58:04 INFO - no previously-included directories found matching '.git*' 02:58:04 INFO - Installing collected packages: jsonschema, functools32 02:58:04 INFO - Running setup.py install for functools32 02:58:04 INFO - warning: no files found matching '*.txt' 02:58:04 INFO - no previously-included directories found matching 'build' 02:58:04 INFO - no previously-included directories found matching 'dist' 02:58:04 INFO - no previously-included directories found matching '.git*' 02:58:04 INFO - Successfully installed jsonschema functools32 02:58:04 INFO - Cleaning up... 02:58:04 INFO - Return code: 0 02:58:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:58:04 INFO - Using env: {'DISPLAY': ':0', 02:58:04 INFO - 'HOME': '/home/cltbld', 02:58:04 INFO - 'LANG': 'en_US.UTF-8', 02:58:04 INFO - 'LANGUAGE': 'en_US:en', 02:58:04 INFO - 'LOGNAME': 'cltbld', 02:58:04 INFO - 'MAIL': '/var/mail/cltbld', 02:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:04 INFO - 'MOZ_NO_REMOTE': '1', 02:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:04 INFO - 'NO_EM_RESTART': '1', 02:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:04 INFO - 'PWD': '/builds/slave/test', 02:58:04 INFO - 'SHELL': '/bin/bash', 02:58:04 INFO - 'SHLVL': '1', 02:58:04 INFO - 'TERM': 'linux', 02:58:04 INFO - 'TMOUT': '86400', 02:58:04 INFO - 'USER': 'cltbld', 02:58:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:04 INFO - '_': '/tools/buildbot/bin/python'} 02:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:58:04 INFO - Cleaning up... 02:58:04 INFO - Return code: 0 02:58:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:58:04 INFO - Using env: {'DISPLAY': ':0', 02:58:04 INFO - 'HOME': '/home/cltbld', 02:58:04 INFO - 'LANG': 'en_US.UTF-8', 02:58:04 INFO - 'LANGUAGE': 'en_US:en', 02:58:04 INFO - 'LOGNAME': 'cltbld', 02:58:04 INFO - 'MAIL': '/var/mail/cltbld', 02:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:04 INFO - 'MOZ_NO_REMOTE': '1', 02:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:04 INFO - 'NO_EM_RESTART': '1', 02:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:04 INFO - 'PWD': '/builds/slave/test', 02:58:04 INFO - 'SHELL': '/bin/bash', 02:58:04 INFO - 'SHLVL': '1', 02:58:04 INFO - 'TERM': 'linux', 02:58:04 INFO - 'TMOUT': '86400', 02:58:04 INFO - 'USER': 'cltbld', 02:58:04 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:04 INFO - '_': '/tools/buildbot/bin/python'} 02:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58: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 02:58: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 02:58: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 02:58: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 02:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58: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 02:58: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 02:58: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 02:58: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 02:58:06 INFO - Downloading docopt-0.6.1.tar.gz 02:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:06 INFO - Running setup.py install for blobuploader 02:58:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:06 INFO - Running setup.py install for requests 02:58:07 INFO - Running setup.py install for docopt 02:58:07 INFO - Successfully installed blobuploader requests docopt 02:58:07 INFO - Cleaning up... 02:58:07 INFO - Return code: 0 02:58:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:07 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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58:07 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 02:58:07 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 02:58:07 INFO - Using env: {'DISPLAY': ':0', 02:58:07 INFO - 'HOME': '/home/cltbld', 02:58:07 INFO - 'LANG': 'en_US.UTF-8', 02:58:07 INFO - 'LANGUAGE': 'en_US:en', 02:58:07 INFO - 'LOGNAME': 'cltbld', 02:58:07 INFO - 'MAIL': '/var/mail/cltbld', 02:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:07 INFO - 'MOZ_NO_REMOTE': '1', 02:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:07 INFO - 'NO_EM_RESTART': '1', 02:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:07 INFO - 'PWD': '/builds/slave/test', 02:58:07 INFO - 'SHELL': '/bin/bash', 02:58:07 INFO - 'SHLVL': '1', 02:58:07 INFO - 'TERM': 'linux', 02:58:07 INFO - 'TMOUT': '86400', 02:58:07 INFO - 'USER': 'cltbld', 02:58:07 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:07 INFO - '_': '/tools/buildbot/bin/python'} 02:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:07 INFO - Running setup.py (path:/tmp/pip-kY4DM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:07 INFO - Running setup.py (path:/tmp/pip-M_9Ur7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:07 INFO - Running setup.py (path:/tmp/pip-hPZgN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:07 INFO - Running setup.py (path:/tmp/pip-iaol1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:07 INFO - Running setup.py (path:/tmp/pip-wVy2BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:07 INFO - Running setup.py (path:/tmp/pip-aAtKSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:07 INFO - Running setup.py (path:/tmp/pip-vAMMKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:07 INFO - Running setup.py (path:/tmp/pip-CkE8gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:07 INFO - Running setup.py (path:/tmp/pip-000_kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:08 INFO - Running setup.py (path:/tmp/pip-txuq1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:08 INFO - Running setup.py (path:/tmp/pip-2EByz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:08 INFO - Running setup.py (path:/tmp/pip-GtJNuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:08 INFO - Running setup.py (path:/tmp/pip-tq3Nmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:08 INFO - Running setup.py (path:/tmp/pip-2cfClO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:08 INFO - Running setup.py (path:/tmp/pip-vE2AfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:08 INFO - Running setup.py (path:/tmp/pip-fN2Ilm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:08 INFO - Running setup.py (path:/tmp/pip-jtNeaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:08 INFO - Running setup.py install for manifestparser 02:58:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:08 INFO - Running setup.py install for mozcrash 02:58:08 INFO - Running setup.py install for mozdebug 02:58:08 INFO - Running setup.py install for mozdevice 02:58:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozfile 02:58:09 INFO - Running setup.py install for mozhttpd 02:58:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozinfo 02:58:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozInstall 02:58:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozleak 02:58:09 INFO - Running setup.py install for mozlog 02:58:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for moznetwork 02:58:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozprocess 02:58:09 INFO - Running setup.py install for mozprofile 02:58:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:09 INFO - Running setup.py install for mozrunner 02:58:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:10 INFO - Running setup.py install for mozscreenshot 02:58:10 INFO - Running setup.py install for moztest 02:58:10 INFO - Running setup.py install for mozversion 02:58:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:10 INFO - Cleaning up... 02:58:10 INFO - Return code: 0 02:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58: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')]} 02:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58: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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58: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 02:58: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 02:58:10 INFO - Using env: {'DISPLAY': ':0', 02:58:10 INFO - 'HOME': '/home/cltbld', 02:58:10 INFO - 'LANG': 'en_US.UTF-8', 02:58:10 INFO - 'LANGUAGE': 'en_US:en', 02:58:10 INFO - 'LOGNAME': 'cltbld', 02:58:10 INFO - 'MAIL': '/var/mail/cltbld', 02:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:10 INFO - 'MOZ_NO_REMOTE': '1', 02:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:10 INFO - 'NO_EM_RESTART': '1', 02:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:10 INFO - 'PWD': '/builds/slave/test', 02:58:10 INFO - 'SHELL': '/bin/bash', 02:58:10 INFO - 'SHLVL': '1', 02:58:10 INFO - 'TERM': 'linux', 02:58:10 INFO - 'TMOUT': '86400', 02:58:10 INFO - 'USER': 'cltbld', 02:58:10 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:10 INFO - '_': '/tools/buildbot/bin/python'} 02:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:10 INFO - Running setup.py (path:/tmp/pip-5NTrVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58: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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:10 INFO - Running setup.py (path:/tmp/pip-5zqMUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58: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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:10 INFO - Running setup.py (path:/tmp/pip-70P6ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58: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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:10 INFO - Running setup.py (path:/tmp/pip-vMPDqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58: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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:10 INFO - Running setup.py (path:/tmp/pip-ssPbCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58: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)) 02:58:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:10 INFO - Running setup.py (path:/tmp/pip-brS9bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:11 INFO - Running setup.py (path:/tmp/pip-UV60eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:11 INFO - Running setup.py (path:/tmp/pip-8y8RBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:11 INFO - Running setup.py (path:/tmp/pip-ZTAc21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:11 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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:11 INFO - Running setup.py (path:/tmp/pip-j7Lsgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:11 INFO - Running setup.py (path:/tmp/pip-z5WipO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:11 INFO - Running setup.py (path:/tmp/pip-wKbXl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:11 INFO - Running setup.py (path:/tmp/pip-RyPIBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:11 INFO - Running setup.py (path:/tmp/pip-oyX7mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:11 INFO - Running setup.py (path:/tmp/pip-UAxXYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:11 INFO - Running setup.py (path:/tmp/pip-PZHiXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58: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)) 02:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:11 INFO - Running setup.py (path:/tmp/pip-Is0T46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58: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 02:58: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 02:58: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 02:58: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 02:58:12 INFO - Downloading blessings-1.6.tar.gz 02:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:13 INFO - Installing collected packages: blessings 02:58:13 INFO - Running setup.py install for blessings 02:58:13 INFO - Successfully installed blessings 02:58:13 INFO - Cleaning up... 02:58:13 INFO - Return code: 0 02:58:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:13 INFO - Reading from file tmpfile_stdout 02:58:13 INFO - Current package versions: 02:58:13 INFO - argparse == 1.2.1 02:58:13 INFO - blessings == 1.6 02:58:13 INFO - blobuploader == 1.2.4 02:58:13 INFO - docopt == 0.6.1 02:58:13 INFO - functools32 == 3.2.3-2 02:58:13 INFO - jsonschema == 2.5.1 02:58:13 INFO - manifestparser == 1.1 02:58:13 INFO - mozInstall == 1.13 02:58:13 INFO - mozcrash == 1.0 02:58:13 INFO - mozdebug == 0.1 02:58:13 INFO - mozdevice == 0.51 02:58:13 INFO - mozfile == 1.2 02:58:13 INFO - mozhttpd == 0.7 02:58:13 INFO - mozinfo == 0.10 02:58:13 INFO - mozleak == 0.1 02:58:13 INFO - mozlog == 3.5 02:58:13 INFO - moznetwork == 0.27 02:58:13 INFO - mozprocess == 0.25 02:58:13 INFO - mozprofile == 0.28 02:58:13 INFO - mozrunner == 6.13 02:58:13 INFO - mozscreenshot == 0.1 02:58:13 INFO - mozsystemmonitor == 0.3 02:58:13 INFO - moztest == 0.8 02:58:13 INFO - mozversion == 1.4 02:58:13 INFO - psutil == 3.1.1 02:58:13 INFO - requests == 1.2.3 02:58:13 INFO - wsgiref == 0.1.2 02:58:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58: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')]} 02:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58: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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58: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 02:58: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 02:58:13 INFO - Using env: {'DISPLAY': ':0', 02:58:13 INFO - 'HOME': '/home/cltbld', 02:58:13 INFO - 'LANG': 'en_US.UTF-8', 02:58:13 INFO - 'LANGUAGE': 'en_US:en', 02:58:13 INFO - 'LOGNAME': 'cltbld', 02:58:13 INFO - 'MAIL': '/var/mail/cltbld', 02:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:13 INFO - 'MOZ_NO_REMOTE': '1', 02:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:13 INFO - 'NO_EM_RESTART': '1', 02:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:13 INFO - 'PWD': '/builds/slave/test', 02:58:13 INFO - 'SHELL': '/bin/bash', 02:58:13 INFO - 'SHLVL': '1', 02:58:13 INFO - 'TERM': 'linux', 02:58:13 INFO - 'TMOUT': '86400', 02:58:13 INFO - 'USER': 'cltbld', 02:58:13 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:13 INFO - '_': '/tools/buildbot/bin/python'} 02:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58: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)) 02:58:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:58: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 02:58: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 02:58: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 02:58: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 02:58:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:58:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:58: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 02:58: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 02:58: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 02:58: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 02:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:58:15 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)) 02:58:15 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)) 02:58:15 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)) 02:58:15 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)) 02:58:15 INFO - Installing collected packages: marionette-driver, simplejson 02:58:15 INFO - Running setup.py install for marionette-driver 02:58:15 INFO - Running setup.py install for simplejson 02:58:15 INFO - building 'simplejson._speedups' extension 02:58:15 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 02:58:16 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 02:58:16 INFO - Successfully installed marionette-driver simplejson 02:58:16 INFO - Cleaning up... 02:58:16 INFO - Return code: 0 02:58:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:16 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 0x17c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1992a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b35d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, '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': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', '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 02:58:16 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 02:58:16 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 02:58:16 INFO - Using env: {'DISPLAY': ':0', 02:58:16 INFO - 'HOME': '/home/cltbld', 02:58:16 INFO - 'LANG': 'en_US.UTF-8', 02:58:16 INFO - 'LANGUAGE': 'en_US:en', 02:58:16 INFO - 'LOGNAME': 'cltbld', 02:58:16 INFO - 'MAIL': '/var/mail/cltbld', 02:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:16 INFO - 'MOZ_NO_REMOTE': '1', 02:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:16 INFO - 'NO_EM_RESTART': '1', 02:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:16 INFO - 'PWD': '/builds/slave/test', 02:58:16 INFO - 'SHELL': '/bin/bash', 02:58:16 INFO - 'SHLVL': '1', 02:58:16 INFO - 'TERM': 'linux', 02:58:16 INFO - 'TMOUT': '86400', 02:58:16 INFO - 'USER': 'cltbld', 02:58:16 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:16 INFO - '_': '/tools/buildbot/bin/python'} 02:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:16 INFO - Cleaning up... 02:58:16 INFO - Return code: 0 02:58:16 INFO - Running post-action listener: _resource_record_post_action 02:58:16 INFO - Running post-action listener: _start_resource_monitoring 02:58:16 INFO - Starting resource monitoring. 02:58:16 INFO - [mozharness: 2017-07-31 09:58:16.470074Z] Finished create-virtualenv step (success) 02:58:16 INFO - [mozharness: 2017-07-31 09:58:16.471077Z] Running install step. 02:58:16 INFO - Running pre-action listener: _resource_record_pre_action 02:58:16 INFO - Running main action method: install 02:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:16 INFO - Reading from file tmpfile_stdout 02:58:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:16 INFO - Reading from file tmpfile_stdout 02:58:16 INFO - Output received: 02:58:16 INFO - Usage: mozinstall [options] installer 02:58:16 INFO - Options: 02:58:16 INFO - -h, --help show this help message and exit 02:58:16 INFO - -d DEST, --destination=DEST 02:58:16 INFO - Directory to install application into. [default: 02:58:16 INFO - "/builds/slave/test"] 02:58:16 INFO - --app=APP Application being installed. [default: firefox] 02:58:16 INFO - mkdir: /builds/slave/test/build/application 02:58: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'] 02:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:58:34 INFO - Reading from file tmpfile_stdout 02:58:34 INFO - Output received: 02:58:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:34 INFO - Running post-action listener: _resource_record_post_action 02:58:34 INFO - [mozharness: 2017-07-31 09:58:34.850821Z] Finished install step (success) 02:58:34 INFO - [mozharness: 2017-07-31 09:58:34.850967Z] Running setup-mitmproxy step. 02:58:34 INFO - Running pre-action listener: _resource_record_pre_action 02:58:34 INFO - Running main action method: setup_mitmproxy 02:58:34 INFO - Skipping: mitmproxy is not required 02:58:34 INFO - Running post-action listener: _resource_record_post_action 02:58:34 INFO - [mozharness: 2017-07-31 09:58:34.851497Z] Finished setup-mitmproxy step (success) 02:58:34 INFO - [mozharness: 2017-07-31 09:58:34.851756Z] Running run-tests step. 02:58:34 INFO - Running pre-action listener: _resource_record_pre_action 02:58:34 INFO - Running pre-action listener: _set_gcov_prefix 02:58:34 INFO - Running main action method: run_tests 02:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:34 INFO - Python 2.7.3 02:58:34 INFO - Return code: 0 02:58:34 INFO - grabbing minidump binary from tooltool 02:58: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')]} 02:58: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 0x1b32eb0>, '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 0x1b33db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b34240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58: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 02:58: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 02:58: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 02:58:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:34 INFO - Return code: 0 02:58:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:34 INFO - ENV: RUST_BACKTRACE is now 1 02:58:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58: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/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 02:58: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/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 02:58:34 INFO - Using env: {'DISPLAY': ':0', 02:58:34 INFO - 'HOME': '/home/cltbld', 02:58:34 INFO - 'LANG': 'en_US.UTF-8', 02:58:34 INFO - 'LANGUAGE': 'en_US:en', 02:58:34 INFO - 'LOGNAME': 'cltbld', 02:58:34 INFO - 'MAIL': '/var/mail/cltbld', 02:58:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:34 INFO - 'MOZ_NO_REMOTE': '1', 02:58:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:34 INFO - 'NO_EM_RESTART': '1', 02:58:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:34 INFO - 'PWD': '/builds/slave/test', 02:58:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:34 INFO - 'RUST_BACKTRACE': '1', 02:58:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:58:34 INFO - 'SHELL': '/bin/bash', 02:58:34 INFO - 'SHLVL': '1', 02:58:34 INFO - 'STYLO_FORCE_ENABLED': '1', 02:58:34 INFO - 'TERM': 'linux', 02:58:34 INFO - 'TMOUT': '86400', 02:58:34 INFO - 'USER': 'cltbld', 02:58:34 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905', 02:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:34 INFO - '_': '/tools/buildbot/bin/python'} 02:58: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/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 02:58:35 INFO - mozversion application_buildid: 20170731091001 02:58:35 INFO - mozversion application_changeset: b1dcb20102b7598ec4d467530cd20ba9e8754de6 02:58:35 INFO - mozversion application_display_name: Nightly 02:58:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:35 INFO - mozversion application_name: Firefox 02:58:35 INFO - mozversion application_remotingname: firefox 02:58:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:58:35 INFO - mozversion application_vendor: Mozilla 02:58:35 INFO - mozversion application_version: 56.0a1 02:58:35 INFO - mozversion platform_buildid: 20170731091001 02:58:35 INFO - mozversion platform_changeset: b1dcb20102b7598ec4d467530cd20ba9e8754de6 02:58:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:58:35 INFO - mozversion platform_version: 56.0a1 02:58:35 INFO - using testdate: 1501495115 02:58:35 INFO - actual date: 1501495115 02:58:35 INFO - starting webserver on 'localhost:50765' 02:58:35 INFO - SUITE-START | Running 2 tests 02:58:35 INFO - TEST-START | dromaeo_css 02:58:35 INFO - Initialising browser for dromaeo_css test... 02:58:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html -profile /tmp/tmpdLEUYm/profile 02:58:35 INFO - TEST-INFO | started process 3345 (/builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html) 02:58:46 INFO - TEST-INFO | 3345: exit 0 02:58:46 INFO - Browser initialized. 02:58:46 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:46 INFO - TEST-INFO | started process 3573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdLEUYm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:47 INFO - PID 3573 | 02:58:47 INFO - PID 3573 | (/builds/slave/test/build/application/firefox/firefox:3627): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:58:47 INFO - PID 3573 | 02:58:57 INFO - PID 3573 | RSS: Main: 173330432 02:58:57 INFO - PID 3573 | 03:01:58 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50765/tests/dromaeo/cssquery-ext.html) 03:01:59 INFO - PID 3573 | RSS: Main: 175333376 03:01:59 INFO - PID 3573 | 03:05:01 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-ext.html (next: http://localhost:50765/tests/dromaeo/cssquery-jquery.html) 03:05:01 INFO - PID 3573 | RSS: Main: 172810240 03:05:01 INFO - PID 3573 | 03:08:03 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50765/tests/dromaeo/cssquery-mootools.html) 03:08:04 INFO - PID 3573 | RSS: Main: 175276032 03:08:04 INFO - PID 3573 | 03:11:06 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50765/tests/dromaeo/cssquery-prototype.html) 03:11:06 INFO - PID 3573 | RSS: Main: 173105152 03:11:06 INFO - PID 3573 | 03:14:10 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50765/tests/dromaeo/cssquery-yui.html) 03:14:11 INFO - PID 3573 | RSS: Main: 176627712 03:14:11 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | Cycle 1(1): loaded http://localhost:50765/tests/dromaeo/cssquery-yui.html (next: http://localhost:50765/tests/dromaeo/cssquery-dojo.html) 03:17:13 INFO - PID 3573 | RSS: Main: 177389568 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | __start_tp_report 03:17:13 INFO - PID 3573 | _x_x_mozilla_page_load 03:17:13 INFO - PID 3573 | _x_x_mozilla_page_load_details 03:17:13 INFO - PID 3573 | |i|pagename|runs| 03:17:13 INFO - PID 3573 | |0;dojo.html;3122.45357062514;3144.701253380929;3179.60254968129;3184.7452203823696;3227.4029304578653;6128.816135515931;6177.073438984155;6213.316535181132;6275.780347687832;6295.653739044351;6177.81466556004;6199.752009919598;6205.503559715224;6245.500359971203;6259.593126446778;5640.887182256352;5711.8000869969555;5723.885522289552;5732.742026608813;5736.311642602894;5647.181158731982;5657.23627310314;5671.943280567183;5697.515711164535;5749.425057494238;5667.234923285366;5726.914096288559;5766.250387449626;5775.971120144414;5779.3642699303045;697.7225954125881;5575.358833734132;5658.632188907728;5725.513331366838;5736.7992120276;5530.198121272433;5550.91673624896;5589.832305030855;5625.46558076982;5653.773849046033;6029.758809647609;6063.848403789896;6103.450689437972;6142.447179753844;6150.231221097363;6563.967180164069;6584.341565843425;6672.132622759011;6672.132622759059;6680.69936852838;6637.435817955479;6661.733530658767;6731.798046058626;6752.966235168793;6762.729490820361;6061.151438798572;6150.753969841201;6169.722362493743;6203.193584833943;6269.122322874801;6642.036904648799;6687.76592819249;6689.531732778756;6694.899576506356;6696.698648560827;6323.083152942798;6389.520785941073;6399.392057754506;6401.231852177675;6401.615903045832;6476.805695829038;6489.935100649028;6508.088867558546;6509.349065093453;6561.245456772437;6576.473882089422;6590.538662293593;6631.204255489276;6677.899831502531;6685.732570697215;6625.238097618739;6638.369354911276;6717.429018533382;6729.394354508117;6736.191657001191;5259.421463639073;5342.9465705342445;5374.543163831118;5424.403315635277;5429.511343979061;4647.117047760915;4670.906581868344;4699.530046995342;4714.363560919301;4714.622830173578;5776.133579962955;5843.912341314884;5852.912206316909;5857.297124345021;5860.560457965585;6648.53460257787;6654.401103900672;6677.165354330708;6758.155230596176;6773.729050837911;5697.515711164515;5778.393268706809;5786.623869448473;5861.88276234473;5862.443067908542;5881.147233651097;5887.4701276884425;5889.882202356014;5892.764289428461;5906.822795316061;6431.292557818636;6437.645929474018;6438.774642887476;6531.987541931008;6544.345565443417;6527.771527996498;6657.833554161185;6658.1344425224415;6757.3242675732035;6761.898571521333;6413.42279194856;6426.710798014007;6427.228732552124;6429.6142231466265;6449.903251451138;6485.578437401554;6501.707423165874;6508.414242718178;6517.804465866032;6518.674066296761;6585.506087043586;6679.098321726505;6682.832929176615;6684.966575167093;6688.331166883273;6429.517786165963;6475.449586785176;6476.773312934025;6478.028295755675;6479.967600161969;6428.614283143026;6454.935450645621;6459.773907913201;6468.191476065492;6480.060391243149;6303.779367722108;6367.204099487564;6397;6422.775202868064;6447.9032814508755;6460.3862633049785;6519.608823470607;6570.5729127606555;6606.537542371988;6676.866462670817;6196.1635179250225;6283.937160628335;6300.810975670737;6341.8097457076365;6366.681665916593 03:17:13 INFO - PID 3573 | |1;ext.html;802.5746354432154;838.8070743728946;855.7005048233119;888.3026823943204;898.1736802142028;39369;40024.799876000616;40087.39868901969;40093.19813603726;40117.799411002976;36605.633943660556;36708.81645591775;36886.26227475449;36985.26029479409;37008.259834803284;6890.862182756329;7004.964975175117;7012.474064445161;7016.052832867574;7018.929810701904;6840.760573379933;6962.1993470751;6968.895466568006;6971.33772291634;6974.09336786217;6936;7559.924400755977;7810.531368117902;7812.218778122199;7815.648295826673;7708.229177082303;7767;7767.611619419063;7773.572453515055;7775.339096176832;7519.699212031513;7648.311651951295;7728.459007869451;7730.149683534807;7732.690692372298;37658.24683506342;37791.43312850282;37825.43261851074;37871;37889.621103788886;3566.4115420955773;3621.149029977953;3625.8730944417084;3630.1832087780303;3635.763675361093;30443.847780761174;30473.23816904573;30624.54063189054;30655.540166897514;30737.538936915964;4876.707397556158;4894.36373271476;4903.901921961577;4927.827526036572;4940.827071052532;183894;184239;187334;188832;192367;48440.515594844306;48500;48622.27066593933;48714;48851;50276.24585631218;50398.748006260466;50399.496005040215;50426.24360634593;50454.243186352236;15108.622284442758;15225.847741522442;15344.156071415957;15393.846061539465;15611.843881561266;12893.48426062947;12925.224486530838;12931.353432328535;12950.805737913939;12954.157979731288;13820.447182112603;13933.930330348283;14038.649033774238;14088.43646254159;14282.000259981702;5630.4369563043365;5680.943190568124;5764.510016648548;5794.391588883191;5798;974.288769198489;991.6585762120839;994.4828689081781;1009.878814542245;1018.5416562546735;22179.79952835964;22433.551328973655;22557;23054.901394566015;23176.53646927052;1081.453865797767;1093.8796732359433;1100.2573263047411;1105.8064838653365;1117.1677100559973;11663.825042624367;11885.821712674317;11911.761764764657;11979.760404791856;12265.016962682135;226753;227414;228212;228341;229048;51489.22766158511;52087.739561301954;55310;56546.717266413405;56673.149902751495;1455.7015811758565;1483.6513419346445;1492.634304595381;1494.31261619654;1494.4097081652687;26631.33421664474;26838.194854154408;26839.597406039316;27046.1886143416;27163.91344346204;36920.44619330658;37029.44455833111;37284.81357593195;37317.626823731414;37375.626243738305;201456;202324;202747;203885;204384;32097;33212.33575328528;34914.82542587271;35049.82475087608;35058.298834022666;43610.56389436192;44994.550054499035;45040.77479612581;45107.32339014983;45408.772956135006;25280.494390112464;27081;27994.300142495787;28199;28686.56970145491;26937.326566835985;27038.459230815668;27715.861420692767;27849.860750696116;28328.85835570809;38150.23699526049;38160.23679526449;38229;38412.2317553653;38428.80785596054;31373;31612.367752645278;31796;32876.34247315088;33655.66344336525;23586;23691.407714806577;24142.39644008914;24147.879260603586;24151.879240604387 03:17:13 INFO - PID 3573 | |2;jquery.html;563.9464250896164;569.9031164702002;570.7431655754908;572.627791935242;586.3550094895616;22263.777362226374;22404.3278701639;23038.19366322179;23214.76785232147;23240.41898952527;24256.757432425715;24857.254282371512;24958;24958.251252462454;24995.75004249957;6433.967830160843;6592;6619.735210591594;6626.039224312472;6627.138471998657;6376.681165941684;6519.967400162993;6641.103451034097;6980.720771169173;6991.300869913019;6952.200496942841;6984.825379365531;6988.895166572505;7004.754833580826;7014.438844892396;7014.982827490011;7021.684024218871;7023.578585284874;7044.64776761165;7048.929510704878;6867.244603093705;6877.346652068046;6883.242843287235;6901.654917254117;6904.861902761967;31862.20344491383;31979;32062.679373206203;32893.6710632893;33014.50478242828;1972.8323092537153;1988.6321030609383;1998.1607724755638;2000.949976250591;2001.4395969128668;19664.016799159985;20088.69866951997;20108.497287567927;20125.698114528295;20128.09423575928;2431.489387228684;2453.926382208537;2540.7840333571667;2549.4773571417813;2557.6035714464288;136110;141329;143621;144077;144329.27835360862;19433.514162145777;21596.352109436742;21803.78293087239;22118.88940555287;22899.939005489585;22852.200172993864;23772.7622723774;23783.52432951331;23946.28161155168;44918.55081449209;9965.40207587547;9974.202063834875;9986.650467233612;10233.283670143168;10266.589336426608;9253.72238832836;9404.345196188275;9432;9507.904920950841;9513.952430237805;9180.495072770927;9219.539023048821;9312.627494900264;9453.291003174789;9486.620535178516;2658.9468210635678;2700.8919643214053;2746.0663374452784;2776.9028084016963;2851.8859245630356;915.5285028210477;947.5593848860314;951.3007939164709;971.6307803034802;988.906053924876;19217;19230.807691923183;20186.39440816778;23410.64884026741;25081.62377564338;993.2302465589082;1016.8373060310315;1023.5516743807577;1053.599632139782;1063.3779239145188;11077;11162.939520745516;11234.3259404436;11344.829827552594;11360.545578176945;527018;527075;531002;536286;547715;121081.89511162556;124575;124581.37709311396;126421;127354;1256.9120161588785;1258.704204511939;1291.296243547269;1291.8966482681362;1302.726427450246;17390.913045434692;18379.448616541526;18568;18889.622207556047;18994.335198267996;58992.705036474545;59953.700231498566;60196.69901650464;60701.39298606957;62363.37636623757;74759.65757297847;77632;77847.22152778626;77890.6105469469;79858.60070699609;14838.629034274229;15047.548573542374;15127.39490420415;15177.848221517643;15198;23201.651975220724;24400.389990250387;24496.51006979886;24866.875665621556;24884.129055482972;18170.90914545419;18246.908765456086;18904.621907562047;19303.4208973731;19337.226510939407;13187.67030824237;13669.658258543615;14118.717625647634;14373.64065898361;14625.707485850437;19045.90477047606;19254.903725481283;19359.225630974604;19413.51466213356;19456.513587160433;15015.798736100867;15125.092494450368;15174.772378414113;15247.695046098794;15309.23453827282;17777.28890844352;18809.341673041377;18988.810111898703;19019.239230430627;19592.706109408657 03:17:13 INFO - PID 3573 | |3;mootools.html;1306.2032160382169;1370.6573356660836;1400.7268582626386;1409.1826740490517;1410.308948615179;13803.65490862729;14024.71950560988;14262.928685356572;14470;14478.927605361985;14433.278336083207;14667;14680.119192848437;14747.336369863355;14749.410023599043;2677.678678558571;2722.2377734234447;2722.754952054315;2723;2724.4687285979244;2677.4511225198885;2799.230211691791;2800.915972520828;2808.0593001344573;2808.199663096018;2633.4338117304774;2650.045983445958;2665.093868084851;2675.4782817350624;2682.1685277564015;2595.441979974305;2614.8431094134316;2625.448655782288;2625.9080932167376;2629.290091675256;2512.4095837478176;2518.156417600106;2520.558902192109;2535.2521006303186;2544.9618255726177;13730.382132804049;14082.436702531886;14098.295085245696;14109.082909610843;14138.081024733463;7580.355669768076;7875.173106823759;7904.407169462256;7917.24786145321;7925.88111178327;5008.749562521859;5065.848024559232;5069.239614057884;5142.408623008327;5169.353830771153;1833.6241070580631;1833.8074502177212;1846.8060853610311;1883.4914573065332;1890.1399863062275;23198;23207.3037808866;23294;23322.883385582965;23382.415439614146;6382.20222472191;6617.702203400859;6621.735130594819;6764.526483146231;6771.593704377753;15798.842011579967;15955.042697437959;15958.1223032732;15973.760393594106;15995.760063599055;7471.663775130132;7574.848503029909;7592.050993625797;7647.502912310682;7672.194419585975;5829.183914252008;5833.679147646835;6122.051082082285;6940.7223711052;7044.260352662896;4936.7284799336385;5092.745362731923;5103.7192954387865;5184.196449550326;5195.7142357170715;1445.8771004464527;1467.9266036698123;1476.534891509171;1493.16382825618;1514.2504460292225;832.2634468495426;836.9455985360933;848.5375470368664;858.6436628799104;872.2585802068191;6496.837579060561;6594;6909.136357955255;6959.269276725972;7040.577565346096;667.519386042049;689.8413364926095;707.359839345383;714.0610097721479;723.6851969393331;4502.819887204475;4760.523947605281;4785.784639691222;5147.948520514822;5248.868778280574;18766.530836728918;18924.90537547331;19127.80872191288;19327.130279137473;19454;18792.248310067716;18952.52618684544;19062.523436914187;19181.177788110108;19242.903785480983;10206.38761674287;10896.346219226873;10939.12487001038;11036.11711063113;11052.944735276273;7834.4907581007055;7885.960570197112;8045.758627241192;8104.83790324202;8131.7560473185895;15534.145621990447;16483.91758041202;16583.336666533687;16664.66670666604;17220.74168887493;16256.837431625532;16647.50057498277;17109.230084645973;17372;17550.648987020442;10831.404272765074;11035;11181.385023823443;11183.664490065312;11555.133364997828;13210.735785284432;13243.404046817725;13255.933720331337;13373.06388552792;13377.732445350845;9597.280203984868;9733.464659443798;10012.949935250277;10160.23798215122;10199.286049976727;9628.518574071128;10003.649872254728;10015.599376024877;10414.375137491472;10508.054275115277;8947.328950328882;8970.686025989058;9015.639374424949;9017.188453039258;9025.774355641162;6662.300458451793;6814.557053791487;6858.41703455192;6880.243173251039;6919.065926099912;6455.9677201613695;6699.464042876656;6715.664216789043;6824;7003.824904377431 03:17:13 INFO - PID 3573 | |4;prototype.html;488.963397597094;510.8978204359128;519.8856251624643;526.0058489454931;526.9604779641528;6214.378562143789;6241.812745617627;6256.436920677138;6279.905801412977;6335.683215839201;5899.351071382144;6116.174316467275;6118.357572454895;6138.232720909887;6143.8771224575485;4880.8047678092835;4900.64768910923;4942.332785074005;4975.502449755032;4990.850274491771;4902.779374928119;4916.50834916509;4922.55696987271;4958.652894297401;4990.326305948705;4755.3104799804005;4858.1539015174185;4889.511048895118;4903.53416425439;4975.502449755014;4856.927146092794;4925.408950925912;4942.085714142895;4974.726390048546;4986.950130498685;4402.2296098183015;4429;4449.777511124463;4453.153900758845;4454.109178164348;6027.065804800263;6076.787312444088;6089.330173680892;6130.29501607312;6161.7227224775;5671.177679236487;5691.544676425876;5700.344460387067;5721.6853073080965;5737.254156959611;6348.857205702971;6393.939848196429;6413.230412350501;6514.250861150981;6551;4845.466998630148;4846.5638092571835;4854.902901941977;4860.246661767396;4884.658073934826;6918.723251069951;6950.478714096463;6964.338387853146;6979.651017449158;7021.22766495685;5025.221090730943;5029.220470826955;5032.572231360302;5053.343065401475;5058.291839142523;4988.35151430319;5002.774875130628;5044.924326135111;5098.796048158107;5107.642465027487;5698.82903512887;5709.571782116358;5736.397678243808;5758.424157584208;5759.568032397587;6581.308962558958;6613.735450582019;6669.166354205724;6674.933250667431;6703.262641109474;1663.2847875413447;1706.3601149568913;1710.4441056656387;1748.160882776249;1767.2754170789915;1187.4062968515743;1219.9573014944613;1229.8032314829584;1239.2812168941991;1242.136714983078;5750.987154495893;5753.482186603226;5775;5800.53595712342;5819.53443724501;6568.883289840738;6589.143411356493;6714.160729908762;6717.6977036033495;6734.427573656196;5727.885442291131;5731.369549349568;5771.740271687784;5773.5958482906635;5805.88388232233;3588.102974256436;3607.4769158471877;3608.350496910581;3640.817959102087;3647.3070116677745;6501.1548498694865;6534.705938232696;6572.671366431659;6589.17635295588;6632.303608121174;6881.41507971818;6892.1735740028935;6955;6974.825629359307;6986.336298051677;6564.949608062782;6590.6932573599815;6622;6637.601743895381;6640.269570347258;6783.4573234142135;6797.25230224665;6797.64047190554;6813.727450901908;6814.352636499525;6636.43590294811;6646.966765166143;6676.232233293234;6678.298778628368;6729.629870357177;6453.580517266362;6461.61230326182;6472;6478.870422591616;6583.44040756541;4910.950890491193;4964.63112461032;4984.950150498594;4990.126727822689;5036.118679231046;6666.766663166766;6723.865522689616;6741.258461569126;6791.320867913169;6795.45636349081;6418.293987661447;6460.806175814733;6505.60966342021;6505.772297969548;6586.571872828251;6446.5165112615805;6457.6771161442675;6539.6403197824575;6542.476601871744;6545.770898018546;6143.477804386498;6210.8572542472775;6315.873682526232;6401.42387185137;6463.676816159267;6452.032195170762;6485.605594797141;6513.641749703812;6557.9344206557325;6583.572067815577;6256.280527739186;6303.46420554258;6314.526410519321;6322.810315690536;6353.252855464784 03:17:13 INFO - PID 3573 | |5;yui.html;862.202462721982;893.0533634347591;896.7802888292367;897.5871099294325;898.5417437107078;16944.661106777872;17677.646447071067;17688.38090666825;17775.64448711025;17781.91109044453;15028.323725432354;16519.17404129795;18409.81590184098;19973.10121044553;20117.195312187494;998.2946215755312;1022.8670272864517;1023.7287118913457;1023.7645341571443;1025.08255111675;1028.341861208827;1030.479607798061;1030.855680204772;1031.5718976624692;1034.2966782587837;1003.7540802503397;1042.593388578455;1045.7699306152672;1051.1590727418072;1054.0355574649186;1031.9019693129142;1033.560736686905;1036.507658862042;1036.575004248262;1036.585365853657;760.6158889760635;763.9732609358646;764.6291548598925;769.5036701327613;770.2528547309101;17949.551261218443;18425.631487370312;19581.510462238417;19742.40772776819;19779.307724229726;20051.1979520819;20422.0810063546;20706.171753129856;20929.372118836458;20946.371608851758;15425.922870385688;15665.373385064584;15884.761728573965;16017.798665100048;16021;3494.9126271843406;3531.276088401897;3539.8938031859084;3542.734294927891;3547.130952916526;124296;126818.36590816987;130726;131590.3420482901;133228.3338583301;15700.293486793122;16053.919730401274;16102.677946441005;16203.594910127105;16397.836021639632;28364.290892727848;30274.394512109633;30279.848600756854;30680.232994175323;30687.539686904714;8366.916330836613;8587.613557389932;8607.526586037702;8610.095939926343;8629.956850215709;3921.568627450978;3983.063979964706;3998.980005099956;4032.395140728914;4033.6369726724147;4872.756362181876;5106.668066575735;5159.071367153948;5163.561097306696;5180.456052114474;992.369845148336;1014.3254735600743;1014.624588902111;1033.1012019543045;1034.886162522122;659.2221179008816;662.211967758366;687.1547995964991;694.9826254343682;698.769406095987;10931.508082136323;11681.532738690357;11992.64022079339;12013.87986120145;12218;609.2445367744054;619.5693992675137;627.9120923070774;636.5162476517879;642.9710663020176;5269.657472264367;5315.760790764425;5333.359996800331;5467.6719396836315;5701.828945131652;94955;95710;99246;100447;103307.48346258371;84226.57886710527;88731;89047;89123;91777;75253.87119193216;75366;78568.607156965;79231.60384198157;79233.60383198163;11861.169718119994;11995.40022998864;12164.695882603006;12603.74792504163;12662.366881656064;34109.97670069902;34611;35003.47494787529;35762.64237357593;36014.09964750902;41640.95897602584;44663.55336446724;44857.327140092275;46277.53722462867;67209.32790672226;16335;17185.570360741083;17869.821301786815;17897.910510447364;17903.46289611314;19056.04719764034;19188.616227675648;19211.807881921002;19286.61426771485;19530.60938781188;18531.90734046321;18552.907235463736;18672.346467873558;18696.439106826816;18970.905145474186;14780.18708970974;15127.621809454851;15230.46693365727;15277.694446111238;16554.17229138514;17325.740113898555;17955.910220448815;17971.73042404391;18111.637767244843;18170.81829181691;11379.260348077349;11472.196946213686;11855.17013809025;12071.275723456622;12313.645498994923;11939.447871776614;12296.754064918472;13094.476220951055;13284.468621255042;14069.366878490697 03:17:13 INFO - PID 3573 | __end_tp_report 03:17:13 INFO - PID 3573 | __start_cc_report 03:17:13 INFO - PID 3573 | _x_x_mozilla_cycle_collect,361 03:17:13 INFO - PID 3573 | __end_cc_report 03:17:13 INFO - PID 3573 | __startTimestamp1501496233401__endTimestamp 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | ------- Summary: start ------- 03:17:13 INFO - PID 3573 | Number of tests: 6 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | [#0] dojo.html Cycles:165 Average:6082.88 Median:6389.52 stddev:818.92 (12.8%) stddev-sans-first:787.82 03:17:13 INFO - PID 3573 | Values: 3122.5 3144.7 3179.6 3184.7 3227.4 6128.8 6177.1 6213.3 6275.8 6295.7 6177.8 6199.8 6205.5 6245.5 6259.6 5640.9 5711.8 5723.9 5732.7 5736.3 5647.2 5657.2 5671.9 5697.5 5749.4 5667.2 5726.9 5766.3 5776.0 5779.4 697.7 5575.4 5658.6 5725.5 5736.8 5530.2 5550.9 5589.8 5625.5 5653.8 6029.8 6063.8 6103.5 6142.4 6150.2 6564.0 6584.3 6672.1 6672.1 6680.7 6637.4 6661.7 6731.8 6753.0 6762.7 6061.2 6150.8 6169.7 6203.2 6269.1 6642.0 6687.8 6689.5 6694.9 6696.7 6323.1 6389.5 6399.4 6401.2 6401.6 6476.8 6489.9 6508.1 6509.3 6561.2 6576.5 6590.5 6631.2 6677.9 6685.7 6625.2 6638.4 6717.4 6729.4 6736.2 5259.4 5342.9 5374.5 5424.4 5429.5 4647.1 4670.9 4699.5 4714.4 4714.6 5776.1 5843.9 5852.9 5857.3 5860.6 6648.5 6654.4 6677.2 6758.2 6773.7 5697.5 5778.4 5786.6 5861.9 5862.4 5881.1 5887.5 5889.9 5892.8 5906.8 6431.3 6437.6 6438.8 6532.0 6544.3 6527.8 6657.8 6658.1 6757.3 6761.9 6413.4 6426.7 6427.2 6429.6 6449.9 6485.6 6501.7 6508.4 6517.8 6518.7 6585.5 6679.1 6682.8 6685.0 6688.3 6429.5 6475.4 6476.8 6478.0 6480.0 6428.6 6454.9 6459.8 6468.2 6480.1 6303.8 6367.2 6397.0 6422.8 6447.9 6460.4 6519.6 6570.6 6606.5 6676.9 6196.2 6283.9 6300.8 6341.8 6366.7 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | [#1] ext.html Cycles:180 Average:37275.46 Median:3632.97 stddev:53614.49 (1475.8%) stddev-sans-first:53694.95 03:17:13 INFO - PID 3573 | Values: 802.6 838.8 855.7 888.3 898.2 39369.0 40024.8 40087.4 40093.2 40117.8 36605.6 36708.8 36886.3 36985.3 37008.3 6890.9 7005.0 7012.5 7016.1 7018.9 6840.8 6962.2 6968.9 6971.3 6974.1 6936.0 7559.9 7810.5 7812.2 7815.6 7708.2 7767.0 7767.6 7773.6 7775.3 7519.7 7648.3 7728.5 7730.1 7732.7 37658.2 37791.4 37825.4 37871.0 37889.6 3566.4 3621.1 3625.9 3630.2 3635.8 30443.8 30473.2 30624.5 30655.5 30737.5 4876.7 4894.4 4903.9 4927.8 4940.8 183894.0 184239.0 187334.0 188832.0 192367.0 48440.5 48500.0 48622.3 48714.0 48851.0 50276.2 50398.7 50399.5 50426.2 50454.2 15108.6 15225.8 15344.2 15393.8 15611.8 12893.5 12925.2 12931.4 12950.8 12954.2 13820.4 13933.9 14038.6 14088.4 14282.0 5630.4 5680.9 5764.5 5794.4 5798.0 974.3 991.7 994.5 1009.9 1018.5 22179.8 22433.6 22557.0 23054.9 23176.5 1081.5 1093.9 1100.3 1105.8 1117.2 11663.8 11885.8 11911.8 11979.8 12265.0 226753.0 227414.0 228212.0 228341.0 229048.0 51489.2 52087.7 55310.0 56546.7 56673.1 1455.7 1483.7 1492.6 1494.3 1494.4 26631.3 26838.2 26839.6 27046.2 27163.9 36920.4 37029.4 37284.8 37317.6 37375.6 201456.0 202324.0 202747.0 203885.0 204384.0 32097.0 33212.3 34914.8 35049.8 35058.3 43610.6 44994.6 45040.8 45107.3 45408.8 25280.5 27081.0 27994.3 28199.0 28686.6 26937.3 27038.5 27715.9 27849.9 28328.9 38150.2 38160.2 38229.0 38412.2 38428.8 31373.0 31612.4 31796.0 32876.3 33655.7 23586.0 23691.4 24142.4 24147.9 24151.9 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | [#2] jquery.html Cycles:180 Average:37188.12 Median:13344.12 stddev:89744.10 (672.5%) stddev-sans-first:89953.73 03:17:13 INFO - PID 3573 | Values: 563.9 569.9 570.7 572.6 586.4 22263.8 22404.3 23038.2 23214.8 23240.4 24256.8 24857.3 24958.0 24958.3 24995.8 6434.0 6592.0 6619.7 6626.0 6627.1 6376.7 6520.0 6641.1 6980.7 6991.3 6952.2 6984.8 6988.9 7004.8 7014.4 7015.0 7021.7 7023.6 7044.6 7048.9 6867.2 6877.3 6883.2 6901.7 6904.9 31862.2 31979.0 32062.7 32893.7 33014.5 1972.8 1988.6 1998.2 2000.9 2001.4 19664.0 20088.7 20108.5 20125.7 20128.1 2431.5 2453.9 2540.8 2549.5 2557.6 136110.0 141329.0 143621.0 144077.0 144329.3 19433.5 21596.4 21803.8 22118.9 22899.9 22852.2 23772.8 23783.5 23946.3 44918.6 9965.4 9974.2 9986.7 10233.3 10266.6 9253.7 9404.3 9432.0 9507.9 9514.0 9180.5 9219.5 9312.6 9453.3 9486.6 2658.9 2700.9 2746.1 2776.9 2851.9 915.5 947.6 951.3 971.6 988.9 19217.0 19230.8 20186.4 23410.6 25081.6 993.2 1016.8 1023.6 1053.6 1063.4 11077.0 11162.9 11234.3 11344.8 11360.5 527018.0 527075.0 531002.0 536286.0 547715.0 121081.9 124575.0 124581.4 126421.0 127354.0 1256.9 1258.7 1291.3 1291.9 1302.7 17390.9 18379.4 18568.0 18889.6 18994.3 58992.7 59953.7 60196.7 60701.4 62363.4 74759.7 77632.0 77847.2 77890.6 79858.6 14838.6 15047.5 15127.4 15177.8 15198.0 23201.7 24400.4 24496.5 24866.9 24884.1 18170.9 18246.9 18904.6 19303.4 19337.2 13187.7 13669.7 14118.7 14373.6 14625.7 19045.9 19254.9 19359.2 19413.5 19456.5 15015.8 15125.1 15174.8 15247.7 15309.2 17777.3 18809.3 18988.8 19019.2 19592.7 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | [#3] mootools.html Cycles:180 Average:8597.84 Median:2627.60 stddev:5944.52 (226.2%) stddev-sans-first:5935.95 03:17:13 INFO - PID 3573 | Values: 1306.2 1370.7 1400.7 1409.2 1410.3 13803.7 14024.7 14262.9 14470.0 14478.9 14433.3 14667.0 14680.1 14747.3 14749.4 2677.7 2722.2 2722.8 2723.0 2724.5 2677.5 2799.2 2800.9 2808.1 2808.2 2633.4 2650.0 2665.1 2675.5 2682.2 2595.4 2614.8 2625.4 2625.9 2629.3 2512.4 2518.2 2520.6 2535.3 2545.0 13730.4 14082.4 14098.3 14109.1 14138.1 7580.4 7875.2 7904.4 7917.2 7925.9 5008.7 5065.8 5069.2 5142.4 5169.4 1833.6 1833.8 1846.8 1883.5 1890.1 23198.0 23207.3 23294.0 23322.9 23382.4 6382.2 6617.7 6621.7 6764.5 6771.6 15798.8 15955.0 15958.1 15973.8 15995.8 7471.7 7574.8 7592.1 7647.5 7672.2 5829.2 5833.7 6122.1 6940.7 7044.3 4936.7 5092.7 5103.7 5184.2 5195.7 1445.9 1467.9 1476.5 1493.2 1514.3 832.3 836.9 848.5 858.6 872.3 6496.8 6594.0 6909.1 6959.3 7040.6 667.5 689.8 707.4 714.1 723.7 4502.8 4760.5 4785.8 5147.9 5248.9 18766.5 18924.9 19127.8 19327.1 19454.0 18792.2 18952.5 19062.5 19181.2 19242.9 10206.4 10896.3 10939.1 11036.1 11052.9 7834.5 7886.0 8045.8 8104.8 8131.8 15534.1 16483.9 16583.3 16664.7 17220.7 16256.8 16647.5 17109.2 17372.0 17550.6 10831.4 11035.0 11181.4 11183.7 11555.1 13210.7 13243.4 13255.9 13373.1 13377.7 9597.3 9733.5 10012.9 10160.2 10199.3 9628.5 10003.6 10015.6 10414.4 10508.1 8947.3 8970.7 9015.6 9017.2 9025.8 6662.3 6814.6 6858.4 6880.2 6919.1 6456.0 6699.5 6715.7 6824.0 7003.8 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | [#4] prototype.html Cycles:180 Average:5506.60 Median:6124.33 stddev:1552.17 (25.3%) stddev-sans-first:1510.14 03:17:13 INFO - PID 3573 | Values: 489.0 510.9 519.9 526.0 527.0 6214.4 6241.8 6256.4 6279.9 6335.7 5899.4 6116.2 6118.4 6138.2 6143.9 4880.8 4900.6 4942.3 4975.5 4990.9 4902.8 4916.5 4922.6 4958.7 4990.3 4755.3 4858.2 4889.5 4903.5 4975.5 4856.9 4925.4 4942.1 4974.7 4987.0 4402.2 4429.0 4449.8 4453.2 4454.1 6027.1 6076.8 6089.3 6130.3 6161.7 5671.2 5691.5 5700.3 5721.7 5737.3 6348.9 6393.9 6413.2 6514.3 6551.0 4845.5 4846.6 4854.9 4860.2 4884.7 6918.7 6950.5 6964.3 6979.7 7021.2 5025.2 5029.2 5032.6 5053.3 5058.3 4988.4 5002.8 5044.9 5098.8 5107.6 5698.8 5709.6 5736.4 5758.4 5759.6 6581.3 6613.7 6669.2 6674.9 6703.3 1663.3 1706.4 1710.4 1748.2 1767.3 1187.4 1220.0 1229.8 1239.3 1242.1 5751.0 5753.5 5775.0 5800.5 5819.5 6568.9 6589.1 6714.2 6717.7 6734.4 5727.9 5731.4 5771.7 5773.6 5805.9 3588.1 3607.5 3608.4 3640.8 3647.3 6501.2 6534.7 6572.7 6589.2 6632.3 6881.4 6892.2 6955.0 6974.8 6986.3 6564.9 6590.7 6622.0 6637.6 6640.3 6783.5 6797.3 6797.6 6813.7 6814.4 6636.4 6647.0 6676.2 6678.3 6729.6 6453.6 6461.6 6472.0 6478.9 6583.4 4911.0 4964.6 4985.0 4990.1 5036.1 6666.8 6723.9 6741.3 6791.3 6795.5 6418.3 6460.8 6505.6 6505.8 6586.6 6446.5 6457.7 6539.6 6542.5 6545.8 6143.5 6210.9 6315.9 6401.4 6463.7 6452.0 6485.6 6513.6 6557.9 6583.6 6256.3 6303.5 6314.5 6322.8 6353.3 03:17:13 INFO - PID 3573 | 03:17:13 INFO - PID 3573 | [#5] yui.html Cycles:180 Average:21878.13 Median:19122.33 stddev:29910.13 (156.4%) stddev-sans-first:29952.40 03:17:13 INFO - PID 3573 | Values: 862.2 893.1 896.8 897.6 898.5 16944.7 17677.6 17688.4 17775.6 17781.9 15028.3 16519.2 18409.8 19973.1 20117.2 998.3 1022.9 1023.7 1023.8 1025.1 1028.3 1030.5 1030.9 1031.6 1034.3 1003.8 1042.6 1045.8 1051.2 1054.0 1031.9 1033.6 1036.5 1036.6 1036.6 760.6 764.0 764.6 769.5 770.3 17949.6 18425.6 19581.5 19742.4 19779.3 20051.2 20422.1 20706.2 20929.4 20946.4 15425.9 15665.4 15884.8 16017.8 16021.0 3494.9 3531.3 3539.9 3542.7 3547.1 124296.0 126818.4 130726.0 131590.3 133228.3 15700.3 16053.9 16102.7 16203.6 16397.8 28364.3 30274.4 30279.8 30680.2 30687.5 8366.9 8587.6 8607.5 8610.1 8630.0 3921.6 3983.1 3999.0 4032.4 4033.6 4872.8 5106.7 5159.1 5163.6 5180.5 992.4 1014.3 1014.6 1033.1 1034.9 659.2 662.2 687.2 695.0 698.8 10931.5 11681.5 11992.6 12013.9 12218.0 609.2 619.6 627.9 636.5 643.0 5269.7 5315.8 5333.4 5467.7 5701.8 94955.0 95710.0 99246.0 100447.0 103307.5 84226.6 88731.0 89047.0 89123.0 91777.0 75253.9 75366.0 78568.6 79231.6 79233.6 11861.2 11995.4 12164.7 12603.7 12662.4 34110.0 34611.0 35003.5 35762.6 36014.1 41641.0 44663.6 44857.3 46277.5 67209.3 16335.0 17185.6 17869.8 17897.9 17903.5 19056.0 19188.6 19211.8 19286.6 19530.6 18531.9 18552.9 18672.3 18696.4 18970.9 14780.2 15127.6 15230.5 15277.7 16554.2 17325.7 17955.9 17971.7 18111.6 18170.8 11379.3 11472.2 11855.2 12071.3 12313.6 11939.4 12296.8 13094.5 13284.5 14069.4 03:17:13 INFO - PID 3573 | -------- Summary: end -------- 03:17:13 INFO - PID 3573 | 03:17:14 INFO - TEST-INFO | 3573: exit 0 03:17:14 INFO - TEST-OK | dromaeo_css | took 1118923ms 03:17:14 INFO - TEST-START | kraken 03:17:14 INFO - Initialising browser for kraken test... 03:17:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html -profile /tmp/tmplv1eP_/profile 03:17:14 INFO - TEST-INFO | started process 3956 (/builds/slave/test/build/application/firefox/firefox http://localhost:50765/getInfo.html) 03:17:20 INFO - TEST-INFO | 3956: exit 0 03:17:20 INFO - Browser initialized. 03:17:20 INFO - Running cycle 1/1 for kraken test... 03:17:20 INFO - TEST-INFO | started process 4180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplv1eP_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:21 INFO - PID 4180 | 03:17:21 INFO - PID 4180 | (/builds/slave/test/build/application/firefox/firefox:4235): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:17:21 INFO - PID 4180 | 03:17:32 INFO - PID 4180 | RSS: Main: 173776896 03:17:32 INFO - PID 4180 | 03:17:34 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:35 INFO - PID 4180 | RSS: Main: 178618368 03:17:35 INFO - PID 4180 | 03:17:38 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-dft) 03:17:39 INFO - PID 4180 | RSS: Main: 179445760 03:17:39 INFO - PID 4180 | 03:17:42 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-fft) 03:17:42 INFO - PID 4180 | RSS: Main: 173592576 03:17:42 INFO - PID 4180 | 03:17:45 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50765/tests/kraken/driver.html?testName=audio-oscillator) 03:17:45 INFO - PID 4180 | RSS: Main: 175026176 03:17:45 INFO - PID 4180 | 03:17:47 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:48 INFO - PID 4180 | RSS: Main: 174854144 03:17:48 INFO - PID 4180 | 03:17:51 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50765/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:52 INFO - PID 4180 | RSS: Main: 177430528 03:17:52 INFO - PID 4180 | 03:17:55 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50765/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:56 INFO - PID 4180 | RSS: Main: 176914432 03:17:56 INFO - PID 4180 | 03:17:59 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50765/tests/kraken/driver.html?testName=json-parse-financial) 03:18:00 INFO - PID 4180 | RSS: Main: 178184192 03:18:00 INFO - PID 4180 | 03:18:01 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:18:02 INFO - PID 4180 | RSS: Main: 178147328 03:18:02 INFO - PID 4180 | 03:18:04 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:18:04 INFO - PID 4180 | RSS: Main: 175505408 03:18:04 INFO - PID 4180 | 03:18:07 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:07 INFO - PID 4180 | RSS: Main: 176119808 03:18:07 INFO - PID 4180 | 03:18:10 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:11 INFO - PID 4180 | RSS: Main: 176029696 03:18:11 INFO - PID 4180 | 03:18:14 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:15 INFO - PID 4180 | RSS: Main: 176009216 03:18:15 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | Cycle 1(1): loaded http://localhost:50765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50765/tests/kraken/driver.html?testName=ai-astar) 03:18:17 INFO - PID 4180 | RSS: Main: 177278976 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | __start_tp_report 03:18:17 INFO - PID 4180 | _x_x_mozilla_page_load 03:18:17 INFO - PID 4180 | _x_x_mozilla_page_load_details 03:18:17 INFO - PID 4180 | |i|pagename|runs| 03:18:17 INFO - PID 4180 | |0;ai-astar;99;111;104;108;110;111;110;100;107;109 03:18:17 INFO - PID 4180 | |1;audio-beat-detection;147;117;151;186;121;145;155;118;176;117 03:18:17 INFO - PID 4180 | |2;audio-dft;172;164;169;161;164;163;165;164;161;163 03:18:17 INFO - PID 4180 | |3;audio-fft;74;76;76;164;77;78;75;74;150;77 03:18:17 INFO - PID 4180 | |4;audio-oscillator;79;78;132;79;81;78;133;80;78;126 03:18:17 INFO - PID 4180 | |5;imaging-gaussian-blur;117;117;114;114;116;114;114;115;118;114 03:18:17 INFO - PID 4180 | |6;imaging-darkroom;149;149;151;151;150;149;152;154;157;149 03:18:17 INFO - PID 4180 | |7;imaging-desaturate;94;99;95;94;94;95;95;94;98;94 03:18:17 INFO - PID 4180 | |8;json-parse-financial;57;69;57;61;57;57;58;60;57;61 03:18:17 INFO - PID 4180 | |9;json-stringify-tinderbox;55;54;54;54;54;55;54;55;54;66 03:18:17 INFO - PID 4180 | |10;stanford-crypto-aes;80;79;81;79;94;79;81;88;90;78 03:18:17 INFO - PID 4180 | |11;stanford-crypto-ccm;142;134;132;133;127;125;140;125;147;172 03:18:17 INFO - PID 4180 | |12;stanford-crypto-pbkdf2;187;183;184;181;185;182;187;186;181;194 03:18:17 INFO - PID 4180 | |13;stanford-crypto-sha256-iterative;68;65;65;67;67;65;73;73;68;68 03:18:17 INFO - PID 4180 | __end_tp_report 03:18:17 INFO - PID 4180 | __start_cc_report 03:18:17 INFO - PID 4180 | _x_x_mozilla_cycle_collect,959 03:18:17 INFO - PID 4180 | __end_cc_report 03:18:17 INFO - PID 4180 | __startTimestamp1501496297258__endTimestamp 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | ------- Summary: start ------- 03:18:17 INFO - PID 4180 | Number of tests: 14 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#0] ai-astar Cycles:10 Average:106.90 Median:110.00 stddev:4.43 (4.0%) stddev-sans-first:3.67 03:18:17 INFO - PID 4180 | Values: 99.0 111.0 104.0 108.0 110.0 111.0 110.0 100.0 107.0 109.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:25.00 (16.8%) stddev-sans-first:26.48 03:18:17 INFO - PID 4180 | Values: 147.0 117.0 151.0 186.0 121.0 145.0 155.0 118.0 176.0 117.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.44 (2.1%) stddev-sans-first:2.39 03:18:17 INFO - PID 4180 | Values: 172.0 164.0 169.0 161.0 164.0 163.0 165.0 164.0 161.0 163.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:34.39 (45.2%) stddev-sans-first:35.84 03:18:17 INFO - PID 4180 | Values: 74.0 76.0 76.0 164.0 77.0 78.0 75.0 74.0 150.0 77.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:78.50 stddev:24.88 (31.7%) stddev-sans-first:25.76 03:18:17 INFO - PID 4180 | Values: 79.0 78.0 132.0 79.0 81.0 78.0 133.0 80.0 78.0 126.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.50 stddev:1.57 (1.4%) stddev-sans-first:1.54 03:18:17 INFO - PID 4180 | Values: 117.0 117.0 114.0 114.0 116.0 114.0 114.0 115.0 118.0 114.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:2.64 (1.8%) stddev-sans-first:2.69 03:18:17 INFO - PID 4180 | Values: 149.0 149.0 151.0 151.0 150.0 149.0 152.0 154.0 157.0 149.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.81 (1.9%) stddev-sans-first:1.87 03:18:17 INFO - PID 4180 | Values: 94.0 99.0 95.0 94.0 94.0 95.0 95.0 94.0 98.0 94.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.00 stddev:3.78 (6.4%) stddev-sans-first:3.91 03:18:17 INFO - PID 4180 | Values: 57.0 69.0 57.0 61.0 57.0 57.0 58.0 60.0 57.0 61.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:54.50 stddev:3.72 (6.8%) stddev-sans-first:3.94 03:18:17 INFO - PID 4180 | Values: 55.0 54.0 54.0 54.0 54.0 55.0 54.0 55.0 54.0 66.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:81.00 stddev:5.63 (6.9%) stddev-sans-first:5.87 03:18:17 INFO - PID 4180 | Values: 80.0 79.0 81.0 79.0 94.0 79.0 81.0 88.0 90.0 78.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:137.00 stddev:14.11 (10.3%) stddev-sans-first:14.88 03:18:17 INFO - PID 4180 | Values: 142.0 134.0 132.0 133.0 127.0 125.0 140.0 125.0 147.0 172.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:185.50 stddev:3.89 (2.1%) stddev-sans-first:4.06 03:18:17 INFO - PID 4180 | Values: 187.0 183.0 184.0 181.0 185.0 182.0 187.0 186.0 181.0 194.0 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.96 (4.4%) stddev-sans-first:3.14 03:18:17 INFO - PID 4180 | Values: 68.0 65.0 65.0 67.0 67.0 65.0 73.0 73.0 68.0 68.0 03:18:17 INFO - PID 4180 | -------- Summary: end -------- 03:18:17 INFO - PID 4180 | 03:18:17 INFO - PID 4180 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:18:18 INFO - TEST-INFO | 4180: exit 0 03:18:18 INFO - TEST-OK | kraken | took 63853ms 03:18:18 INFO - SUITE-END | took 1182s 03:18:18 INFO - Completed test suite (00:19:43) 03:18:18 INFO - javascript benchmark 03:18:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8383.308431777828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.45357062514, 3144.701253380929, 3179.60254968129, 3184.7452203823696, 3227.4029304578653, 6128.816135515931, 6177.073438984155, 6213.316535181132, 6275.780347687832, 6295.653739044351, 6177.81466556004, 6199.752009919598, 6205.503559715224, 6245.500359971203, 6259.593126446778, 5640.887182256352, 5711.8000869969555, 5723.885522289552, 5732.742026608813, 5736.311642602894, 5647.181158731982, 5657.23627310314, 5671.943280567183, 5697.515711164535, 5749.425057494238, 5667.234923285366, 5726.914096288559, 5766.250387449626, 5775.971120144414, 5779.3642699303045, 697.7225954125881, 5575.358833734132, 5658.632188907728, 5725.513331366838, 5736.7992120276, 5530.198121272433, 5550.91673624896, 5589.832305030855, 5625.46558076982, 5653.773849046033, 6029.758809647609, 6063.848403789896, 6103.450689437972, 6142.447179753844, 6150.231221097363, 6563.967180164069, 6584.341565843425, 6672.132622759011, 6672.132622759059, 6680.69936852838, 6637.435817955479, 6661.733530658767, 6731.798046058626, 6752.966235168793, 6762.729490820361, 6061.151438798572, 6150.753969841201, 6169.722362493743, 6203.193584833943, 6269.122322874801, 6642.036904648799, 6687.76592819249, 6689.531732778756, 6694.899576506356, 6696.698648560827, 6323.083152942798, 6389.520785941073, 6399.392057754506, 6401.231852177675, 6401.615903045832, 6476.805695829038, 6489.935100649028, 6508.088867558546, 6509.349065093453, 6561.245456772437, 6576.473882089422, 6590.538662293593, 6631.204255489276, 6677.899831502531, 6685.732570697215, 6625.238097618739, 6638.369354911276, 6717.429018533382, 6729.394354508117, 6736.191657001191, 5259.421463639073, 5342.9465705342445, 5374.543163831118, 5424.403315635277, 5429.511343979061, 4647.117047760915, 4670.906581868344, 4699.530046995342, 4714.363560919301, 4714.622830173578, 5776.133579962955, 5843.912341314884, 5852.912206316909, 5857.297124345021, 5860.560457965585, 6648.53460257787, 6654.401103900672, 6677.165354330708, 6758.155230596176, 6773.729050837911, 5697.515711164515, 5778.393268706809, 5786.623869448473, 5861.88276234473, 5862.443067908542, 5881.147233651097, 5887.4701276884425, 5889.882202356014, 5892.764289428461, 5906.822795316061, 6431.292557818636, 6437.645929474018, 6438.774642887476, 6531.987541931008, 6544.345565443417, 6527.771527996498, 6657.833554161185, 6658.1344425224415, 6757.3242675732035, 6761.898571521333, 6413.42279194856, 6426.710798014007, 6427.228732552124, 6429.6142231466265, 6449.903251451138, 6485.578437401554, 6501.707423165874, 6508.414242718178, 6517.804465866032, 6518.674066296761, 6585.506087043586, 6679.098321726505, 6682.832929176615, 6684.966575167093, 6688.331166883273, 6429.517786165963, 6475.449586785176, 6476.773312934025, 6478.028295755675, 6479.967600161969, 6428.614283143026, 6454.935450645621, 6459.773907913201, 6468.191476065492, 6480.060391243149, 6303.779367722108, 6367.204099487564, 6397.0, 6422.775202868064, 6447.9032814508755, 6460.3862633049785, 6519.608823470607, 6570.5729127606555, 6606.537542371988, 6676.866462670817, 6196.1635179250225, 6283.937160628335, 6300.810975670737, 6341.8097457076365, 6366.681665916593], "value": 6026.252871557673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.5746354432154, 838.8070743728946, 855.7005048233119, 888.3026823943204, 898.1736802142028, 39369.0, 40024.799876000616, 40087.39868901969, 40093.19813603726, 40117.799411002976, 36605.633943660556, 36708.81645591775, 36886.26227475449, 36985.26029479409, 37008.259834803284, 6890.862182756329, 7004.964975175117, 7012.474064445161, 7016.052832867574, 7018.929810701904, 6840.760573379933, 6962.1993470751, 6968.895466568006, 6971.33772291634, 6974.09336786217, 6936.0, 7559.924400755977, 7810.531368117902, 7812.218778122199, 7815.648295826673, 7708.229177082303, 7767.0, 7767.611619419063, 7773.572453515055, 7775.339096176832, 7519.699212031513, 7648.311651951295, 7728.459007869451, 7730.149683534807, 7732.690692372298, 37658.24683506342, 37791.43312850282, 37825.43261851074, 37871.0, 37889.621103788886, 3566.4115420955773, 3621.149029977953, 3625.8730944417084, 3630.1832087780303, 3635.763675361093, 30443.847780761174, 30473.23816904573, 30624.54063189054, 30655.540166897514, 30737.538936915964, 4876.707397556158, 4894.36373271476, 4903.901921961577, 4927.827526036572, 4940.827071052532, 183894.0, 184239.0, 187334.0, 188832.0, 192367.0, 48440.515594844306, 48500.0, 48622.27066593933, 48714.0, 48851.0, 50276.24585631218, 50398.748006260466, 50399.496005040215, 50426.24360634593, 50454.243186352236, 15108.622284442758, 15225.847741522442, 15344.156071415957, 15393.846061539465, 15611.843881561266, 12893.48426062947, 12925.224486530838, 12931.353432328535, 12950.805737913939, 12954.157979731288, 13820.447182112603, 13933.930330348283, 14038.649033774238, 14088.43646254159, 14282.000259981702, 5630.4369563043365, 5680.943190568124, 5764.510016648548, 5794.391588883191, 5798.0, 974.288769198489, 991.6585762120839, 994.4828689081781, 1009.878814542245, 1018.5416562546735, 22179.79952835964, 22433.551328973655, 22557.0, 23054.901394566015, 23176.53646927052, 1081.453865797767, 1093.8796732359433, 1100.2573263047411, 1105.8064838653365, 1117.1677100559973, 11663.825042624367, 11885.821712674317, 11911.761764764657, 11979.760404791856, 12265.016962682135, 226753.0, 227414.0, 228212.0, 228341.0, 229048.0, 51489.22766158511, 52087.739561301954, 55310.0, 56546.717266413405, 56673.149902751495, 1455.7015811758565, 1483.6513419346445, 1492.634304595381, 1494.31261619654, 1494.4097081652687, 26631.33421664474, 26838.194854154408, 26839.597406039316, 27046.1886143416, 27163.91344346204, 36920.44619330658, 37029.44455833111, 37284.81357593195, 37317.626823731414, 37375.626243738305, 201456.0, 202324.0, 202747.0, 203885.0, 204384.0, 32097.0, 33212.33575328528, 34914.82542587271, 35049.82475087608, 35058.298834022666, 43610.56389436192, 44994.550054499035, 45040.77479612581, 45107.32339014983, 45408.772956135006, 25280.494390112464, 27081.0, 27994.300142495787, 28199.0, 28686.56970145491, 26937.326566835985, 27038.459230815668, 27715.861420692767, 27849.860750696116, 28328.85835570809, 38150.23699526049, 38160.23679526449, 38229.0, 38412.2317553653, 38428.80785596054, 31373.0, 31612.367752645278, 31796.0, 32876.34247315088, 33655.66344336525, 23586.0, 23691.407714806577, 24142.39644008914, 24147.879260603586, 24151.879240604387], "value": 16895.104623644595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9464250896164, 569.9031164702002, 570.7431655754908, 572.627791935242, 586.3550094895616, 22263.777362226374, 22404.3278701639, 23038.19366322179, 23214.76785232147, 23240.41898952527, 24256.757432425715, 24857.254282371512, 24958.0, 24958.251252462454, 24995.75004249957, 6433.967830160843, 6592.0, 6619.735210591594, 6626.039224312472, 6627.138471998657, 6376.681165941684, 6519.967400162993, 6641.103451034097, 6980.720771169173, 6991.300869913019, 6952.200496942841, 6984.825379365531, 6988.895166572505, 7004.754833580826, 7014.438844892396, 7014.982827490011, 7021.684024218871, 7023.578585284874, 7044.64776761165, 7048.929510704878, 6867.244603093705, 6877.346652068046, 6883.242843287235, 6901.654917254117, 6904.861902761967, 31862.20344491383, 31979.0, 32062.679373206203, 32893.6710632893, 33014.50478242828, 1972.8323092537153, 1988.6321030609383, 1998.1607724755638, 2000.949976250591, 2001.4395969128668, 19664.016799159985, 20088.69866951997, 20108.497287567927, 20125.698114528295, 20128.09423575928, 2431.489387228684, 2453.926382208537, 2540.7840333571667, 2549.4773571417813, 2557.6035714464288, 136110.0, 141329.0, 143621.0, 144077.0, 144329.27835360862, 19433.514162145777, 21596.352109436742, 21803.78293087239, 22118.88940555287, 22899.939005489585, 22852.200172993864, 23772.7622723774, 23783.52432951331, 23946.28161155168, 44918.55081449209, 9965.40207587547, 9974.202063834875, 9986.650467233612, 10233.283670143168, 10266.589336426608, 9253.72238832836, 9404.345196188275, 9432.0, 9507.904920950841, 9513.952430237805, 9180.495072770927, 9219.539023048821, 9312.627494900264, 9453.291003174789, 9486.620535178516, 2658.9468210635678, 2700.8919643214053, 2746.0663374452784, 2776.9028084016963, 2851.8859245630356, 915.5285028210477, 947.5593848860314, 951.3007939164709, 971.6307803034802, 988.906053924876, 19217.0, 19230.807691923183, 20186.39440816778, 23410.64884026741, 25081.62377564338, 993.2302465589082, 1016.8373060310315, 1023.5516743807577, 1053.599632139782, 1063.3779239145188, 11077.0, 11162.939520745516, 11234.3259404436, 11344.829827552594, 11360.545578176945, 527018.0, 527075.0, 531002.0, 536286.0, 547715.0, 121081.89511162556, 124575.0, 124581.37709311396, 126421.0, 127354.0, 1256.9120161588785, 1258.704204511939, 1291.296243547269, 1291.8966482681362, 1302.726427450246, 17390.913045434692, 18379.448616541526, 18568.0, 18889.622207556047, 18994.335198267996, 58992.705036474545, 59953.700231498566, 60196.69901650464, 60701.39298606957, 62363.37636623757, 74759.65757297847, 77632.0, 77847.22152778626, 77890.6105469469, 79858.60070699609, 14838.629034274229, 15047.548573542374, 15127.39490420415, 15177.848221517643, 15198.0, 23201.651975220724, 24400.389990250387, 24496.51006979886, 24866.875665621556, 24884.129055482972, 18170.90914545419, 18246.908765456086, 18904.621907562047, 19303.4208973731, 19337.226510939407, 13187.67030824237, 13669.658258543615, 14118.717625647634, 14373.64065898361, 14625.707485850437, 19045.90477047606, 19254.903725481283, 19359.225630974604, 19413.51466213356, 19456.513587160433, 15015.798736100867, 15125.092494450368, 15174.772378414113, 15247.695046098794, 15309.23453827282, 17777.28890844352, 18809.341673041377, 18988.810111898703, 19019.239230430627, 19592.706109408657], "value": 12495.991487078234, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.2032160382169, 1370.6573356660836, 1400.7268582626386, 1409.1826740490517, 1410.308948615179, 13803.65490862729, 14024.71950560988, 14262.928685356572, 14470.0, 14478.927605361985, 14433.278336083207, 14667.0, 14680.119192848437, 14747.336369863355, 14749.410023599043, 2677.678678558571, 2722.2377734234447, 2722.754952054315, 2723.0, 2724.4687285979244, 2677.4511225198885, 2799.230211691791, 2800.915972520828, 2808.0593001344573, 2808.199663096018, 2633.4338117304774, 2650.045983445958, 2665.093868084851, 2675.4782817350624, 2682.1685277564015, 2595.441979974305, 2614.8431094134316, 2625.448655782288, 2625.9080932167376, 2629.290091675256, 2512.4095837478176, 2518.156417600106, 2520.558902192109, 2535.2521006303186, 2544.9618255726177, 13730.382132804049, 14082.436702531886, 14098.295085245696, 14109.082909610843, 14138.081024733463, 7580.355669768076, 7875.173106823759, 7904.407169462256, 7917.24786145321, 7925.88111178327, 5008.749562521859, 5065.848024559232, 5069.239614057884, 5142.408623008327, 5169.353830771153, 1833.6241070580631, 1833.8074502177212, 1846.8060853610311, 1883.4914573065332, 1890.1399863062275, 23198.0, 23207.3037808866, 23294.0, 23322.883385582965, 23382.415439614146, 6382.20222472191, 6617.702203400859, 6621.735130594819, 6764.526483146231, 6771.593704377753, 15798.842011579967, 15955.042697437959, 15958.1223032732, 15973.760393594106, 15995.760063599055, 7471.663775130132, 7574.848503029909, 7592.050993625797, 7647.502912310682, 7672.194419585975, 5829.183914252008, 5833.679147646835, 6122.051082082285, 6940.7223711052, 7044.260352662896, 4936.7284799336385, 5092.745362731923, 5103.7192954387865, 5184.196449550326, 5195.7142357170715, 1445.8771004464527, 1467.9266036698123, 1476.534891509171, 1493.16382825618, 1514.2504460292225, 832.2634468495426, 836.9455985360933, 848.5375470368664, 858.6436628799104, 872.2585802068191, 6496.837579060561, 6594.0, 6909.136357955255, 6959.269276725972, 7040.577565346096, 667.519386042049, 689.8413364926095, 707.359839345383, 714.0610097721479, 723.6851969393331, 4502.819887204475, 4760.523947605281, 4785.784639691222, 5147.948520514822, 5248.868778280574, 18766.530836728918, 18924.90537547331, 19127.80872191288, 19327.130279137473, 19454.0, 18792.248310067716, 18952.52618684544, 19062.523436914187, 19181.177788110108, 19242.903785480983, 10206.38761674287, 10896.346219226873, 10939.12487001038, 11036.11711063113, 11052.944735276273, 7834.4907581007055, 7885.960570197112, 8045.758627241192, 8104.83790324202, 8131.7560473185895, 15534.145621990447, 16483.91758041202, 16583.336666533687, 16664.66670666604, 17220.74168887493, 16256.837431625532, 16647.50057498277, 17109.230084645973, 17372.0, 17550.648987020442, 10831.404272765074, 11035.0, 11181.385023823443, 11183.664490065312, 11555.133364997828, 13210.735785284432, 13243.404046817725, 13255.933720331337, 13373.06388552792, 13377.732445350845, 9597.280203984868, 9733.464659443798, 10012.949935250277, 10160.23798215122, 10199.286049976727, 9628.518574071128, 10003.649872254728, 10015.599376024877, 10414.375137491472, 10508.054275115277, 8947.328950328882, 8970.686025989058, 9015.639374424949, 9017.188453039258, 9025.774355641162, 6662.300458451793, 6814.557053791487, 6858.41703455192, 6880.243173251039, 6919.065926099912, 6455.9677201613695, 6699.464042876656, 6715.664216789043, 6824.0, 7003.824904377431], "value": 6223.615946252503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.963397597094, 510.8978204359128, 519.8856251624643, 526.0058489454931, 526.9604779641528, 6214.378562143789, 6241.812745617627, 6256.436920677138, 6279.905801412977, 6335.683215839201, 5899.351071382144, 6116.174316467275, 6118.357572454895, 6138.232720909887, 6143.8771224575485, 4880.8047678092835, 4900.64768910923, 4942.332785074005, 4975.502449755032, 4990.850274491771, 4902.779374928119, 4916.50834916509, 4922.55696987271, 4958.652894297401, 4990.326305948705, 4755.3104799804005, 4858.1539015174185, 4889.511048895118, 4903.53416425439, 4975.502449755014, 4856.927146092794, 4925.408950925912, 4942.085714142895, 4974.726390048546, 4986.950130498685, 4402.2296098183015, 4429.0, 4449.777511124463, 4453.153900758845, 4454.109178164348, 6027.065804800263, 6076.787312444088, 6089.330173680892, 6130.29501607312, 6161.7227224775, 5671.177679236487, 5691.544676425876, 5700.344460387067, 5721.6853073080965, 5737.254156959611, 6348.857205702971, 6393.939848196429, 6413.230412350501, 6514.250861150981, 6551.0, 4845.466998630148, 4846.5638092571835, 4854.902901941977, 4860.246661767396, 4884.658073934826, 6918.723251069951, 6950.478714096463, 6964.338387853146, 6979.651017449158, 7021.22766495685, 5025.221090730943, 5029.220470826955, 5032.572231360302, 5053.343065401475, 5058.291839142523, 4988.35151430319, 5002.774875130628, 5044.924326135111, 5098.796048158107, 5107.642465027487, 5698.82903512887, 5709.571782116358, 5736.397678243808, 5758.424157584208, 5759.568032397587, 6581.308962558958, 6613.735450582019, 6669.166354205724, 6674.933250667431, 6703.262641109474, 1663.2847875413447, 1706.3601149568913, 1710.4441056656387, 1748.160882776249, 1767.2754170789915, 1187.4062968515743, 1219.9573014944613, 1229.8032314829584, 1239.2812168941991, 1242.136714983078, 5750.987154495893, 5753.482186603226, 5775.0, 5800.53595712342, 5819.53443724501, 6568.883289840738, 6589.143411356493, 6714.160729908762, 6717.6977036033495, 6734.427573656196, 5727.885442291131, 5731.369549349568, 5771.740271687784, 5773.5958482906635, 5805.88388232233, 3588.102974256436, 3607.4769158471877, 3608.350496910581, 3640.817959102087, 3647.3070116677745, 6501.1548498694865, 6534.705938232696, 6572.671366431659, 6589.17635295588, 6632.303608121174, 6881.41507971818, 6892.1735740028935, 6955.0, 6974.825629359307, 6986.336298051677, 6564.949608062782, 6590.6932573599815, 6622.0, 6637.601743895381, 6640.269570347258, 6783.4573234142135, 6797.25230224665, 6797.64047190554, 6813.727450901908, 6814.352636499525, 6636.43590294811, 6646.966765166143, 6676.232233293234, 6678.298778628368, 6729.629870357177, 6453.580517266362, 6461.61230326182, 6472.0, 6478.870422591616, 6583.44040756541, 4910.950890491193, 4964.63112461032, 4984.950150498594, 4990.126727822689, 5036.118679231046, 6666.766663166766, 6723.865522689616, 6741.258461569126, 6791.320867913169, 6795.45636349081, 6418.293987661447, 6460.806175814733, 6505.60966342021, 6505.772297969548, 6586.571872828251, 6446.5165112615805, 6457.6771161442675, 6539.6403197824575, 6542.476601871744, 6545.770898018546, 6143.477804386498, 6210.8572542472775, 6315.873682526232, 6401.42387185137, 6463.676816159267, 6452.032195170762, 6485.605594797141, 6513.641749703812, 6557.9344206557325, 6583.572067815577, 6256.280527739186, 6303.46420554258, 6314.526410519321, 6322.810315690536, 6353.252855464784], "value": 5049.689928499204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.202462721982, 893.0533634347591, 896.7802888292367, 897.5871099294325, 898.5417437107078, 16944.661106777872, 17677.646447071067, 17688.38090666825, 17775.64448711025, 17781.91109044453, 15028.323725432354, 16519.17404129795, 18409.81590184098, 19973.10121044553, 20117.195312187494, 998.2946215755312, 1022.8670272864517, 1023.7287118913457, 1023.7645341571443, 1025.08255111675, 1028.341861208827, 1030.479607798061, 1030.855680204772, 1031.5718976624692, 1034.2966782587837, 1003.7540802503397, 1042.593388578455, 1045.7699306152672, 1051.1590727418072, 1054.0355574649186, 1031.9019693129142, 1033.560736686905, 1036.507658862042, 1036.575004248262, 1036.585365853657, 760.6158889760635, 763.9732609358646, 764.6291548598925, 769.5036701327613, 770.2528547309101, 17949.551261218443, 18425.631487370312, 19581.510462238417, 19742.40772776819, 19779.307724229726, 20051.1979520819, 20422.0810063546, 20706.171753129856, 20929.372118836458, 20946.371608851758, 15425.922870385688, 15665.373385064584, 15884.761728573965, 16017.798665100048, 16021.0, 3494.9126271843406, 3531.276088401897, 3539.8938031859084, 3542.734294927891, 3547.130952916526, 124296.0, 126818.36590816987, 130726.0, 131590.3420482901, 133228.3338583301, 15700.293486793122, 16053.919730401274, 16102.677946441005, 16203.594910127105, 16397.836021639632, 28364.290892727848, 30274.394512109633, 30279.848600756854, 30680.232994175323, 30687.539686904714, 8366.916330836613, 8587.613557389932, 8607.526586037702, 8610.095939926343, 8629.956850215709, 3921.568627450978, 3983.063979964706, 3998.980005099956, 4032.395140728914, 4033.6369726724147, 4872.756362181876, 5106.668066575735, 5159.071367153948, 5163.561097306696, 5180.456052114474, 992.369845148336, 1014.3254735600743, 1014.624588902111, 1033.1012019543045, 1034.886162522122, 659.2221179008816, 662.211967758366, 687.1547995964991, 694.9826254343682, 698.769406095987, 10931.508082136323, 11681.532738690357, 11992.64022079339, 12013.87986120145, 12218.0, 609.2445367744054, 619.5693992675137, 627.9120923070774, 636.5162476517879, 642.9710663020176, 5269.657472264367, 5315.760790764425, 5333.359996800331, 5467.6719396836315, 5701.828945131652, 94955.0, 95710.0, 99246.0, 100447.0, 103307.48346258371, 84226.57886710527, 88731.0, 89047.0, 89123.0, 91777.0, 75253.87119193216, 75366.0, 78568.607156965, 79231.60384198157, 79233.60383198163, 11861.169718119994, 11995.40022998864, 12164.695882603006, 12603.74792504163, 12662.366881656064, 34109.97670069902, 34611.0, 35003.47494787529, 35762.64237357593, 36014.09964750902, 41640.95897602584, 44663.55336446724, 44857.327140092275, 46277.53722462867, 67209.32790672226, 16335.0, 17185.570360741083, 17869.821301786815, 17897.910510447364, 17903.46289611314, 19056.04719764034, 19188.616227675648, 19211.807881921002, 19286.61426771485, 19530.60938781188, 18531.90734046321, 18552.907235463736, 18672.346467873558, 18696.439106826816, 18970.905145474186, 14780.18708970974, 15127.621809454851, 15230.46693365727, 15277.694446111238, 16554.17229138514, 17325.740113898555, 17955.910220448815, 17971.73042404391, 18111.637767244843, 18170.81829181691, 11379.260348077349, 11472.196946213686, 11855.17013809025, 12071.275723456622, 12313.645498994923, 11939.447871776614, 12296.754064918472, 13094.476220951055, 13284.468621255042, 14069.366878490697], "value": 8681.17894442311, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 104.0, 108.0, 110.0, 111.0, 110.0, 100.0, 107.0, 109.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 151.0, 186.0, 121.0, 145.0, 155.0, 118.0, 176.0, 117.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 164.0, 169.0, 161.0, 164.0, 163.0, 165.0, 164.0, 161.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 164.0, 77.0, 78.0, 75.0, 74.0, 150.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 132.0, 79.0, 81.0, 78.0, 133.0, 80.0, 78.0, 126.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 114.0, 114.0, 116.0, 114.0, 114.0, 115.0, 118.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 151.0, 151.0, 150.0, 149.0, 152.0, 154.0, 157.0, 149.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 98.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 69.0, 57.0, 61.0, 57.0, 57.0, 58.0, 60.0, 57.0, 61.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 66.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 79.0, 94.0, 79.0, 81.0, 88.0, 90.0, 78.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 132.0, 133.0, 127.0, 125.0, 140.0, 125.0, 147.0, 172.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 184.0, 181.0, 185.0, 182.0, 187.0, 186.0, 181.0, 194.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 67.0, 67.0, 65.0, 73.0, 73.0, 68.0, 68.0], "value": 67.9, "unit": "score"}]}]} 03:18:18 INFO - Return code: 0 03:18:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:18 INFO - # TBPL SUCCESS # 03:18:18 INFO - Running post-action listener: _package_coverage_data 03:18:18 INFO - Running post-action listener: _resource_record_post_action 03:18:18 INFO - [mozharness: 2017-07-31 10:18:18.528567Z] Finished run-tests step (success) 03:18:18 INFO - Running post-run listener: _resource_record_post_run 03:18:18 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 6348800; Write bytes: 450318336; Read time: 3360; Write time: 652644 03:18:18 INFO - TinderboxPrint: CPU usage
13.2% 03:18:18 INFO - TinderboxPrint: I/O read bytes / time
6,348,800 / 3,360 03:18:18 INFO - TinderboxPrint: I/O write bytes / time
450,318,336 / 652,644 03:18:18 INFO - TinderboxPrint: CPU idle
8,318.6 (86.8%) 03:18:18 INFO - TinderboxPrint: CPU user
1,205.6 (12.6%) 03:18:18 INFO - TinderboxPrint: Swap in / out
0 / 0 03:18:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120180736; Read time: 0; Write time: 170800 03:18:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:18:18 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 3850240; Write bytes: 330137600; Read time: 2884; Write time: 481844 03:18:19 INFO - Running post-run listener: _upload_blobber_files 03:18:19 INFO - Blob upload gear active. 03:18:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:18:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:20 INFO - (blobuploader) - INFO - Done attempting. 03:18:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:27 INFO - (blobuploader) - INFO - Done attempting. 03:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:28 INFO - (blobuploader) - INFO - Done attempting. 03:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:29 INFO - (blobuploader) - INFO - Done attempting. 03:18:29 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:29 INFO - Return code: 0 03:18:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2224746170e1f38d968149c7c02370b7ed8793921081169342f6d5af86d7420a62f4da5aa6f28ff5372afcd1472540b4e9c7323f92f008868fb1dcec8b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7977390d967c7333ad524e56194ca6cc33aa5ed34299d203b9fca72828ffbc277e0caaf862ef89d087ab2f8329515ca81a3e83ba1d5d58dab960d4383bf42edf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dcc83714297fb9522d2113a7180af6547586bcdd68b1b52ead02bd00c71105f4fb3cfa13a34641a3170914be1756c74c6cc723eb42af23ae7d7f34e23070cd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbba0434276c3a6180f1defdb63cfd65c28bd6af6dc7a0a2c3ced6f88196ee60377c7e7a6c96e24edee1c18a30160f85ba69d13648cd9d3c05098886f035383"} 03:18:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:29 INFO - Contents: 03:18:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2224746170e1f38d968149c7c02370b7ed8793921081169342f6d5af86d7420a62f4da5aa6f28ff5372afcd1472540b4e9c7323f92f008868fb1dcec8b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7977390d967c7333ad524e56194ca6cc33aa5ed34299d203b9fca72828ffbc277e0caaf862ef89d087ab2f8329515ca81a3e83ba1d5d58dab960d4383bf42edf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dcc83714297fb9522d2113a7180af6547586bcdd68b1b52ead02bd00c71105f4fb3cfa13a34641a3170914be1756c74c6cc723eb42af23ae7d7f34e23070cd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbba0434276c3a6180f1defdb63cfd65c28bd6af6dc7a0a2c3ced6f88196ee60377c7e7a6c96e24edee1c18a30160f85ba69d13648cd9d3c05098886f035383"} 03:18:29 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:29 INFO - Copying logs to upload dir... 03:18:29 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.800435 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-31 03:18:29.563508) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:18:29.570733) ========= 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=ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2224746170e1f38d968149c7c02370b7ed8793921081169342f6d5af86d7420a62f4da5aa6f28ff5372afcd1472540b4e9c7323f92f008868fb1dcec8b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7977390d967c7333ad524e56194ca6cc33aa5ed34299d203b9fca72828ffbc277e0caaf862ef89d087ab2f8329515ca81a3e83ba1d5d58dab960d4383bf42edf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dcc83714297fb9522d2113a7180af6547586bcdd68b1b52ead02bd00c71105f4fb3cfa13a34641a3170914be1756c74c6cc723eb42af23ae7d7f34e23070cd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbba0434276c3a6180f1defdb63cfd65c28bd6af6dc7a0a2c3ced6f88196ee60377c7e7a6c96e24edee1c18a30160f85ba69d13648cd9d3c05098886f035383"} build_url:https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/OypQKKTlTgyj1Ao4ZC_kMg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a2224746170e1f38d968149c7c02370b7ed8793921081169342f6d5af86d7420a62f4da5aa6f28ff5372afcd1472540b4e9c7323f92f008868fb1dcec8b7961", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7977390d967c7333ad524e56194ca6cc33aa5ed34299d203b9fca72828ffbc277e0caaf862ef89d087ab2f8329515ca81a3e83ba1d5d58dab960d4383bf42edf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dcc83714297fb9522d2113a7180af6547586bcdd68b1b52ead02bd00c71105f4fb3cfa13a34641a3170914be1756c74c6cc723eb42af23ae7d7f34e23070cd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbba0434276c3a6180f1defdb63cfd65c28bd6af6dc7a0a2c3ced6f88196ee60377c7e7a6c96e24edee1c18a30160f85ba69d13648cd9d3c05098886f035383"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 03:18:29.595353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:18:29.595671) ========= 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=ea65d483da93c827905c2090000001f5-1501494071.542699-1486518905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 03:18:29.681227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:18:29.681536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 03:18:29.681816) ========= ========= Total master_lag: 0.19 =========