builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1502706450.97 results: success (0) revision: 87ae6494d5b1fff0b2cd388c6d639e29f438fe77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:30.973751) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:30.974136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:30.974429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:31.003913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:31.004190) ========= 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=cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 03:27:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-08-14 03:27:31 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.069479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:31.087563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:31.087848) ========= 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=cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016891 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:31.144051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:31.144350) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 87ae6494d5b1fff0b2cd388c6d639e29f438fe77 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 87ae6494d5b1fff0b2cd388c6d639e29f438fe77 --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=cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 03:27:32,035 truncating revision to first 12 chars 2017-08-14 03:27:32,035 Setting DEBUG logging. 2017-08-14 03:27:32,035 attempt 1/10 2017-08-14 03:27:32,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/87ae6494d5b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 03:27:32,650 unpacking tar archive at: mozilla-beta-87ae6494d5b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921369 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:32.078612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:32.078913) ========= script_repo_revision: 87ae6494d5b1fff0b2cd388c6d639e29f438fe77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:32.079273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:32.079567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:27:32.089321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-14 03:27:32.089597) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:33 INFO - MultiFileLogger online at 20170814 03:27:33 in /builds/slave/test 03:27:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 03:27:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:33 INFO - {'append_to_log': False, 03:27:33 INFO - 'base_work_dir': '/builds/slave/test', 03:27:33 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 03:27:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:33 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 03:27:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:33 INFO - 'code_coverage': False, 03:27:33 INFO - 'config_files': ('talos/linux_config.py',), 03:27:33 INFO - 'default_actions': ('clobber', 03:27:33 INFO - 'read-buildbot-config', 03:27:33 INFO - 'download-and-extract', 03:27:33 INFO - 'populate-webroot', 03:27:33 INFO - 'create-virtualenv', 03:27:33 INFO - 'install', 03:27:33 INFO - 'setup-mitmproxy', 03:27:33 INFO - 'run-tests'), 03:27:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:33 INFO - 'disable_ccov_upload': False, 03:27:33 INFO - 'download_minidump_stackwalk': True, 03:27:33 INFO - 'download_symbols': 'ondemand', 03:27:33 INFO - 'enable_stylo': False, 03:27:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:33 INFO - 'gecko_profile': False, 03:27:33 INFO - 'gecko_profile_interval': 0, 03:27:33 INFO - 'installer_path': 'installer.exe', 03:27:33 INFO - 'log_level': 'info', 03:27:33 INFO - 'log_name': 'talos', 03:27:33 INFO - 'log_to_console': True, 03:27:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:33 INFO - 'opt_config_files': (), 03:27:33 INFO - 'pip_index': False, 03:27:33 INFO - 'suite': 'dromaeojs-e10s', 03:27:33 INFO - 'system_bits': '32', 03:27:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:33 INFO - 'title': 'talos-linux64-ix-054', 03:27:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:33 INFO - 'use_talos_json': True, 03:27:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:33 INFO - 'work_dir': 'build'} 03:27:33 INFO - [mozharness: 2017-08-14 10:27:33.083065Z] Running clobber step. 03:27:33 INFO - Running pre-action listener: _resource_record_pre_action 03:27:33 INFO - Running main action method: clobber 03:27:33 INFO - rmtree: /builds/slave/test/build 03:27:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:34 INFO - Running post-action listener: _resource_record_post_action 03:27:34 INFO - [mozharness: 2017-08-14 10:27:34.106477Z] Finished clobber step (success) 03:27:34 INFO - [mozharness: 2017-08-14 10:27:34.106579Z] Running read-buildbot-config step. 03:27:34 INFO - Running pre-action listener: _resource_record_pre_action 03:27:34 INFO - Running main action method: read_buildbot_config 03:27:34 INFO - Using buildbot properties: 03:27:34 INFO - { 03:27:34 INFO - "project": "", 03:27:34 INFO - "product": "firefox", 03:27:34 INFO - "who": "cmccormack@mozilla.com", 03:27:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:27:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:27:34 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 03:27:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 03:27:34 INFO - "stage_platform": "linux64", 03:27:34 INFO - "basedir": "/builds/slave/test", 03:27:34 INFO - "buildnumber": 47, 03:27:34 INFO - "platform": "ubuntu64_hw", 03:27:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:34 INFO - "slavebuilddir": "test", 03:27:34 INFO - "taskId": "DOlWqByUSqWWNIMQuJrqxQ", 03:27:34 INFO - "branch": "mozilla-beta", 03:27:34 INFO - "script_repo_revision": "production", 03:27:34 INFO - "revision": "87ae6494d5b1fff0b2cd388c6d639e29f438fe77", 03:27:34 INFO - "slavename": "talos-linux64-ix-054", 03:27:34 INFO - "repo_path": "releases/mozilla-beta" 03:27:34 INFO - } 03:27:34 INFO - Finding installer, test and symbols from parent task. 03:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOlWqByUSqWWNIMQuJrqxQ'}, attempt #1 03:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOlWqByUSqWWNIMQuJrqxQ'}, attempt #1 03:27:35 INFO - Task dependencies: DYz24zi9Svu_LePPR096jQ 03:27:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ'}, attempt #1 03:27:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2 03:27:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.test_packages.json 03:27:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.crashreporter-symbols.zip 03:27:35 INFO - Running post-action listener: _resource_record_post_action 03:27:35 INFO - [mozharness: 2017-08-14 10:27:35.455379Z] Finished read-buildbot-config step (success) 03:27:35 INFO - [mozharness: 2017-08-14 10:27:35.455602Z] Running download-and-extract step. 03:27:35 INFO - Running pre-action listener: _resource_record_pre_action 03:27:35 INFO - Running main action method: download_and_extract 03:27:35 INFO - mkdir: /builds/slave/test/build/tests 03:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:35 INFO - trying https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.test_packages.json 03:27:35 INFO - Downloading https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:27:36 INFO - Downloaded 989 bytes. 03:27:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:27:36 INFO - Using the following test package requirements: 03:27:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:27:36 INFO - u'common': [u'target.common.tests.zip'], 03:27:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:27:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:27:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:27:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:27:36 INFO - u'mozbase': [u'target.common.tests.zip'], 03:27:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:27:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:27:36 INFO - u'web-platform': [u'target.common.tests.zip', 03:27:36 INFO - u'target.web-platform.tests.tar.gz'], 03:27:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:27:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:27:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.common.tests.zip 03:27:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:36 INFO - Fetch https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.common.tests.zip into memory 03:27:38 INFO - Content-Length response header: 72826653 03:27:38 INFO - Bytes received: 72826653 03:27:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:27:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.common.tests.zip 03:27:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:49 INFO - Fetch https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.common.tests.zip into memory 03:27:51 INFO - Content-Length response header: 72826653 03:27:51 INFO - Bytes received: 72826653 03:28:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.talos.tests.zip 03:28:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:28:03 INFO - Fetch https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.talos.tests.zip into memory 03:28:04 INFO - Content-Length response header: 14496472 03:28:04 INFO - Bytes received: 14496472 03:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:04 INFO - trying https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2 03:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:28:06 INFO - Downloaded 53746347 bytes. 03:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2 03:28:06 INFO - mkdir: /builds/slave/test/properties 03:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:06 INFO - Contents: 03:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2 03:28:06 INFO - Running post-action listener: _resource_record_post_action 03:28:06 INFO - Running post-action listener: set_extra_try_arguments 03:28:06 INFO - [mozharness: 2017-08-14 10:28:06.049128Z] Finished download-and-extract step (success) 03:28:06 INFO - [mozharness: 2017-08-14 10:28:06.049227Z] Running populate-webroot step. 03:28:06 INFO - Running pre-action listener: _resource_record_pre_action 03:28:06 INFO - Running main action method: populate_webroot 03:28:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:28:06 INFO - 'tests': ['damp', 'tps']}, 03:28:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:28:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:28:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:28:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_many_windows', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:28:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:28:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:06 INFO - 'talos_options': ['--mitmproxy', 03:28:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:06 INFO - '--firstNonBlankPaint'], 03:28:06 INFO - 'tests': ['quantum_pageload_google', 03:28:06 INFO - 'quantum_pageload_youtube', 03:28:06 INFO - 'quantum_pageload_amazon', 03:28:06 INFO - 'quantum_pageload_facebook']}, 03:28:06 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:06 INFO - 'talos_options': ['--stylo', 03:28:06 INFO - '--mitmproxy', 03:28:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:06 INFO - '--firstNonBlankPaint'], 03:28:06 INFO - 'tests': ['quantum_pageload_google', 03:28:06 INFO - 'quantum_pageload_youtube', 03:28:06 INFO - 'quantum_pageload_amazon', 03:28:06 INFO - 'quantum_pageload_facebook']}, 03:28:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:06 INFO - 'tsvgr_opacity', 03:28:06 INFO - 'tart', 03:28:06 INFO - 'tscrollx', 03:28:06 INFO - 'cart', 03:28:06 INFO - 'tsvg_static']}, 03:28:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:28:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:06 INFO - 'talos_options': ['--stylo', 03:28:06 INFO - '--stylo-threads=1', 03:28:06 INFO - '--mitmproxy', 03:28:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:06 INFO - '--firstNonBlankPaint'], 03:28:06 INFO - 'tests': ['tp6_google', 03:28:06 INFO - 'tp6_youtube', 03:28:06 INFO - 'tp6_amazon', 03:28:06 INFO - 'tp6_facebook']}, 03:28:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:28:06 INFO - 'talos_options': ['--xperf_path', 03:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:06 INFO - 'tests': ['tp5n']}}} 03:28:06 INFO - Running post-action listener: _resource_record_post_action 03:28:06 INFO - [mozharness: 2017-08-14 10:28:06.057913Z] Finished populate-webroot step (success) 03:28:06 INFO - [mozharness: 2017-08-14 10:28:06.058004Z] Running create-virtualenv step. 03:28:06 INFO - Running pre-action listener: _resource_record_pre_action 03:28:06 INFO - Running main action method: create_virtualenv 03:28:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:28:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:28:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:06 INFO - Using real prefix '/usr' 03:28:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:08 INFO - Installing pip.................done. 03:28:08 INFO - Return code: 0 03:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:08 INFO - Reading from file tmpfile_stdout 03:28:08 INFO - Output received: 03:28:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:28:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:08 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:08 INFO - Using env: {'DISPLAY': ':0', 03:28:08 INFO - 'HOME': '/home/cltbld', 03:28:08 INFO - 'LANG': 'en_US.UTF-8', 03:28:08 INFO - 'LANGUAGE': 'en_US:en', 03:28:08 INFO - 'LOGNAME': 'cltbld', 03:28:08 INFO - 'MAIL': '/var/mail/cltbld', 03:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:08 INFO - 'MOZ_NO_REMOTE': '1', 03:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:08 INFO - 'NO_EM_RESTART': '1', 03:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:08 INFO - 'PWD': '/builds/slave/test', 03:28:08 INFO - 'SHELL': '/bin/bash', 03:28:08 INFO - 'SHLVL': '1', 03:28:08 INFO - 'TERM': 'linux', 03:28:08 INFO - 'TMOUT': '86400', 03:28:08 INFO - 'USER': 'cltbld', 03:28:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:08 INFO - '_': '/tools/buildbot/bin/python'} 03:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:28:09 INFO - Cleaning up... 03:28:09 INFO - Return code: 0 03:28:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:28:09 INFO - Using env: {'DISPLAY': ':0', 03:28:09 INFO - 'HOME': '/home/cltbld', 03:28:09 INFO - 'LANG': 'en_US.UTF-8', 03:28:09 INFO - 'LANGUAGE': 'en_US:en', 03:28:09 INFO - 'LOGNAME': 'cltbld', 03:28:09 INFO - 'MAIL': '/var/mail/cltbld', 03:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:09 INFO - 'MOZ_NO_REMOTE': '1', 03:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:09 INFO - 'NO_EM_RESTART': '1', 03:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:09 INFO - 'PWD': '/builds/slave/test', 03:28:09 INFO - 'SHELL': '/bin/bash', 03:28:09 INFO - 'SHLVL': '1', 03:28:09 INFO - 'TERM': 'linux', 03:28:09 INFO - 'TMOUT': '86400', 03:28:09 INFO - 'USER': 'cltbld', 03:28:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:09 INFO - '_': '/tools/buildbot/bin/python'} 03:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:09 INFO - Downloading/unpacking psutil>=3.1.1 03:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:10 INFO - Installing collected packages: psutil 03:28:10 INFO - Running setup.py install for psutil 03:28:10 INFO - building 'psutil._psutil_linux' extension 03:28:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:28:10 INFO - building 'psutil._psutil_posix' extension 03:28:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:28:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:10 INFO - Successfully installed psutil 03:28:10 INFO - Cleaning up... 03:28:10 INFO - Return code: 0 03:28:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:28:11 INFO - Using env: {'DISPLAY': ':0', 03:28:11 INFO - 'HOME': '/home/cltbld', 03:28:11 INFO - 'LANG': 'en_US.UTF-8', 03:28:11 INFO - 'LANGUAGE': 'en_US:en', 03:28:11 INFO - 'LOGNAME': 'cltbld', 03:28:11 INFO - 'MAIL': '/var/mail/cltbld', 03:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:11 INFO - 'MOZ_NO_REMOTE': '1', 03:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:11 INFO - 'NO_EM_RESTART': '1', 03:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:11 INFO - 'PWD': '/builds/slave/test', 03:28:11 INFO - 'SHELL': '/bin/bash', 03:28:11 INFO - 'SHLVL': '1', 03:28:11 INFO - 'TERM': 'linux', 03:28:11 INFO - 'TMOUT': '86400', 03:28:11 INFO - 'USER': 'cltbld', 03:28:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:11 INFO - '_': '/tools/buildbot/bin/python'} 03:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28: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 03:28: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 03:28: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 03:28: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 03:28:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:12 INFO - Installing collected packages: mozsystemmonitor 03:28:12 INFO - Running setup.py install for mozsystemmonitor 03:28:12 INFO - Successfully installed mozsystemmonitor 03:28:12 INFO - Cleaning up... 03:28:12 INFO - Return code: 0 03:28:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:12 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:28:12 INFO - Using env: {'DISPLAY': ':0', 03:28:12 INFO - 'HOME': '/home/cltbld', 03:28:12 INFO - 'LANG': 'en_US.UTF-8', 03:28:12 INFO - 'LANGUAGE': 'en_US:en', 03:28:12 INFO - 'LOGNAME': 'cltbld', 03:28:12 INFO - 'MAIL': '/var/mail/cltbld', 03:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:12 INFO - 'MOZ_NO_REMOTE': '1', 03:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:12 INFO - 'NO_EM_RESTART': '1', 03:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:12 INFO - 'PWD': '/builds/slave/test', 03:28:12 INFO - 'SHELL': '/bin/bash', 03:28:12 INFO - 'SHLVL': '1', 03:28:12 INFO - 'TERM': 'linux', 03:28:12 INFO - 'TMOUT': '86400', 03:28:12 INFO - 'USER': 'cltbld', 03:28:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:12 INFO - '_': '/tools/buildbot/bin/python'} 03:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:12 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28: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 03:28: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 03:28: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 03:28: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 03:28:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:13 INFO - warning: no files found matching '*.txt' 03:28:13 INFO - no previously-included directories found matching 'build' 03:28:13 INFO - no previously-included directories found matching 'dist' 03:28:13 INFO - no previously-included directories found matching '.git*' 03:28:13 INFO - Installing collected packages: jsonschema, functools32 03:28:14 INFO - Running setup.py install for functools32 03:28:14 INFO - warning: no files found matching '*.txt' 03:28:14 INFO - no previously-included directories found matching 'build' 03:28:14 INFO - no previously-included directories found matching 'dist' 03:28:14 INFO - no previously-included directories found matching '.git*' 03:28:14 INFO - Successfully installed jsonschema functools32 03:28:14 INFO - Cleaning up... 03:28:14 INFO - Return code: 0 03:28:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:14 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:28:14 INFO - Using env: {'DISPLAY': ':0', 03:28:14 INFO - 'HOME': '/home/cltbld', 03:28:14 INFO - 'LANG': 'en_US.UTF-8', 03:28:14 INFO - 'LANGUAGE': 'en_US:en', 03:28:14 INFO - 'LOGNAME': 'cltbld', 03:28:14 INFO - 'MAIL': '/var/mail/cltbld', 03:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:14 INFO - 'MOZ_NO_REMOTE': '1', 03:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:14 INFO - 'NO_EM_RESTART': '1', 03:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:14 INFO - 'PWD': '/builds/slave/test', 03:28:14 INFO - 'SHELL': '/bin/bash', 03:28:14 INFO - 'SHLVL': '1', 03:28:14 INFO - 'TERM': 'linux', 03:28:14 INFO - 'TMOUT': '86400', 03:28:14 INFO - 'USER': 'cltbld', 03:28:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:14 INFO - '_': '/tools/buildbot/bin/python'} 03:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:28:14 INFO - Cleaning up... 03:28:14 INFO - Return code: 0 03:28:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:14 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:28:14 INFO - Using env: {'DISPLAY': ':0', 03:28:14 INFO - 'HOME': '/home/cltbld', 03:28:14 INFO - 'LANG': 'en_US.UTF-8', 03:28:14 INFO - 'LANGUAGE': 'en_US:en', 03:28:14 INFO - 'LOGNAME': 'cltbld', 03:28:14 INFO - 'MAIL': '/var/mail/cltbld', 03:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:14 INFO - 'MOZ_NO_REMOTE': '1', 03:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:14 INFO - 'NO_EM_RESTART': '1', 03:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:14 INFO - 'PWD': '/builds/slave/test', 03:28:14 INFO - 'SHELL': '/bin/bash', 03:28:14 INFO - 'SHLVL': '1', 03:28:14 INFO - 'TERM': 'linux', 03:28:14 INFO - 'TMOUT': '86400', 03:28:14 INFO - 'USER': 'cltbld', 03:28:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:14 INFO - '_': '/tools/buildbot/bin/python'} 03:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:16 INFO - Downloading docopt-0.6.1.tar.gz 03:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:16 INFO - Running setup.py install for blobuploader 03:28:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:16 INFO - Running setup.py install for requests 03:28:16 INFO - Running setup.py install for docopt 03:28:16 INFO - Successfully installed blobuploader requests docopt 03:28:16 INFO - Cleaning up... 03:28:16 INFO - Return code: 0 03:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:16 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:16 INFO - Using env: {'DISPLAY': ':0', 03:28:16 INFO - 'HOME': '/home/cltbld', 03:28:16 INFO - 'LANG': 'en_US.UTF-8', 03:28:16 INFO - 'LANGUAGE': 'en_US:en', 03:28:16 INFO - 'LOGNAME': 'cltbld', 03:28:16 INFO - 'MAIL': '/var/mail/cltbld', 03:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:16 INFO - 'MOZ_NO_REMOTE': '1', 03:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:16 INFO - 'NO_EM_RESTART': '1', 03:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:16 INFO - 'PWD': '/builds/slave/test', 03:28:16 INFO - 'SHELL': '/bin/bash', 03:28:16 INFO - 'SHLVL': '1', 03:28:16 INFO - 'TERM': 'linux', 03:28:16 INFO - 'TMOUT': '86400', 03:28:16 INFO - 'USER': 'cltbld', 03:28:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:16 INFO - '_': '/tools/buildbot/bin/python'} 03:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:17 INFO - Running setup.py (path:/tmp/pip-vRtnV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:17 INFO - Running setup.py (path:/tmp/pip-U0V6eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:17 INFO - Running setup.py (path:/tmp/pip-LUvNvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:17 INFO - Running setup.py (path:/tmp/pip-PS0XhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:17 INFO - Running setup.py (path:/tmp/pip-ZaNwqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:17 INFO - Running setup.py (path:/tmp/pip-wfmMYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:17 INFO - Running setup.py (path:/tmp/pip-UXcf2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:17 INFO - Running setup.py (path:/tmp/pip-coRTdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:17 INFO - Running setup.py (path:/tmp/pip-EjCMmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:17 INFO - Running setup.py (path:/tmp/pip-obd1ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:17 INFO - Running setup.py (path:/tmp/pip-kh1cI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:17 INFO - Running setup.py (path:/tmp/pip-XClqpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:18 INFO - Running setup.py (path:/tmp/pip-xCohqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:18 INFO - Running setup.py (path:/tmp/pip-qQOWaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:18 INFO - Running setup.py (path:/tmp/pip-r84WDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:18 INFO - Running setup.py (path:/tmp/pip-QSN84l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:18 INFO - Running setup.py (path:/tmp/pip-XhDPSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:18 INFO - Running setup.py install for manifestparser 03:28:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:18 INFO - Running setup.py install for mozcrash 03:28:18 INFO - Running setup.py install for mozdebug 03:28:18 INFO - Running setup.py install for mozdevice 03:28:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:18 INFO - Running setup.py install for mozfile 03:28:18 INFO - Running setup.py install for mozhttpd 03:28:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:18 INFO - Running setup.py install for mozinfo 03:28:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Running setup.py install for mozInstall 03:28:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Running setup.py install for mozleak 03:28:19 INFO - Running setup.py install for mozlog 03:28:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Running setup.py install for moznetwork 03:28:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Running setup.py install for mozprocess 03:28:19 INFO - Running setup.py install for mozprofile 03:28:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Running setup.py install for mozrunner 03:28:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:19 INFO - Running setup.py install for mozscreenshot 03:28:19 INFO - Running setup.py install for moztest 03:28:20 INFO - Running setup.py install for mozversion 03:28:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:20 INFO - Cleaning up... 03:28:20 INFO - Return code: 0 03:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:20 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:20 INFO - Using env: {'DISPLAY': ':0', 03:28:20 INFO - 'HOME': '/home/cltbld', 03:28:20 INFO - 'LANG': 'en_US.UTF-8', 03:28:20 INFO - 'LANGUAGE': 'en_US:en', 03:28:20 INFO - 'LOGNAME': 'cltbld', 03:28:20 INFO - 'MAIL': '/var/mail/cltbld', 03:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:20 INFO - 'MOZ_NO_REMOTE': '1', 03:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:20 INFO - 'NO_EM_RESTART': '1', 03:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:20 INFO - 'PWD': '/builds/slave/test', 03:28:20 INFO - 'SHELL': '/bin/bash', 03:28:20 INFO - 'SHLVL': '1', 03:28:20 INFO - 'TERM': 'linux', 03:28:20 INFO - 'TMOUT': '86400', 03:28:20 INFO - 'USER': 'cltbld', 03:28:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:20 INFO - '_': '/tools/buildbot/bin/python'} 03:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:20 INFO - Running setup.py (path:/tmp/pip-GyRDCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:20 INFO - Running setup.py (path:/tmp/pip-bnq8JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:20 INFO - Running setup.py (path:/tmp/pip-ZqYsTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:20 INFO - Running setup.py (path:/tmp/pip-6iC12J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:20 INFO - Running setup.py (path:/tmp/pip-5aWPn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:20 INFO - Running setup.py (path:/tmp/pip-MFqjQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:20 INFO - Running setup.py (path:/tmp/pip-lKZKw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:20 INFO - Running setup.py (path:/tmp/pip-Fi0Vu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:20 INFO - Running setup.py (path:/tmp/pip-pcq7BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:21 INFO - Running setup.py (path:/tmp/pip-3ng797-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:21 INFO - Running setup.py (path:/tmp/pip-DHA4xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:21 INFO - Running setup.py (path:/tmp/pip-JrrYvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:21 INFO - Running setup.py (path:/tmp/pip-RZ50Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:21 INFO - Running setup.py (path:/tmp/pip-uJYZwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:21 INFO - Running setup.py (path:/tmp/pip-BhLjTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:21 INFO - Running setup.py (path:/tmp/pip-udAKw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:21 INFO - Running setup.py (path:/tmp/pip-E0aFq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:22 INFO - Downloading blessings-1.6.tar.gz 03:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:22 INFO - Installing collected packages: blessings 03:28:22 INFO - Running setup.py install for blessings 03:28:22 INFO - Successfully installed blessings 03:28:22 INFO - Cleaning up... 03:28:22 INFO - Return code: 0 03:28:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:23 INFO - Reading from file tmpfile_stdout 03:28:23 INFO - Current package versions: 03:28:23 INFO - argparse == 1.2.1 03:28:23 INFO - blessings == 1.6 03:28:23 INFO - blobuploader == 1.2.4 03:28:23 INFO - docopt == 0.6.1 03:28:23 INFO - functools32 == 3.2.3-2 03:28:23 INFO - jsonschema == 2.5.1 03:28:23 INFO - manifestparser == 1.1 03:28:23 INFO - mozInstall == 1.13 03:28:23 INFO - mozcrash == 1.0 03:28:23 INFO - mozdebug == 0.1 03:28:23 INFO - mozdevice == 0.51 03:28:23 INFO - mozfile == 1.2 03:28:23 INFO - mozhttpd == 0.7 03:28:23 INFO - mozinfo == 0.10 03:28:23 INFO - mozleak == 0.1 03:28:23 INFO - mozlog == 3.5 03:28:23 INFO - moznetwork == 0.27 03:28:23 INFO - mozprocess == 0.25 03:28:23 INFO - mozprofile == 0.28 03:28:23 INFO - mozrunner == 6.13 03:28:23 INFO - mozscreenshot == 0.1 03:28:23 INFO - mozsystemmonitor == 0.3 03:28:23 INFO - moztest == 0.8 03:28:23 INFO - mozversion == 1.4 03:28:23 INFO - psutil == 3.1.1 03:28:23 INFO - requests == 1.2.3 03:28:23 INFO - wsgiref == 0.1.2 03:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:23 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:23 INFO - Using env: {'DISPLAY': ':0', 03:28:23 INFO - 'HOME': '/home/cltbld', 03:28:23 INFO - 'LANG': 'en_US.UTF-8', 03:28:23 INFO - 'LANGUAGE': 'en_US:en', 03:28:23 INFO - 'LOGNAME': 'cltbld', 03:28:23 INFO - 'MAIL': '/var/mail/cltbld', 03:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:23 INFO - 'MOZ_NO_REMOTE': '1', 03:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:23 INFO - 'NO_EM_RESTART': '1', 03:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:23 INFO - 'PWD': '/builds/slave/test', 03:28:23 INFO - 'SHELL': '/bin/bash', 03:28:23 INFO - 'SHLVL': '1', 03:28:23 INFO - 'TERM': 'linux', 03:28:23 INFO - 'TMOUT': '86400', 03:28:23 INFO - 'USER': 'cltbld', 03:28:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:23 INFO - '_': '/tools/buildbot/bin/python'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:24 INFO - Installing collected packages: simplejson 03:28:24 INFO - Running setup.py install for simplejson 03:28:24 INFO - building 'simplejson._speedups' extension 03:28:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:28:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:28:25 INFO - Successfully installed simplejson 03:28:25 INFO - Cleaning up... 03:28:25 INFO - Return code: 0 03:28:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:25 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 0x1ae71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e56eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, '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': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:28:25 INFO - Using env: {'DISPLAY': ':0', 03:28:25 INFO - 'HOME': '/home/cltbld', 03:28:25 INFO - 'LANG': 'en_US.UTF-8', 03:28:25 INFO - 'LANGUAGE': 'en_US:en', 03:28:25 INFO - 'LOGNAME': 'cltbld', 03:28:25 INFO - 'MAIL': '/var/mail/cltbld', 03:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:25 INFO - 'MOZ_NO_REMOTE': '1', 03:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:25 INFO - 'NO_EM_RESTART': '1', 03:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:25 INFO - 'PWD': '/builds/slave/test', 03:28:25 INFO - 'SHELL': '/bin/bash', 03:28:25 INFO - 'SHLVL': '1', 03:28:25 INFO - 'TERM': 'linux', 03:28:25 INFO - 'TMOUT': '86400', 03:28:25 INFO - 'USER': 'cltbld', 03:28:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:25 INFO - '_': '/tools/buildbot/bin/python'} 03:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:25 INFO - Cleaning up... 03:28:25 INFO - Return code: 0 03:28:25 INFO - Running post-action listener: _resource_record_post_action 03:28:25 INFO - Running post-action listener: _start_resource_monitoring 03:28:25 INFO - Starting resource monitoring. 03:28:25 INFO - [mozharness: 2017-08-14 10:28:25.824745Z] Finished create-virtualenv step (success) 03:28:25 INFO - [mozharness: 2017-08-14 10:28:25.825268Z] Running install step. 03:28:25 INFO - Running pre-action listener: _resource_record_pre_action 03:28:25 INFO - Running main action method: install 03:28:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:26 INFO - Reading from file tmpfile_stdout 03:28:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:26 INFO - Reading from file tmpfile_stdout 03:28:26 INFO - Output received: 03:28:26 INFO - Usage: mozinstall [options] installer 03:28:26 INFO - Options: 03:28:26 INFO - -h, --help show this help message and exit 03:28:26 INFO - -d DEST, --destination=DEST 03:28:26 INFO - Directory to install application into. [default: 03:28:26 INFO - "/builds/slave/test"] 03:28:26 INFO - --app=APP Application being installed. [default: firefox] 03:28:26 INFO - mkdir: /builds/slave/test/build/application 03:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:28:40 INFO - Reading from file tmpfile_stdout 03:28:40 INFO - Output received: 03:28:40 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:40 INFO - Running post-action listener: _resource_record_post_action 03:28:40 INFO - [mozharness: 2017-08-14 10:28:40.827787Z] Finished install step (success) 03:28:40 INFO - [mozharness: 2017-08-14 10:28:40.828040Z] Running setup-mitmproxy step. 03:28:40 INFO - Running pre-action listener: _resource_record_pre_action 03:28:40 INFO - Running main action method: setup_mitmproxy 03:28:40 INFO - Skipping: mitmproxy is not required 03:28:40 INFO - Running post-action listener: _resource_record_post_action 03:28:40 INFO - [mozharness: 2017-08-14 10:28:40.829242Z] Finished setup-mitmproxy step (success) 03:28:40 INFO - [mozharness: 2017-08-14 10:28:40.829468Z] Running run-tests step. 03:28:40 INFO - Running pre-action listener: _resource_record_pre_action 03:28:40 INFO - Running pre-action listener: _set_gcov_prefix 03:28:40 INFO - Running main action method: run_tests 03:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:40 INFO - Python 2.7.3 03:28:40 INFO - Return code: 0 03:28:40 INFO - grabbing minidump binary from tooltool 03:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e54050>, '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 0x1e54f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e553e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:28:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:28:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:28:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:40 INFO - Return code: 0 03:28:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:40 INFO - ENV: RUST_BACKTRACE is now 1 03:28:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:28:40 INFO - Using env: {'DISPLAY': ':0', 03:28:40 INFO - 'HOME': '/home/cltbld', 03:28:40 INFO - 'LANG': 'en_US.UTF-8', 03:28:40 INFO - 'LANGUAGE': 'en_US:en', 03:28:40 INFO - 'LOGNAME': 'cltbld', 03:28:40 INFO - 'MAIL': '/var/mail/cltbld', 03:28:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:40 INFO - 'MOZ_NO_REMOTE': '1', 03:28:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:40 INFO - 'NO_EM_RESTART': '1', 03:28:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:40 INFO - 'PWD': '/builds/slave/test', 03:28:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:40 INFO - 'RUST_BACKTRACE': '1', 03:28:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:28:40 INFO - 'SHELL': '/bin/bash', 03:28:40 INFO - 'SHLVL': '1', 03:28:40 INFO - 'TERM': 'linux', 03:28:40 INFO - 'TMOUT': '86400', 03:28:40 INFO - 'USER': 'cltbld', 03:28:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837', 03:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:40 INFO - '_': '/tools/buildbot/bin/python'} 03:28:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:28:41 INFO - mozversion application_buildid: 20170814091934 03:28:41 INFO - mozversion application_changeset: 87ae6494d5b1fff0b2cd388c6d639e29f438fe77 03:28:41 INFO - mozversion application_display_name: Firefox 03:28:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:41 INFO - mozversion application_name: Firefox 03:28:41 INFO - mozversion application_remotingname: firefox 03:28:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:28:41 INFO - mozversion application_vendor: Mozilla 03:28:41 INFO - mozversion application_version: 56.0 03:28:41 INFO - mozversion platform_buildid: 20170814091934 03:28:41 INFO - mozversion platform_changeset: 87ae6494d5b1fff0b2cd388c6d639e29f438fe77 03:28:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:28:41 INFO - mozversion platform_version: 56.0 03:28:41 INFO - using testdate: 1502706521 03:28:41 INFO - actual date: 1502706521 03:28:41 INFO - starting webserver on 'localhost:39911' 03:28:41 INFO - SUITE-START | Running 2 tests 03:28:41 INFO - TEST-START | dromaeo_css 03:28:41 INFO - Initialising browser for dromaeo_css test... 03:28:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39911/getInfo.html -profile /tmp/tmpGIPxf_/profile 03:28:41 INFO - TEST-INFO | started process 7980 (/builds/slave/test/build/application/firefox/firefox http://localhost:39911/getInfo.html) 03:28:47 INFO - TEST-INFO | 7980: exit 0 03:28:47 INFO - Browser initialized. 03:28:47 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:47 INFO - TEST-INFO | started process 8146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGIPxf_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:47 INFO - PID 8146 | 1502706527871 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 03:28:58 INFO - PID 8146 | RSS: Main: 139431936 03:28:58 INFO - PID 8146 | 03:31:56 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:39911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39911/tests/dromaeo/cssquery-ext.html) 03:31:57 INFO - PID 8146 | RSS: Main: 149700608 03:31:57 INFO - PID 8146 | 03:34:59 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:39911/tests/dromaeo/cssquery-ext.html (next: http://localhost:39911/tests/dromaeo/cssquery-jquery.html) 03:35:00 INFO - PID 8146 | RSS: Main: 149340160 03:35:00 INFO - PID 8146 | 03:38:01 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:39911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39911/tests/dromaeo/cssquery-mootools.html) 03:38:02 INFO - PID 8146 | RSS: Main: 150384640 03:38:02 INFO - PID 8146 | 03:41:03 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:39911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39911/tests/dromaeo/cssquery-prototype.html) 03:41:04 INFO - PID 8146 | RSS: Main: 151130112 03:41:04 INFO - PID 8146 | 03:44:07 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:39911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39911/tests/dromaeo/cssquery-yui.html) 03:44:08 INFO - PID 8146 | RSS: Main: 153108480 03:44:08 INFO - PID 8146 | 03:47:09 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:39911/tests/dromaeo/cssquery-yui.html (next: http://localhost:39911/tests/dromaeo/cssquery-dojo.html) 03:47:10 INFO - PID 8146 | RSS: Main: 155738112 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | __start_tp_report 03:47:10 INFO - PID 8146 | _x_x_mozilla_page_load 03:47:10 INFO - PID 8146 | _x_x_mozilla_page_load_details 03:47:10 INFO - PID 8146 | |i|pagename|runs| 03:47:10 INFO - PID 8146 | |0;dojo.html;3498.8250587470634;3536.3104194682014;3566.73249506287;3568.625294344093;3596.9100772480683;6217.471514921232;6326.810195694136;6343.841403964903;6361.55469117162;6365.713542890569;6272.121902933582;6287.182666253392;6291.905621415671;6372.617642941415;6383.393577610132;5416.4312747161575;5500.477454641803;5551.9722401387935;5569.972150139264;5577.665340079598;5511.283533140686;5575.609707320489;5587.916181257285;5597.188407680904;5600.719964001804;5525.502704756571;5556.888862222773;5613.298337707786;5615.2700148980575;5622.381538030854;5487.067198576252;5514.117741161395;5548.0845660465975;5595.524380427669;5606.803761868356;5513.228148059275;5523.696196709179;5543.833684989457;5556.91664625031;5559.360673522557;6162.952298109332;6193.256809182927;6214.130021796952;6217.191765070512;6244.75020999164;6738.797836064926;6740.662966851638;6745;6819.352161544645;6821.420179284767;6878.415334696507;6900.930990690079;6905.792826215172;6908.1364829396325;6921.826954326132;6292.5595208335435;6294;6343.111964324952;6365.968170159166;6390.0734393512685;6824.7952561423235;6911.6889739961825;6944.861102777916;6959.060526828814;7030.437564994788;6664.5334826561675;6667.6666166691475;6669.599824010478;6691.029800678972;6740.62926539045;6840;6873.965630171917;6894.448444124458;6900.723971041102;6913.723451061901;6735.461163106939;6761.391474767294;6765.72937082521;6775.0514927910135;6809.795706128824;6720.529562930646;6747.6626168692355;6774.390304872487;6784.898226526606;6826.556273842184;5034.647574669738;5035.16919708244;5045.520675535819;5058.671186372874;5084.186530155157;4502.482214545369;4526.321051842184;4562.657800664963;4565.086982603492;4581.015081757371;6508.446782023487;6515.446187074152;6584.078229047937;6590;6590.901136482957;6746.460283177432;6828.6927088281145;6834.350736680008;6871.312868713088;6921.342472465108;6495.4803615710625;6528.08606795049;6531.0529973153625;6546.770863019867;6561.245456772533;5720.799772008043;5726.284214473191;5748.7125643717645;5782.219400380979;5821.53427725781;6902.689378977958;6963.303669633097;6965.895511567331;6969.128858892638;7052.33002864727;6833.4191593715095;6853.937639665959;6863.073485079451;6893.310668933066;6910.827229319308;6929;6977.1976222733;7052.365287124184;7066.752663656747;7077.893831592633;6560;6631.568948018364;6642.103316052271;6694.297098804555;6733.494987876027;6723.596584204964;6731.259561448334;6750.0887380205;6804.557703749439;6901.792946211622;6676.899846502403;6679.532432729662;6720.361565651256;6726.159230096238;6734.259231484631;6537.5096867734155;6599.340065993362;6619.801405957829;6647.235567909753;6738.561993470409;6431.421172094534;6468.935310647022;6487.708053137714;6489.286178520453;6500.934990650033;6472.546921715435;6531.738730450728;6538.444232240313;6538.8365290868105;6562.409383155539;6303.149074874833;6365.61806291624;6524.836879078061;6575.80272591823;6593.703283352164 03:47:10 INFO - PID 8146 | |1;ext.html;853.0327408437028;903.530164314556;933.8599210118481;938.0291398402654;954.3748844506841;43325.78337108314;44161.01275442609;44161.337579936284;44312.55687443125;44417.77791111048;40779.59220407795;41020.38469422961;41154.176916461656;41261.17477650445;41304.79347603265;6981.4065804406555;7053.365197132257;7115.039469671606;7122.608256545888;7125.679344429487;7090.326418990187;7160.248173941739;7179.533330333537;7182.102237220348;7185.964070179642;7758.806029849243;7848.7645370638975;7949.841003179933;7951.761447156595;7955.840883182362;7828.295453409192;7833.647485863093;7847.64685589147;7860.646270917794;7862.882056769153;7744.612769361565;7749.961250193713;7767.650455729506;7834.059912810442;7836.098848632423;40374.798126009475;40501.594984050374;40768.79615601933;40792.59207407918;40822.591774082175;3636.181859081712;3647.0517665407187;3692.464592634053;3693.316736403774;3698.0939669780805;31346.37307253865;31428.52857207144;31461;31734.365312693848;31782.682173178433;5043.62172837035;5176.5858731301405;5207.6875387476875;5239.292695486099;5262.710550919698;220295;221024;221729;222331;223339.99999999837;52726.47273527215;52765.736171318895;53108.468915311125;53249.733751331;53876.73061634667;55608.443915560325;55724;55745;55844.44155558392;55935;18157.36449224271;18435.446936591656;18479.168437420078;18484.537886552946;18498.260069597334;15036.774448383283;15077.623059423602;15079.095254284559;15088.471903483325;15106.622334441727;14981.850181498046;15099.245037748069;15121.697566048837;15165.924170379298;15224.619384515476;5672.688002159921;5802.912956305659;5946.910796338058;5963.314218864799;5966.105084237312;1089.2212068371152;1089.4607169451172;1103.779244151173;1104.0725790335996;1114.9331040137617;25532.744672553406;25713.357166070622;25739.227823165336;25749.74250257511;25838;1174.4773575758877;1176.8293597428326;1218.945147468366;1221.5358163897663;1236.252067499168;13213.405396756976;13260.801087983687;13507.729845403037;13516.459341626225;13658.385372658255;309170;309367;311883;312965;313200;53705.73147134239;53974.19038714423;60260.69869650711;60515.39484605098;61425;1552.4256025270722;1569.1448160752418;1572.536101849934;1573.913434761099;1581.1856893699753;29607.703922961355;29867.253318667208;29959.850200748857;30282.54576181315;30425.847870760503;40347.79826100851;40418.39372409475;40499.190016198925;40517;40657.39013914853;245917;247795;247913;248222;249577;36843.81578092092;36900.446493302086;37026;37038.25923481569;37207.25585488329;45088;50702.49297506978;51149;51443.48556514387;51589.22616160686;36217.45673814842;36498;36594.45108323431;37002;37262.44106338461;35364.469532956515;36324.27351453009;36494.27011459809;36509;36553.24587152346;42235.577644224395;42376.5762342385;42401.15197696091;42722.35916461193;42764;35099.82450087733;36187;36330.091747706516;36484.45273320955;36811.44782828313;26316.342091447867;27011.459770804868;27475.31311717223;27584.586231206147;27863.16410507688 03:47:10 INFO - PID 8146 | |2;jquery.html;573.546897950619;588.5762251179152;595.4904317554999;597.1550256387212;607.1590846677352;23568.292951211468;24324.270271891826;24349;24416;24702;26772.73227267727;27596.862015689945;27736.583951240747;27783.166505004883;27825.304367390825;6349.047642853563;6499.38255865692;6500.4474619657385;6505.4145126938565;6520.93479065208;5940.287165540141;6475.158229430168;6498.415142637162;6500.057491663706;6528.836779080513;6416.4225219730215;6418.679066046679;6429.58207716497;6473.061406096113;6483.935160648404;6448.903266451007;6450.161479007723;6455.160829092235;6461.386168314003;6462.450691691212;5981.282246130492;6003.699815009276;6040.426159514839;6061.333253342129;6072.757089716406;32533.186670333194;32637.836810815796;32773.34453310944;33025;33084.33831323384;2316.4787922717423;2390.605550084234;2395.3293077938206;2399.7600239975864;2404.002339029301;20132.39602811918;20683.482912927146;20785.792142078535;20796.79203207979;20801.271955481636;2370.97629023711;2405.87970601471;2450.6079027355718;2491.202815099169;2510.736372680879;165510;167755;168551;169244;169503;16164.75752863708;16274.349026038826;16290.592735181715;16793;17172;25444;25548.616770748453;25580.872095639403;25600.359991000372;25700.485990280464;11447.484863181176;11564.595239166589;11681.88318116808;11800.704982375337;11855.822162667568;9856.802863942681;10513.211509136845;11060.612878549213;11163.776724465466;11242;9623.278254130968;10021.849672254923;10208.285420020527;10227.693169204937;10286.485675716185;2862.5706144078554;2918.7664986801005;2944.985275073611;2962.86667099981;3016.702817788328;1058.1006144776877;1084.9566017359375;1090.373035504588;1092.825147976336;1094.1356328500397;23074.077036918672;23390.064397424252;23408.414789630395;23537;23555;1176.4588289386977;1176.9646910592696;1182.9112816538623;1189.0309397840733;1200.0759415250209;12473;12928.095033347576;12930.482780688855;12936.094473386773;13023.088383813232;627320;652232;670221;676936;681119;133837;136463.31768341293;140679;142120.28939855236;144089;1321.7620828251006;1345.4483661698657;1393.3071318348254;1396.0367346531064;1397.3711829676686;23468.295951121494;24036.87981560151;24118;24179.758202418456;25558.361040974123;68229.65885170741;68566.47416125625;69927.30072699208;70692.29307706858;71435.28564714287;81008.59495702483;81093.59453202697;81288;84294.57852710698;89602.55198723964;15894;16194.514164575081;16430.342786288413;16496.92769969948;16593.672506199233;25723.35691607725;25832.225033249033;25908.61137082983;25931.611025835005;26146.607800883383;21024.159033639095;21264.574708505435;21317.147314107264;21486.24798132058;21507.78492215058;18759.812401875806;18912.905435473283;19145.13846876866;19423.611527769648;19682.409527714193;20058.59882802365;21209.469763256042;21597.568048638626;21953.890230548746;22088;15818.60453488672;15998.120103394425;16022.519324420286;16132.274047668117;16303.103329317002;19279.22883084661;19456;19569.902150489157;19817.306394276133;19820.40538783839 03:47:10 INFO - PID 8146 | |3;mootools.html;1457.4170331867251;1478.4603619678815;1502.4816438328787;1524.6417091983385;1524.7103050420426;15446.61383465414;15748.370065197407;16155.91922040391;16171.433999809995;16176.514704558853;16589.917050414762;16971.74542381865;17035.57411064724;17045.232964516596;17047.06241156736;3028.9091327260107;3060.1890499017777;3107.39405815866;3109.813411195324;3111.6888311168927;2948.115565330403;3000.729934305912;3030.9545356819667;3046.8019578727312;3049.4815881300233;2931.8680659370275;2947.7199666031693;2969.866356013974;2971.539411391227;2971.687972762861;2848.7151284871657;2868.842213678247;2890.3930174663346;2892.117904039267;2899.0433157058224;2837.872295746696;2851.9429611407654;2861.7710583153507;2862.799604027719;2875.151830210072;14812.777808332883;15004.099754014795;15041.473548425753;15057.54827355181;15075.472358467401;8679.696210632661;8931.73204803857;8945.105489451067;8974.86537701935;8978.551072446351;5826.446487583673;5893.174955506232;5963.970180149115;6073.878522429527;6079.088136779475;1884.1521315408122;1889.7070954002152;1900.6573851562096;1931.5460866696314;1938.8255057044935;28940.710592894222;29169.854150729323;29222.561661575095;29238.853805731047;29276.853615731787;7598.8100297493;7619.847603047908;7631.885521717179;7769.261920117579;7804.2585954334245;17346.826531734772;17593.29626814913;17686.204120814593;17694.823051769574;17712.734308985375;8783.472991620523;8909.1536304051;8919.331050171264;8925.375223734407;8985.685501007434;7899.881501777478;8171.959140204261;8236.094029656733;8274.8345033099;8316.875246871301;5472.398036216093;5598;5959.195508606283;6037.184980027728;6158.938410615926;1718.5016345259735;1721.3200785689583;1749.7462867884085;1751.0631811980784;1775.343123044482;955.7371722776293;974.3617930255693;980.887197972228;982.3172894838019;1007.2747621712356;9160.6793762218;9321.394109382869;9364.531773411301;9450.57472413743;9811.362261452983;1067.7811048735146;1071.23406764164;1076.967690969272;1092.3391348234204;1103.4813637590319;5622.156676498476;5650.660960342392;5833.591648584643;6084.908726369108;6438.098666186737;23399.883000584887;23890.163844265713;24358.147464838647;24392;24443.144489942766;22870.08519659228;23715.288541343787;23796.167134150222;23818.04727810903;23886.64170037451;12506.562270320495;12635.1787133836;12893.677658058623;12965.481380744854;12985.155964862253;9483.620655173716;9915.20678345745;9978.401295922267;10019.849702254327;10107.545160467944;20386.28647997313;20498.18007279692;20579.4855128623;20616;20640.07119679588;20559.69160462624;20778.79221207829;20809.687854681888;21065.473363166042;21314.36056918295;12980.35098245103;13089.149205302007;13224.272665003517;13230.07389482727;13248.337583120612;14655.413783448543;14901.25493725331;15063.322150503473;15116.848831511545;15127.092374457568;12139.575114870937;12148.817767733668;12398.81401778956;12415.193012454161;12564.937175314066;11852.585159519376;11885.524579017088;11993.820092698443;12178.878211217774;12258.877411225774;10090.2432317575;10192.235582331503;10234.795304094025;10247.897521024992;10249.590016399261;7671.846563068819;7913.287804097658;7913.920860791549;7955;7976.561289128921;7647.235276472531;7773.611319433892;7816.765497035098;7831.216878312123;7905 03:47:10 INFO - PID 8146 | |4;prototype.html;509.69673044538484;521.9634625576209;531.410134750427;538.0879409401066;538.4131296886393;6087.11736798164;6137;6137.846553836151;6162.22972128484;6248.656323902189;5939.732712027958;5986.132010858423;6017.7592896284095;6081.9695901520545;6103.474131467133;4791.616670666356;4839.9516004840025;4875.975620121894;4877.731724755137;4911.975440122795;4672.322513235579;4786.952130478703;4801.159797035522;4816.662833601649;4885.5358740919555;4667.789949452266;4680.157571637121;4712.528747125277;4728.952710472886;4744.837514808876;4695.131400690883;4707.5763181313505;4716.292556116576;4721.26820342844;4744.95255047452;4274.337477690963;4277.1873344064525;4284.828606855754;4331.483980606794;4334.739915605074;5909;5926.822195334147;5966.940330596725;5967.582269241155;5993.820185394402;5499.33282358056;5601.971990140023;5620.522255608278;5630.8029218977135;5687.544996400278;6389.201349831271;6414.684989577126;6548.199245207558;6555.3772391622715;6570.868582628368;4774.376711917965;4874.731889746063;4881.731504767236;4902.656814022984;4907.656464047518;6589.044588534635;6600.933990660128;6752.122224110834;6792.864142717168;6838.48711346651;4971.365176456484;4985.227289770091;4991.4758950310425;4997.325361076281;5000.799328564024;5056.84829455117;5069.771860266297;5075.137226671474;5084.618653600995;5095.910676622567;5694.202811606378;5694.800681976111;5705.74324155414;5706.9429305707245;5713.4000929902595;6411.583247089017;6418.84460797061;6441.935580644227;6458.644774537352;6569.737210511622;1704;1709.3162734906136;1746.6855965926002;1749.2390809997692;1750.2298988445043;1166.8833116688263;1199.892009719112;1231.359692959656;1240.6898275431142;1251.843519560055;6198.504119670415;6209.9068513972325;6256.280527739368;6304.495640348761;6324.71538780756;6583.144191255106;6586.901196481961;6648.301928297459;6656.96671516649;6703.525224450613;6181.505479561624;6263.655498947602;6322.525810564226;6324.146240257598;6332.905006424908;3521.7182625389905;3522.454019626962;3530.6292839252023;3559.94660080099;3562.3435102676863;6788.932110678928;6806.217285012287;6816.591004539644;6914.308569143045;6928.792136235921;6747.898781518281;6794.796156115324;6798.2182049064;6832.419244364285;6918.8962165567555;6772.103810932848;6794.796156115324;6819.6360727853635;6861.622610756356;6907;6089.35587391393;6564.9671751640935;6587.835304117244;6597.769078082436;6601.702923368556;6453;6476.643784591893;6522.34776522344;6523.140904842097;6550.115734375799;6621.966890165519;6688.2977287386075;6740.977706688072;6760.966195168992;6830.624315662686;4910.680805747615;4953.702777833341;4956.504349565014;4956.752162391938;5026.798928042984;6373.044043393528;6481.157449531531;6544.8363790905605;6701.865962680817;6757.391834734897;6445.838854028687;6480.416762491398;6512.120863683532;6535.2811190768025;6557.852375834305;6308.432241098323;6470.255920569195;6473.482121430368;6492.740290388331;6534.281229064704;6404;6466.450351719968;6472.805815825533;6512.511561632802;6513.7068831903625;6465;6494.116706155162;6508.902366464412;6524.836879077871;6541.411272985454;6274.811755647338;6334.651594162366;6362.77730279438;6399.080275917113;6409.647469389042 03:47:10 INFO - PID 8146 | |5;yui.html;952.1478276942141;976.0532283684826;994.7314225159207;1004.964826231082;1006.1296978113929;19325.323613673525;20021.799782002177;20372.694409583848;20384.8980755096;23813.404664883386;22569.435764105907;22579;22683.31950041497;22732;22816.20143294985;1055.5039131608132;1075.7256899490658;1086.9728256793564;1087.211771465689;1088.5536929858758;1050.2858056521563;1088.5482524752258;1088.678839742274;1101.6860194844471;1106.24775152896;1165.6095208105296;1170.4791367841315;1173.383973413956;1175.5885440095983;1177.9587714429997;1154.999999999996;1160.5299853559238;1160.535785685724;1166.3643314393591;1167.1829719196596;852.3181454836106;854.6837670062055;855.9871601925976;857.8370109679204;858.3519442820693;20391.082401291977;20521.076551555216;20705.27531536404;20830.687539686918;21201.46996325089;21742;21813.23653672114;21907.780922190894;22094.116235350728;22220;17314.740278895828;17483.475495735147;17546.38587649426;17552.736708949247;17729.7340539892;3796.772193668361;3831.63599458051;3842.346801043829;3850.634189751969;3852.7688338699486;155054;155461;156265;156673;156730;16333.836661633231;16348.75476867848;16434.6713065738;16843.578910527336;17224.397146099825;33389.3322133556;33696.32607347839;33700.831495842365;33711.83144084313;34233.31533369319;8421.789455263544;8664.523451210118;9242.953785231031;9538.618455261712;9707.805843883083;4614.8384806532285;4674;4682.765861706901;4692.0850434165695;4746.69146505483;5715.199872017921;5783.739731712083;5814.040683287295;5837.562182836305;5842.853928651818;1208.6857417071449;1210.6126039667397;1229.5204870100667;1238.9814152787715;1242.4719494214924;716.5485743981259;735.2059775442509;748.195689633646;748.7529115391908;758.1660173808876;12693.809592856114;13926.303684815719;14156.433742650179;14177.291135443187;14239.359228834728;749.1459735901077;750.6209364271008;751.5565816168487;757.8446418484198;767.0373681030271;6282.780102696475;6340;6366.236051673829;6417.935820641827;6481.708323125471;128124;129393.35303323423;131405.3429732845;134298;135431.32284338516;115624.42187789007;116432.41783791027;119619;120193.39903300427;125107;100043.99956000493;102359.48820255851;102680;103151;104059;12453.128281020241;12482.875171248534;12615.36923153857;12665.240085594894;12693.873061269269;48482.75758621185;48871;49690.50309496859;49944;50634;83807.5809620948;84983;85756.57121714352;86991;88656.48511510588;16691;21228.25701100454;21249.787502124782;21543.353699389045;21569.029393677007;21992;23896;23985.52028959446;24390.878045609657;24574.385640359134;21718.131274748834;22197.445063873532;22404.03020655858;22512.66231006569;22574.20990265333;22055.33833984983;22083.227087051877;22118.33644990653;22186.223482178048;22467.88766056159;19913.900430497753;20016.59966800685;20256.088476018318;20863.8956805215;21726.674099888198;13944.651383715083;14141.393944544487;14880.255987200813;14996.850031499982;15184.240787960778;15515.689686205988;15705.921470392575;15962.760558591399;16051.277692503632;16274.349026038826 03:47:10 INFO - PID 8146 | __end_tp_report 03:47:10 INFO - PID 8146 | __start_cc_report 03:47:10 INFO - PID 8146 | _x_x_mozilla_cycle_collect,256 03:47:10 INFO - PID 8146 | __end_cc_report 03:47:10 INFO - PID 8146 | __startTimestamp1502707630153__endTimestamp 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | ------- Summary: start ------- 03:47:10 INFO - PID 8146 | Number of tests: 6 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | [#0] dojo.html Cycles:165 Average:6261.73 Median:6538.84 stddev:773.99 (11.8%) stddev-sans-first:745.40 03:47:10 INFO - PID 8146 | Values: 3498.8 3536.3 3566.7 3568.6 3596.9 6217.5 6326.8 6343.8 6361.6 6365.7 6272.1 6287.2 6291.9 6372.6 6383.4 5416.4 5500.5 5552.0 5570.0 5577.7 5511.3 5575.6 5587.9 5597.2 5600.7 5525.5 5556.9 5613.3 5615.3 5622.4 5487.1 5514.1 5548.1 5595.5 5606.8 5513.2 5523.7 5543.8 5556.9 5559.4 6163.0 6193.3 6214.1 6217.2 6244.8 6738.8 6740.7 6745.0 6819.4 6821.4 6878.4 6900.9 6905.8 6908.1 6921.8 6292.6 6294.0 6343.1 6366.0 6390.1 6824.8 6911.7 6944.9 6959.1 7030.4 6664.5 6667.7 6669.6 6691.0 6740.6 6840.0 6874.0 6894.4 6900.7 6913.7 6735.5 6761.4 6765.7 6775.1 6809.8 6720.5 6747.7 6774.4 6784.9 6826.6 5034.6 5035.2 5045.5 5058.7 5084.2 4502.5 4526.3 4562.7 4565.1 4581.0 6508.4 6515.4 6584.1 6590.0 6590.9 6746.5 6828.7 6834.4 6871.3 6921.3 6495.5 6528.1 6531.1 6546.8 6561.2 5720.8 5726.3 5748.7 5782.2 5821.5 6902.7 6963.3 6965.9 6969.1 7052.3 6833.4 6853.9 6863.1 6893.3 6910.8 6929.0 6977.2 7052.4 7066.8 7077.9 6560.0 6631.6 6642.1 6694.3 6733.5 6723.6 6731.3 6750.1 6804.6 6901.8 6676.9 6679.5 6720.4 6726.2 6734.3 6537.5 6599.3 6619.8 6647.2 6738.6 6431.4 6468.9 6487.7 6489.3 6500.9 6472.5 6531.7 6538.4 6538.8 6562.4 6303.1 6365.6 6524.8 6575.8 6593.7 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | [#1] ext.html Cycles:180 Average:44074.24 Median:37014.00 stddev:68531.71 (185.2%) stddev-sans-first:68647.12 03:47:10 INFO - PID 8146 | Values: 853.0 903.5 933.9 938.0 954.4 43325.8 44161.0 44161.3 44312.6 44417.8 40779.6 41020.4 41154.2 41261.2 41304.8 6981.4 7053.4 7115.0 7122.6 7125.7 7090.3 7160.2 7179.5 7182.1 7186.0 7758.8 7848.8 7949.8 7951.8 7955.8 7828.3 7833.6 7847.6 7860.6 7862.9 7744.6 7750.0 7767.7 7834.1 7836.1 40374.8 40501.6 40768.8 40792.6 40822.6 3636.2 3647.1 3692.5 3693.3 3698.1 31346.4 31428.5 31461.0 31734.4 31782.7 5043.6 5176.6 5207.7 5239.3 5262.7 220295.0 221024.0 221729.0 222331.0 223340.0 52726.5 52765.7 53108.5 53249.7 53876.7 55608.4 55724.0 55745.0 55844.4 55935.0 18157.4 18435.4 18479.2 18484.5 18498.3 15036.8 15077.6 15079.1 15088.5 15106.6 14981.9 15099.2 15121.7 15165.9 15224.6 5672.7 5802.9 5946.9 5963.3 5966.1 1089.2 1089.5 1103.8 1104.1 1114.9 25532.7 25713.4 25739.2 25749.7 25838.0 1174.5 1176.8 1218.9 1221.5 1236.3 13213.4 13260.8 13507.7 13516.5 13658.4 309170.0 309367.0 311883.0 312965.0 313200.0 53705.7 53974.2 60260.7 60515.4 61425.0 1552.4 1569.1 1572.5 1573.9 1581.2 29607.7 29867.3 29959.9 30282.5 30425.8 40347.8 40418.4 40499.2 40517.0 40657.4 245917.0 247795.0 247913.0 248222.0 249577.0 36843.8 36900.4 37026.0 37038.3 37207.3 45088.0 50702.5 51149.0 51443.5 51589.2 36217.5 36498.0 36594.5 37002.0 37262.4 35364.5 36324.3 36494.3 36509.0 36553.2 42235.6 42376.6 42401.2 42722.4 42764.0 35099.8 36187.0 36330.1 36484.5 36811.4 26316.3 27011.5 27475.3 27584.6 27863.2 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | [#2] jquery.html Cycles:180 Average:42953.15 Median:12969.63 stddev:110828.39 (854.5%) stddev-sans-first:111093.61 03:47:10 INFO - PID 8146 | Values: 573.5 588.6 595.5 597.2 607.2 23568.3 24324.3 24349.0 24416.0 24702.0 26772.7 27596.9 27736.6 27783.2 27825.3 6349.0 6499.4 6500.4 6505.4 6520.9 5940.3 6475.2 6498.4 6500.1 6528.8 6416.4 6418.7 6429.6 6473.1 6483.9 6448.9 6450.2 6455.2 6461.4 6462.5 5981.3 6003.7 6040.4 6061.3 6072.8 32533.2 32637.8 32773.3 33025.0 33084.3 2316.5 2390.6 2395.3 2399.8 2404.0 20132.4 20683.5 20785.8 20796.8 20801.3 2371.0 2405.9 2450.6 2491.2 2510.7 165510.0 167755.0 168551.0 169244.0 169503.0 16164.8 16274.3 16290.6 16793.0 17172.0 25444.0 25548.6 25580.9 25600.4 25700.5 11447.5 11564.6 11681.9 11800.7 11855.8 9856.8 10513.2 11060.6 11163.8 11242.0 9623.3 10021.8 10208.3 10227.7 10286.5 2862.6 2918.8 2945.0 2962.9 3016.7 1058.1 1085.0 1090.4 1092.8 1094.1 23074.1 23390.1 23408.4 23537.0 23555.0 1176.5 1177.0 1182.9 1189.0 1200.1 12473.0 12928.1 12930.5 12936.1 13023.1 627320.0 652232.0 670221.0 676936.0 681119.0 133837.0 136463.3 140679.0 142120.3 144089.0 1321.8 1345.4 1393.3 1396.0 1397.4 23468.3 24036.9 24118.0 24179.8 25558.4 68229.7 68566.5 69927.3 70692.3 71435.3 81008.6 81093.6 81288.0 84294.6 89602.6 15894.0 16194.5 16430.3 16496.9 16593.7 25723.4 25832.2 25908.6 25931.6 26146.6 21024.2 21264.6 21317.1 21486.2 21507.8 18759.8 18912.9 19145.1 19423.6 19682.4 20058.6 21209.5 21597.6 21953.9 22088.0 15818.6 15998.1 16022.5 16132.3 16303.1 19279.2 19456.0 19569.9 19817.3 19820.4 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | [#3] mootools.html Cycles:180 Average:10214.76 Median:24375.07 stddev:7256.43 (29.8%) stddev-sans-first:7246.96 03:47:10 INFO - PID 8146 | Values: 1457.4 1478.5 1502.5 1524.6 1524.7 15446.6 15748.4 16155.9 16171.4 16176.5 16589.9 16971.7 17035.6 17045.2 17047.1 3028.9 3060.2 3107.4 3109.8 3111.7 2948.1 3000.7 3031.0 3046.8 3049.5 2931.9 2947.7 2969.9 2971.5 2971.7 2848.7 2868.8 2890.4 2892.1 2899.0 2837.9 2851.9 2861.8 2862.8 2875.2 14812.8 15004.1 15041.5 15057.5 15075.5 8679.7 8931.7 8945.1 8974.9 8978.6 5826.4 5893.2 5964.0 6073.9 6079.1 1884.2 1889.7 1900.7 1931.5 1938.8 28940.7 29169.9 29222.6 29238.9 29276.9 7598.8 7619.8 7631.9 7769.3 7804.3 17346.8 17593.3 17686.2 17694.8 17712.7 8783.5 8909.2 8919.3 8925.4 8985.7 7899.9 8172.0 8236.1 8274.8 8316.9 5472.4 5598.0 5959.2 6037.2 6158.9 1718.5 1721.3 1749.7 1751.1 1775.3 955.7 974.4 980.9 982.3 1007.3 9160.7 9321.4 9364.5 9450.6 9811.4 1067.8 1071.2 1077.0 1092.3 1103.5 5622.2 5650.7 5833.6 6084.9 6438.1 23399.9 23890.2 24358.1 24392.0 24443.1 22870.1 23715.3 23796.2 23818.0 23886.6 12506.6 12635.2 12893.7 12965.5 12985.2 9483.6 9915.2 9978.4 10019.8 10107.5 20386.3 20498.2 20579.5 20616.0 20640.1 20559.7 20778.8 20809.7 21065.5 21314.4 12980.4 13089.1 13224.3 13230.1 13248.3 14655.4 14901.3 15063.3 15116.8 15127.1 12139.6 12148.8 12398.8 12415.2 12564.9 11852.6 11885.5 11993.8 12178.9 12258.9 10090.2 10192.2 10234.8 10247.9 10249.6 7671.8 7913.3 7913.9 7955.0 7976.6 7647.2 7773.6 7816.8 7831.2 7905.0 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | [#4] prototype.html Cycles:180 Average:5491.00 Median:6190.00 stddev:1562.41 (25.2%) stddev-sans-first:1521.40 03:47:10 INFO - PID 8146 | Values: 509.7 522.0 531.4 538.1 538.4 6087.1 6137.0 6137.8 6162.2 6248.7 5939.7 5986.1 6017.8 6082.0 6103.5 4791.6 4840.0 4876.0 4877.7 4912.0 4672.3 4787.0 4801.2 4816.7 4885.5 4667.8 4680.2 4712.5 4729.0 4744.8 4695.1 4707.6 4716.3 4721.3 4745.0 4274.3 4277.2 4284.8 4331.5 4334.7 5909.0 5926.8 5966.9 5967.6 5993.8 5499.3 5602.0 5620.5 5630.8 5687.5 6389.2 6414.7 6548.2 6555.4 6570.9 4774.4 4874.7 4881.7 4902.7 4907.7 6589.0 6600.9 6752.1 6792.9 6838.5 4971.4 4985.2 4991.5 4997.3 5000.8 5056.8 5069.8 5075.1 5084.6 5095.9 5694.2 5694.8 5705.7 5706.9 5713.4 6411.6 6418.8 6441.9 6458.6 6569.7 1704.0 1709.3 1746.7 1749.2 1750.2 1166.9 1199.9 1231.4 1240.7 1251.8 6198.5 6209.9 6256.3 6304.5 6324.7 6583.1 6586.9 6648.3 6657.0 6703.5 6181.5 6263.7 6322.5 6324.1 6332.9 3521.7 3522.5 3530.6 3559.9 3562.3 6788.9 6806.2 6816.6 6914.3 6928.8 6747.9 6794.8 6798.2 6832.4 6918.9 6772.1 6794.8 6819.6 6861.6 6907.0 6089.4 6565.0 6587.8 6597.8 6601.7 6453.0 6476.6 6522.3 6523.1 6550.1 6622.0 6688.3 6741.0 6761.0 6830.6 4910.7 4953.7 4956.5 4956.8 5026.8 6373.0 6481.2 6544.8 6701.9 6757.4 6445.8 6480.4 6512.1 6535.3 6557.9 6308.4 6470.3 6473.5 6492.7 6534.3 6404.0 6466.5 6472.8 6512.5 6513.7 6465.0 6494.1 6508.9 6524.8 6541.4 6274.8 6334.7 6362.8 6399.1 6409.6 03:47:10 INFO - PID 8146 | 03:47:10 INFO - PID 8146 | [#5] yui.html Cycles:180 Average:27897.43 Median:21214.86 stddev:39309.55 (185.3%) stddev-sans-first:39367.76 03:47:10 INFO - PID 8146 | Values: 952.1 976.1 994.7 1005.0 1006.1 19325.3 20021.8 20372.7 20384.9 23813.4 22569.4 22579.0 22683.3 22732.0 22816.2 1055.5 1075.7 1087.0 1087.2 1088.6 1050.3 1088.5 1088.7 1101.7 1106.2 1165.6 1170.5 1173.4 1175.6 1178.0 1155.0 1160.5 1160.5 1166.4 1167.2 852.3 854.7 856.0 857.8 858.4 20391.1 20521.1 20705.3 20830.7 21201.5 21742.0 21813.2 21907.8 22094.1 22220.0 17314.7 17483.5 17546.4 17552.7 17729.7 3796.8 3831.6 3842.3 3850.6 3852.8 155054.0 155461.0 156265.0 156673.0 156730.0 16333.8 16348.8 16434.7 16843.6 17224.4 33389.3 33696.3 33700.8 33711.8 34233.3 8421.8 8664.5 9243.0 9538.6 9707.8 4614.8 4674.0 4682.8 4692.1 4746.7 5715.2 5783.7 5814.0 5837.6 5842.9 1208.7 1210.6 1229.5 1239.0 1242.5 716.5 735.2 748.2 748.8 758.2 12693.8 13926.3 14156.4 14177.3 14239.4 749.1 750.6 751.6 757.8 767.0 6282.8 6340.0 6366.2 6417.9 6481.7 128124.0 129393.4 131405.3 134298.0 135431.3 115624.4 116432.4 119619.0 120193.4 125107.0 100044.0 102359.5 102680.0 103151.0 104059.0 12453.1 12482.9 12615.4 12665.2 12693.9 48482.8 48871.0 49690.5 49944.0 50634.0 83807.6 84983.0 85756.6 86991.0 88656.5 16691.0 21228.3 21249.8 21543.4 21569.0 21992.0 23896.0 23985.5 24390.9 24574.4 21718.1 22197.4 22404.0 22512.7 22574.2 22055.3 22083.2 22118.3 22186.2 22467.9 19913.9 20016.6 20256.1 20863.9 21726.7 13944.7 14141.4 14880.3 14996.9 15184.2 15515.7 15705.9 15962.8 16051.3 16274.3 03:47:10 INFO - PID 8146 | -------- Summary: end -------- 03:47:10 INFO - PID 8146 | 03:47:10 INFO - TEST-INFO | 8146: exit 0 03:47:10 INFO - TEST-OK | dromaeo_css | took 1109580ms 03:47:10 INFO - TEST-START | kraken 03:47:10 INFO - Initialising browser for kraken test... 03:47:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39911/getInfo.html -profile /tmp/tmpX9KL7m/profile 03:47:10 INFO - TEST-INFO | started process 8499 (/builds/slave/test/build/application/firefox/firefox http://localhost:39911/getInfo.html) 03:47:16 INFO - TEST-INFO | 8499: exit 0 03:47:16 INFO - Browser initialized. 03:47:16 INFO - Running cycle 1/1 for kraken test... 03:47:16 INFO - TEST-INFO | started process 8664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9KL7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:16 INFO - PID 8664 | 1502707636648 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 03:47:27 INFO - PID 8664 | RSS: Main: 139014144 03:47:27 INFO - PID 8664 | 03:47:30 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39911/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:30 INFO - PID 8664 | RSS: Main: 147341312 03:47:30 INFO - PID 8664 | 03:47:33 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39911/tests/kraken/driver.html?testName=audio-dft) 03:47:34 INFO - PID 8664 | RSS: Main: 148054016 03:47:34 INFO - PID 8664 | 03:47:36 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39911/tests/kraken/driver.html?testName=audio-fft) 03:47:37 INFO - PID 8664 | RSS: Main: 148385792 03:47:37 INFO - PID 8664 | 03:47:39 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39911/tests/kraken/driver.html?testName=audio-oscillator) 03:47:40 INFO - PID 8664 | RSS: Main: 147587072 03:47:40 INFO - PID 8664 | 03:47:42 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:42 INFO - PID 8664 | RSS: Main: 147472384 03:47:42 INFO - PID 8664 | 03:47:45 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39911/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:46 INFO - PID 8664 | RSS: Main: 147808256 03:47:46 INFO - PID 8664 | 03:47:49 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39911/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:50 INFO - PID 8664 | RSS: Main: 150503424 03:47:50 INFO - PID 8664 | 03:47:53 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39911/tests/kraken/driver.html?testName=json-parse-financial) 03:47:53 INFO - PID 8664 | RSS: Main: 150609920 03:47:54 INFO - PID 8664 | 03:47:55 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:56 INFO - PID 8664 | RSS: Main: 151175168 03:47:56 INFO - PID 8664 | 03:47:57 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:58 INFO - PID 8664 | RSS: Main: 150315008 03:47:58 INFO - PID 8664 | 03:48:00 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:01 INFO - PID 8664 | RSS: Main: 150511616 03:48:01 INFO - PID 8664 | 03:48:03 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:04 INFO - PID 8664 | RSS: Main: 150700032 03:48:04 INFO - PID 8664 | 03:48:07 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:07 INFO - PID 8664 | RSS: Main: 150974464 03:48:07 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | Cycle 1(1): loaded http://localhost:39911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39911/tests/kraken/driver.html?testName=ai-astar) 03:48:09 INFO - PID 8664 | RSS: Main: 153288704 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | __start_tp_report 03:48:09 INFO - PID 8664 | _x_x_mozilla_page_load 03:48:09 INFO - PID 8664 | _x_x_mozilla_page_load_details 03:48:09 INFO - PID 8664 | |i|pagename|runs| 03:48:09 INFO - PID 8664 | |0;ai-astar;103;106;95;105;108;109;114;108;110;108 03:48:09 INFO - PID 8664 | |1;audio-beat-detection;142;118;141;174;121;138;137;112;167;122 03:48:09 INFO - PID 8664 | |2;audio-dft;163;164;164;161;162;163;161;160;161;163 03:48:09 INFO - PID 8664 | |3;audio-fft;76;74;75;172;76;75;73;74;158;77 03:48:09 INFO - PID 8664 | |4;audio-oscillator;78;77;124;78;77;78;122;78;78;130 03:48:09 INFO - PID 8664 | |5;imaging-gaussian-blur;113;113;114;114;115;113;114;114;114;114 03:48:09 INFO - PID 8664 | |6;imaging-darkroom;150;148;149;149;148;148;149;148;149;148 03:48:09 INFO - PID 8664 | |7;imaging-desaturate;94;95;94;94;94;94;93;94;99;94 03:48:09 INFO - PID 8664 | |8;json-parse-financial;45;46;45;45;46;45;46;46;45;45 03:48:09 INFO - PID 8664 | |9;json-stringify-tinderbox;53;53;53;54;54;53;53;54;53;54 03:48:09 INFO - PID 8664 | |10;stanford-crypto-aes;74;74;74;76;73;73;75;80;73;72 03:48:09 INFO - PID 8664 | |11;stanford-crypto-ccm;118;121;115;126;115;128;118;114;120;137 03:48:09 INFO - PID 8664 | |12;stanford-crypto-pbkdf2;161;167;162;161;157;165;166;161;167;166 03:48:09 INFO - PID 8664 | |13;stanford-crypto-sha256-iterative;60;60;60;59;58;60;58;64;58;59 03:48:09 INFO - PID 8664 | __end_tp_report 03:48:09 INFO - PID 8664 | __start_cc_report 03:48:09 INFO - PID 8664 | _x_x_mozilla_cycle_collect,752 03:48:09 INFO - PID 8664 | __end_cc_report 03:48:09 INFO - PID 8664 | __startTimestamp1502707689598__endTimestamp 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | ------- Summary: start ------- 03:48:09 INFO - PID 8664 | Number of tests: 14 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#0] ai-astar Cycles:10 Average:106.60 Median:108.50 stddev:5.04 (4.6%) stddev-sans-first:5.17 03:48:09 INFO - PID 8664 | Values: 103.0 106.0 95.0 105.0 108.0 109.0 114.0 108.0 110.0 108.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:139.50 stddev:20.49 (14.7%) stddev-sans-first:21.66 03:48:09 INFO - PID 8664 | Values: 142.0 118.0 141.0 174.0 121.0 138.0 137.0 112.0 167.0 122.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 03:48:09 INFO - PID 8664 | Values: 163.0 164.0 164.0 161.0 162.0 163.0 161.0 160.0 161.0 163.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:38.11 (50.8%) stddev-sans-first:39.92 03:48:09 INFO - PID 8664 | Values: 76.0 74.0 75.0 172.0 76.0 75.0 73.0 74.0 158.0 77.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:78.00 stddev:23.09 (29.6%) stddev-sans-first:23.93 03:48:09 INFO - PID 8664 | Values: 78.0 77.0 124.0 78.0 77.0 78.0 122.0 78.0 78.0 130.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 03:48:09 INFO - PID 8664 | Values: 113.0 113.0 114.0 114.0 115.0 113.0 114.0 114.0 114.0 114.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 03:48:09 INFO - PID 8664 | Values: 150.0 148.0 149.0 149.0 148.0 148.0 149.0 148.0 149.0 148.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 03:48:09 INFO - PID 8664 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 93.0 94.0 99.0 94.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#8] json-parse-financial Cycles:10 Average:45.40 Median:45.50 stddev:0.52 (1.1%) stddev-sans-first:0.53 03:48:09 INFO - PID 8664 | Values: 45.0 46.0 45.0 45.0 46.0 45.0 46.0 46.0 45.0 45.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 03:48:09 INFO - PID 8664 | Values: 53.0 53.0 53.0 54.0 54.0 53.0 53.0 54.0 53.0 54.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.27 (3.1%) stddev-sans-first:2.40 03:48:09 INFO - PID 8664 | Values: 74.0 74.0 74.0 76.0 73.0 73.0 75.0 80.0 73.0 72.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:120.50 stddev:7.22 (6.0%) stddev-sans-first:7.57 03:48:09 INFO - PID 8664 | Values: 118.0 121.0 115.0 126.0 115.0 128.0 118.0 114.0 120.0 137.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:165.50 stddev:3.37 (2.0%) stddev-sans-first:3.47 03:48:09 INFO - PID 8664 | Values: 161.0 167.0 162.0 161.0 157.0 165.0 166.0 161.0 167.0 166.0 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.00 stddev:1.78 (3.0%) stddev-sans-first:1.88 03:48:09 INFO - PID 8664 | Values: 60.0 60.0 60.0 59.0 58.0 60.0 58.0 64.0 58.0 59.0 03:48:09 INFO - PID 8664 | -------- Summary: end -------- 03:48:09 INFO - PID 8664 | 03:48:09 INFO - PID 8664 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:48:10 INFO - TEST-INFO | 8664: exit 0 03:48:10 INFO - TEST-OK | kraken | took 59433ms 03:48:10 INFO - SUITE-END | took 1169s 03:48:10 INFO - Completed test suite (00:19:29) 03:48:10 INFO - javascript benchmark 03:48:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9154.18396077164, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3498.8250587470634, 3536.3104194682014, 3566.73249506287, 3568.625294344093, 3596.9100772480683, 6217.471514921232, 6326.810195694136, 6343.841403964903, 6361.55469117162, 6365.713542890569, 6272.121902933582, 6287.182666253392, 6291.905621415671, 6372.617642941415, 6383.393577610132, 5416.4312747161575, 5500.477454641803, 5551.9722401387935, 5569.972150139264, 5577.665340079598, 5511.283533140686, 5575.609707320489, 5587.916181257285, 5597.188407680904, 5600.719964001804, 5525.502704756571, 5556.888862222773, 5613.298337707786, 5615.2700148980575, 5622.381538030854, 5487.067198576252, 5514.117741161395, 5548.0845660465975, 5595.524380427669, 5606.803761868356, 5513.228148059275, 5523.696196709179, 5543.833684989457, 5556.91664625031, 5559.360673522557, 6162.952298109332, 6193.256809182927, 6214.130021796952, 6217.191765070512, 6244.75020999164, 6738.797836064926, 6740.662966851638, 6745.0, 6819.352161544645, 6821.420179284767, 6878.415334696507, 6900.930990690079, 6905.792826215172, 6908.1364829396325, 6921.826954326132, 6292.5595208335435, 6294.0, 6343.111964324952, 6365.968170159166, 6390.0734393512685, 6824.7952561423235, 6911.6889739961825, 6944.861102777916, 6959.060526828814, 7030.437564994788, 6664.5334826561675, 6667.6666166691475, 6669.599824010478, 6691.029800678972, 6740.62926539045, 6840.0, 6873.965630171917, 6894.448444124458, 6900.723971041102, 6913.723451061901, 6735.461163106939, 6761.391474767294, 6765.72937082521, 6775.0514927910135, 6809.795706128824, 6720.529562930646, 6747.6626168692355, 6774.390304872487, 6784.898226526606, 6826.556273842184, 5034.647574669738, 5035.16919708244, 5045.520675535819, 5058.671186372874, 5084.186530155157, 4502.482214545369, 4526.321051842184, 4562.657800664963, 4565.086982603492, 4581.015081757371, 6508.446782023487, 6515.446187074152, 6584.078229047937, 6590.0, 6590.901136482957, 6746.460283177432, 6828.6927088281145, 6834.350736680008, 6871.312868713088, 6921.342472465108, 6495.4803615710625, 6528.08606795049, 6531.0529973153625, 6546.770863019867, 6561.245456772533, 5720.799772008043, 5726.284214473191, 5748.7125643717645, 5782.219400380979, 5821.53427725781, 6902.689378977958, 6963.303669633097, 6965.895511567331, 6969.128858892638, 7052.33002864727, 6833.4191593715095, 6853.937639665959, 6863.073485079451, 6893.310668933066, 6910.827229319308, 6929.0, 6977.1976222733, 7052.365287124184, 7066.752663656747, 7077.893831592633, 6560.0, 6631.568948018364, 6642.103316052271, 6694.297098804555, 6733.494987876027, 6723.596584204964, 6731.259561448334, 6750.0887380205, 6804.557703749439, 6901.792946211622, 6676.899846502403, 6679.532432729662, 6720.361565651256, 6726.159230096238, 6734.259231484631, 6537.5096867734155, 6599.340065993362, 6619.801405957829, 6647.235567909753, 6738.561993470409, 6431.421172094534, 6468.935310647022, 6487.708053137714, 6489.286178520453, 6500.934990650033, 6472.546921715435, 6531.738730450728, 6538.444232240313, 6538.8365290868105, 6562.409383155539, 6303.149074874833, 6365.61806291624, 6524.836879078061, 6575.80272591823, 6593.703283352164], "value": 6204.93543264433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.0327408437028, 903.530164314556, 933.8599210118481, 938.0291398402654, 954.3748844506841, 43325.78337108314, 44161.01275442609, 44161.337579936284, 44312.55687443125, 44417.77791111048, 40779.59220407795, 41020.38469422961, 41154.176916461656, 41261.17477650445, 41304.79347603265, 6981.4065804406555, 7053.365197132257, 7115.039469671606, 7122.608256545888, 7125.679344429487, 7090.326418990187, 7160.248173941739, 7179.533330333537, 7182.102237220348, 7185.964070179642, 7758.806029849243, 7848.7645370638975, 7949.841003179933, 7951.761447156595, 7955.840883182362, 7828.295453409192, 7833.647485863093, 7847.64685589147, 7860.646270917794, 7862.882056769153, 7744.612769361565, 7749.961250193713, 7767.650455729506, 7834.059912810442, 7836.098848632423, 40374.798126009475, 40501.594984050374, 40768.79615601933, 40792.59207407918, 40822.591774082175, 3636.181859081712, 3647.0517665407187, 3692.464592634053, 3693.316736403774, 3698.0939669780805, 31346.37307253865, 31428.52857207144, 31461.0, 31734.365312693848, 31782.682173178433, 5043.62172837035, 5176.5858731301405, 5207.6875387476875, 5239.292695486099, 5262.710550919698, 220295.0, 221024.0, 221729.0, 222331.0, 223339.99999999837, 52726.47273527215, 52765.736171318895, 53108.468915311125, 53249.733751331, 53876.73061634667, 55608.443915560325, 55724.0, 55745.0, 55844.44155558392, 55935.0, 18157.36449224271, 18435.446936591656, 18479.168437420078, 18484.537886552946, 18498.260069597334, 15036.774448383283, 15077.623059423602, 15079.095254284559, 15088.471903483325, 15106.622334441727, 14981.850181498046, 15099.245037748069, 15121.697566048837, 15165.924170379298, 15224.619384515476, 5672.688002159921, 5802.912956305659, 5946.910796338058, 5963.314218864799, 5966.105084237312, 1089.2212068371152, 1089.4607169451172, 1103.779244151173, 1104.0725790335996, 1114.9331040137617, 25532.744672553406, 25713.357166070622, 25739.227823165336, 25749.74250257511, 25838.0, 1174.4773575758877, 1176.8293597428326, 1218.945147468366, 1221.5358163897663, 1236.252067499168, 13213.405396756976, 13260.801087983687, 13507.729845403037, 13516.459341626225, 13658.385372658255, 309170.0, 309367.0, 311883.0, 312965.0, 313200.0, 53705.73147134239, 53974.19038714423, 60260.69869650711, 60515.39484605098, 61425.0, 1552.4256025270722, 1569.1448160752418, 1572.536101849934, 1573.913434761099, 1581.1856893699753, 29607.703922961355, 29867.253318667208, 29959.850200748857, 30282.54576181315, 30425.847870760503, 40347.79826100851, 40418.39372409475, 40499.190016198925, 40517.0, 40657.39013914853, 245917.0, 247795.0, 247913.0, 248222.0, 249577.0, 36843.81578092092, 36900.446493302086, 37026.0, 37038.25923481569, 37207.25585488329, 45088.0, 50702.49297506978, 51149.0, 51443.48556514387, 51589.22616160686, 36217.45673814842, 36498.0, 36594.45108323431, 37002.0, 37262.44106338461, 35364.469532956515, 36324.27351453009, 36494.27011459809, 36509.0, 36553.24587152346, 42235.577644224395, 42376.5762342385, 42401.15197696091, 42722.35916461193, 42764.0, 35099.82450087733, 36187.0, 36330.091747706516, 36484.45273320955, 36811.44782828313, 26316.342091447867, 27011.459770804868, 27475.31311717223, 27584.586231206147, 27863.16410507688], "value": 18732.278921523917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.546897950619, 588.5762251179152, 595.4904317554999, 597.1550256387212, 607.1590846677352, 23568.292951211468, 24324.270271891826, 24349.0, 24416.0, 24702.0, 26772.73227267727, 27596.862015689945, 27736.583951240747, 27783.166505004883, 27825.304367390825, 6349.047642853563, 6499.38255865692, 6500.4474619657385, 6505.4145126938565, 6520.93479065208, 5940.287165540141, 6475.158229430168, 6498.415142637162, 6500.057491663706, 6528.836779080513, 6416.4225219730215, 6418.679066046679, 6429.58207716497, 6473.061406096113, 6483.935160648404, 6448.903266451007, 6450.161479007723, 6455.160829092235, 6461.386168314003, 6462.450691691212, 5981.282246130492, 6003.699815009276, 6040.426159514839, 6061.333253342129, 6072.757089716406, 32533.186670333194, 32637.836810815796, 32773.34453310944, 33025.0, 33084.33831323384, 2316.4787922717423, 2390.605550084234, 2395.3293077938206, 2399.7600239975864, 2404.002339029301, 20132.39602811918, 20683.482912927146, 20785.792142078535, 20796.79203207979, 20801.271955481636, 2370.97629023711, 2405.87970601471, 2450.6079027355718, 2491.202815099169, 2510.736372680879, 165510.0, 167755.0, 168551.0, 169244.0, 169503.0, 16164.75752863708, 16274.349026038826, 16290.592735181715, 16793.0, 17172.0, 25444.0, 25548.616770748453, 25580.872095639403, 25600.359991000372, 25700.485990280464, 11447.484863181176, 11564.595239166589, 11681.88318116808, 11800.704982375337, 11855.822162667568, 9856.802863942681, 10513.211509136845, 11060.612878549213, 11163.776724465466, 11242.0, 9623.278254130968, 10021.849672254923, 10208.285420020527, 10227.693169204937, 10286.485675716185, 2862.5706144078554, 2918.7664986801005, 2944.985275073611, 2962.86667099981, 3016.702817788328, 1058.1006144776877, 1084.9566017359375, 1090.373035504588, 1092.825147976336, 1094.1356328500397, 23074.077036918672, 23390.064397424252, 23408.414789630395, 23537.0, 23555.0, 1176.4588289386977, 1176.9646910592696, 1182.9112816538623, 1189.0309397840733, 1200.0759415250209, 12473.0, 12928.095033347576, 12930.482780688855, 12936.094473386773, 13023.088383813232, 627320.0, 652232.0, 670221.0, 676936.0, 681119.0, 133837.0, 136463.31768341293, 140679.0, 142120.28939855236, 144089.0, 1321.7620828251006, 1345.4483661698657, 1393.3071318348254, 1396.0367346531064, 1397.3711829676686, 23468.295951121494, 24036.87981560151, 24118.0, 24179.758202418456, 25558.361040974123, 68229.65885170741, 68566.47416125625, 69927.30072699208, 70692.29307706858, 71435.28564714287, 81008.59495702483, 81093.59453202697, 81288.0, 84294.57852710698, 89602.55198723964, 15894.0, 16194.514164575081, 16430.342786288413, 16496.92769969948, 16593.672506199233, 25723.35691607725, 25832.225033249033, 25908.61137082983, 25931.611025835005, 26146.607800883383, 21024.159033639095, 21264.574708505435, 21317.147314107264, 21486.24798132058, 21507.78492215058, 18759.812401875806, 18912.905435473283, 19145.13846876866, 19423.611527769648, 19682.409527714193, 20058.59882802365, 21209.469763256042, 21597.568048638626, 21953.890230548746, 22088.0, 15818.60453488672, 15998.120103394425, 16022.519324420286, 16132.274047668117, 16303.103329317002, 19279.22883084661, 19456.0, 19569.902150489157, 19817.306394276133, 19820.40538783839], "value": 13368.963828653894, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.4170331867251, 1478.4603619678815, 1502.4816438328787, 1524.6417091983385, 1524.7103050420426, 15446.61383465414, 15748.370065197407, 16155.91922040391, 16171.433999809995, 16176.514704558853, 16589.917050414762, 16971.74542381865, 17035.57411064724, 17045.232964516596, 17047.06241156736, 3028.9091327260107, 3060.1890499017777, 3107.39405815866, 3109.813411195324, 3111.6888311168927, 2948.115565330403, 3000.729934305912, 3030.9545356819667, 3046.8019578727312, 3049.4815881300233, 2931.8680659370275, 2947.7199666031693, 2969.866356013974, 2971.539411391227, 2971.687972762861, 2848.7151284871657, 2868.842213678247, 2890.3930174663346, 2892.117904039267, 2899.0433157058224, 2837.872295746696, 2851.9429611407654, 2861.7710583153507, 2862.799604027719, 2875.151830210072, 14812.777808332883, 15004.099754014795, 15041.473548425753, 15057.54827355181, 15075.472358467401, 8679.696210632661, 8931.73204803857, 8945.105489451067, 8974.86537701935, 8978.551072446351, 5826.446487583673, 5893.174955506232, 5963.970180149115, 6073.878522429527, 6079.088136779475, 1884.1521315408122, 1889.7070954002152, 1900.6573851562096, 1931.5460866696314, 1938.8255057044935, 28940.710592894222, 29169.854150729323, 29222.561661575095, 29238.853805731047, 29276.853615731787, 7598.8100297493, 7619.847603047908, 7631.885521717179, 7769.261920117579, 7804.2585954334245, 17346.826531734772, 17593.29626814913, 17686.204120814593, 17694.823051769574, 17712.734308985375, 8783.472991620523, 8909.1536304051, 8919.331050171264, 8925.375223734407, 8985.685501007434, 7899.881501777478, 8171.959140204261, 8236.094029656733, 8274.8345033099, 8316.875246871301, 5472.398036216093, 5598.0, 5959.195508606283, 6037.184980027728, 6158.938410615926, 1718.5016345259735, 1721.3200785689583, 1749.7462867884085, 1751.0631811980784, 1775.343123044482, 955.7371722776293, 974.3617930255693, 980.887197972228, 982.3172894838019, 1007.2747621712356, 9160.6793762218, 9321.394109382869, 9364.531773411301, 9450.57472413743, 9811.362261452983, 1067.7811048735146, 1071.23406764164, 1076.967690969272, 1092.3391348234204, 1103.4813637590319, 5622.156676498476, 5650.660960342392, 5833.591648584643, 6084.908726369108, 6438.098666186737, 23399.883000584887, 23890.163844265713, 24358.147464838647, 24392.0, 24443.144489942766, 22870.08519659228, 23715.288541343787, 23796.167134150222, 23818.04727810903, 23886.64170037451, 12506.562270320495, 12635.1787133836, 12893.677658058623, 12965.481380744854, 12985.155964862253, 9483.620655173716, 9915.20678345745, 9978.401295922267, 10019.849702254327, 10107.545160467944, 20386.28647997313, 20498.18007279692, 20579.4855128623, 20616.0, 20640.07119679588, 20559.69160462624, 20778.79221207829, 20809.687854681888, 21065.473363166042, 21314.36056918295, 12980.35098245103, 13089.149205302007, 13224.272665003517, 13230.07389482727, 13248.337583120612, 14655.413783448543, 14901.25493725331, 15063.322150503473, 15116.848831511545, 15127.092374457568, 12139.575114870937, 12148.817767733668, 12398.81401778956, 12415.193012454161, 12564.937175314066, 11852.585159519376, 11885.524579017088, 11993.820092698443, 12178.878211217774, 12258.877411225774, 10090.2432317575, 10192.235582331503, 10234.795304094025, 10247.897521024992, 10249.590016399261, 7671.846563068819, 7913.287804097658, 7913.920860791549, 7955.0, 7976.561289128921, 7647.235276472531, 7773.611319433892, 7816.765497035098, 7831.216878312123, 7905.0], "value": 7327.501857028028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.69673044538484, 521.9634625576209, 531.410134750427, 538.0879409401066, 538.4131296886393, 6087.11736798164, 6137.0, 6137.846553836151, 6162.22972128484, 6248.656323902189, 5939.732712027958, 5986.132010858423, 6017.7592896284095, 6081.9695901520545, 6103.474131467133, 4791.616670666356, 4839.9516004840025, 4875.975620121894, 4877.731724755137, 4911.975440122795, 4672.322513235579, 4786.952130478703, 4801.159797035522, 4816.662833601649, 4885.5358740919555, 4667.789949452266, 4680.157571637121, 4712.528747125277, 4728.952710472886, 4744.837514808876, 4695.131400690883, 4707.5763181313505, 4716.292556116576, 4721.26820342844, 4744.95255047452, 4274.337477690963, 4277.1873344064525, 4284.828606855754, 4331.483980606794, 4334.739915605074, 5909.0, 5926.822195334147, 5966.940330596725, 5967.582269241155, 5993.820185394402, 5499.33282358056, 5601.971990140023, 5620.522255608278, 5630.8029218977135, 5687.544996400278, 6389.201349831271, 6414.684989577126, 6548.199245207558, 6555.3772391622715, 6570.868582628368, 4774.376711917965, 4874.731889746063, 4881.731504767236, 4902.656814022984, 4907.656464047518, 6589.044588534635, 6600.933990660128, 6752.122224110834, 6792.864142717168, 6838.48711346651, 4971.365176456484, 4985.227289770091, 4991.4758950310425, 4997.325361076281, 5000.799328564024, 5056.84829455117, 5069.771860266297, 5075.137226671474, 5084.618653600995, 5095.910676622567, 5694.202811606378, 5694.800681976111, 5705.74324155414, 5706.9429305707245, 5713.4000929902595, 6411.583247089017, 6418.84460797061, 6441.935580644227, 6458.644774537352, 6569.737210511622, 1704.0, 1709.3162734906136, 1746.6855965926002, 1749.2390809997692, 1750.2298988445043, 1166.8833116688263, 1199.892009719112, 1231.359692959656, 1240.6898275431142, 1251.843519560055, 6198.504119670415, 6209.9068513972325, 6256.280527739368, 6304.495640348761, 6324.71538780756, 6583.144191255106, 6586.901196481961, 6648.301928297459, 6656.96671516649, 6703.525224450613, 6181.505479561624, 6263.655498947602, 6322.525810564226, 6324.146240257598, 6332.905006424908, 3521.7182625389905, 3522.454019626962, 3530.6292839252023, 3559.94660080099, 3562.3435102676863, 6788.932110678928, 6806.217285012287, 6816.591004539644, 6914.308569143045, 6928.792136235921, 6747.898781518281, 6794.796156115324, 6798.2182049064, 6832.419244364285, 6918.8962165567555, 6772.103810932848, 6794.796156115324, 6819.6360727853635, 6861.622610756356, 6907.0, 6089.35587391393, 6564.9671751640935, 6587.835304117244, 6597.769078082436, 6601.702923368556, 6453.0, 6476.643784591893, 6522.34776522344, 6523.140904842097, 6550.115734375799, 6621.966890165519, 6688.2977287386075, 6740.977706688072, 6760.966195168992, 6830.624315662686, 4910.680805747615, 4953.702777833341, 4956.504349565014, 4956.752162391938, 5026.798928042984, 6373.044043393528, 6481.157449531531, 6544.8363790905605, 6701.865962680817, 6757.391834734897, 6445.838854028687, 6480.416762491398, 6512.120863683532, 6535.2811190768025, 6557.852375834305, 6308.432241098323, 6470.255920569195, 6473.482121430368, 6492.740290388331, 6534.281229064704, 6404.0, 6466.450351719968, 6472.805815825533, 6512.511561632802, 6513.7068831903625, 6465.0, 6494.116706155162, 6508.902366464412, 6524.836879077871, 6541.411272985454, 6274.811755647338, 6334.651594162366, 6362.77730279438, 6399.080275917113, 6409.647469389042], "value": 5034.840777128017, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.1478276942141, 976.0532283684826, 994.7314225159207, 1004.964826231082, 1006.1296978113929, 19325.323613673525, 20021.799782002177, 20372.694409583848, 20384.8980755096, 23813.404664883386, 22569.435764105907, 22579.0, 22683.31950041497, 22732.0, 22816.20143294985, 1055.5039131608132, 1075.7256899490658, 1086.9728256793564, 1087.211771465689, 1088.5536929858758, 1050.2858056521563, 1088.5482524752258, 1088.678839742274, 1101.6860194844471, 1106.24775152896, 1165.6095208105296, 1170.4791367841315, 1173.383973413956, 1175.5885440095983, 1177.9587714429997, 1154.999999999996, 1160.5299853559238, 1160.535785685724, 1166.3643314393591, 1167.1829719196596, 852.3181454836106, 854.6837670062055, 855.9871601925976, 857.8370109679204, 858.3519442820693, 20391.082401291977, 20521.076551555216, 20705.27531536404, 20830.687539686918, 21201.46996325089, 21742.0, 21813.23653672114, 21907.780922190894, 22094.116235350728, 22220.0, 17314.740278895828, 17483.475495735147, 17546.38587649426, 17552.736708949247, 17729.7340539892, 3796.772193668361, 3831.63599458051, 3842.346801043829, 3850.634189751969, 3852.7688338699486, 155054.0, 155461.0, 156265.0, 156673.0, 156730.0, 16333.836661633231, 16348.75476867848, 16434.6713065738, 16843.578910527336, 17224.397146099825, 33389.3322133556, 33696.32607347839, 33700.831495842365, 33711.83144084313, 34233.31533369319, 8421.789455263544, 8664.523451210118, 9242.953785231031, 9538.618455261712, 9707.805843883083, 4614.8384806532285, 4674.0, 4682.765861706901, 4692.0850434165695, 4746.69146505483, 5715.199872017921, 5783.739731712083, 5814.040683287295, 5837.562182836305, 5842.853928651818, 1208.6857417071449, 1210.6126039667397, 1229.5204870100667, 1238.9814152787715, 1242.4719494214924, 716.5485743981259, 735.2059775442509, 748.195689633646, 748.7529115391908, 758.1660173808876, 12693.809592856114, 13926.303684815719, 14156.433742650179, 14177.291135443187, 14239.359228834728, 749.1459735901077, 750.6209364271008, 751.5565816168487, 757.8446418484198, 767.0373681030271, 6282.780102696475, 6340.0, 6366.236051673829, 6417.935820641827, 6481.708323125471, 128124.0, 129393.35303323423, 131405.3429732845, 134298.0, 135431.32284338516, 115624.42187789007, 116432.41783791027, 119619.0, 120193.39903300427, 125107.0, 100043.99956000493, 102359.48820255851, 102680.0, 103151.0, 104059.0, 12453.128281020241, 12482.875171248534, 12615.36923153857, 12665.240085594894, 12693.873061269269, 48482.75758621185, 48871.0, 49690.50309496859, 49944.0, 50634.0, 83807.5809620948, 84983.0, 85756.57121714352, 86991.0, 88656.48511510588, 16691.0, 21228.25701100454, 21249.787502124782, 21543.353699389045, 21569.029393677007, 21992.0, 23896.0, 23985.52028959446, 24390.878045609657, 24574.385640359134, 21718.131274748834, 22197.445063873532, 22404.03020655858, 22512.66231006569, 22574.20990265333, 22055.33833984983, 22083.227087051877, 22118.33644990653, 22186.223482178048, 22467.88766056159, 19913.900430497753, 20016.59966800685, 20256.088476018318, 20863.8956805215, 21726.674099888198, 13944.651383715083, 14141.393944544487, 14880.255987200813, 14996.850031499982, 15184.240787960778, 15515.689686205988, 15705.921470392575, 15962.760558591399, 16051.277692503632, 16274.349026038826], "value": 10264.118676849803, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 106.0, 95.0, 105.0, 108.0, 109.0, 114.0, 108.0, 110.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 141.0, 174.0, 121.0, 138.0, 137.0, 112.0, 167.0, 122.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 161.0, 162.0, 163.0, 161.0, 160.0, 161.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 172.0, 76.0, 75.0, 73.0, 74.0, 158.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 124.0, 78.0, 77.0, 78.0, 122.0, 78.0, 78.0, 130.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 99.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 45.0, 45.0, 46.0, 45.0, 46.0, 46.0, 45.0, 45.0], "value": 45.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 76.0, 73.0, 73.0, 75.0, 80.0, 73.0, 72.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 115.0, 126.0, 115.0, 128.0, 118.0, 114.0, 120.0, 137.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 167.0, 162.0, 161.0, 157.0, 165.0, 166.0, 161.0, 167.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 58.0, 60.0, 58.0, 64.0, 58.0, 59.0], "value": 59.6, "unit": "score"}]}]} 03:48:10 INFO - Return code: 0 03:48:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:10 INFO - # TBPL SUCCESS # 03:48:10 INFO - Running post-action listener: _package_coverage_data 03:48:10 INFO - Running post-action listener: _resource_record_post_action 03:48:10 INFO - [mozharness: 2017-08-14 10:48:10.416488Z] Finished run-tests step (success) 03:48:10 INFO - Running post-run listener: _resource_record_post_run 03:48:10 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 577536; Write bytes: 364494848; Read time: 188; Write time: 190160 03:48:10 INFO - TinderboxPrint: CPU usage
13.0% 03:48:10 INFO - TinderboxPrint: I/O read bytes / time
577,536 / 188 03:48:10 INFO - TinderboxPrint: I/O write bytes / time
364,494,848 / 190,160 03:48:10 INFO - TinderboxPrint: CPU idle
8,212.9 (87.0%) 03:48:10 INFO - TinderboxPrint: CPU user
1,180.4 (12.5%) 03:48:10 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:10 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 94527488; Read time: 0; Write time: 70656 03:48:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:48:10 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 577536; Write bytes: 269967360; Read time: 188; Write time: 119504 03:48:11 INFO - Running post-run listener: _upload_blobber_files 03:48:11 INFO - Blob upload gear active. 03:48:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:11 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:48:11 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:48:11 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:48:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:18 INFO - (blobuploader) - INFO - Done attempting. 03:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:19 INFO - (blobuploader) - INFO - Done attempting. 03:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:20 INFO - (blobuploader) - INFO - Done attempting. 03:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:21 INFO - (blobuploader) - INFO - Done attempting. 03:48:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:21 INFO - Return code: 0 03:48:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/401fe5fb06317d673b56ce9ec5ede74f46df205e0e960f6868abeba6a5aee23498bfbd81fbac369eae7e90cd912a5cd349636b3296e5cb437dc22b0154c5b8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5b4a29cadd0f4c6be3a39715e7a2bbfc7b9ed709924905c29e5c6d5baffdc9a29a402714af57e8a471a021809b5ce810e842f24f096e38fda3019200d4b9e59e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9cf44262c6a543b8ced09d1a1cd541103ec2d7a75c2f713202a151f944e048c476d4685b48e88a7241905786154fc2eb2f248e5269409be952717d08fdb809c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06b45a1d3022eae5cf5e60300167b0d25d68d86dbaa90a983e3022beed15b0eca36b9baa3188ecac9a5279113b7c32dc003653ba9e34d60d92dae4c42f721103"} 03:48:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:21 INFO - Contents: 03:48:21 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/401fe5fb06317d673b56ce9ec5ede74f46df205e0e960f6868abeba6a5aee23498bfbd81fbac369eae7e90cd912a5cd349636b3296e5cb437dc22b0154c5b8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5b4a29cadd0f4c6be3a39715e7a2bbfc7b9ed709924905c29e5c6d5baffdc9a29a402714af57e8a471a021809b5ce810e842f24f096e38fda3019200d4b9e59e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9cf44262c6a543b8ced09d1a1cd541103ec2d7a75c2f713202a151f944e048c476d4685b48e88a7241905786154fc2eb2f248e5269409be952717d08fdb809c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06b45a1d3022eae5cf5e60300167b0d25d68d86dbaa90a983e3022beed15b0eca36b9baa3188ecac9a5279113b7c32dc003653ba9e34d60d92dae4c42f721103"} 03:48:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:21 INFO - Copying logs to upload dir... 03:48:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.173505 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-14 03:48:20.326876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 03:48:20.334785) ========= 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=cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/401fe5fb06317d673b56ce9ec5ede74f46df205e0e960f6868abeba6a5aee23498bfbd81fbac369eae7e90cd912a5cd349636b3296e5cb437dc22b0154c5b8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5b4a29cadd0f4c6be3a39715e7a2bbfc7b9ed709924905c29e5c6d5baffdc9a29a402714af57e8a471a021809b5ce810e842f24f096e38fda3019200d4b9e59e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9cf44262c6a543b8ced09d1a1cd541103ec2d7a75c2f713202a151f944e048c476d4685b48e88a7241905786154fc2eb2f248e5269409be952717d08fdb809c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06b45a1d3022eae5cf5e60300167b0d25d68d86dbaa90a983e3022beed15b0eca36b9baa3188ecac9a5279113b7c32dc003653ba9e34d60d92dae4c42f721103"} build_url:https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011491 build_url: 'https://queue.taskcluster.net/v1/task/DYz24zi9Svu_LePPR096jQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/401fe5fb06317d673b56ce9ec5ede74f46df205e0e960f6868abeba6a5aee23498bfbd81fbac369eae7e90cd912a5cd349636b3296e5cb437dc22b0154c5b8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5b4a29cadd0f4c6be3a39715e7a2bbfc7b9ed709924905c29e5c6d5baffdc9a29a402714af57e8a471a021809b5ce810e842f24f096e38fda3019200d4b9e59e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e9cf44262c6a543b8ced09d1a1cd541103ec2d7a75c2f713202a151f944e048c476d4685b48e88a7241905786154fc2eb2f248e5269409be952717d08fdb809c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06b45a1d3022eae5cf5e60300167b0d25d68d86dbaa90a983e3022beed15b0eca36b9baa3188ecac9a5279113b7c32dc003653ba9e34d60d92dae4c42f721103"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 03:48:20.362257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:48:20.362573) ========= 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=cbe409c6de289db6ac707de3000001d4-1502701048.293012-691753837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:48:20.442075) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 03:48:20.442379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 03:48:20.445679) ========= ========= Total master_lag: 0.22 =========