builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1502165882.45 results: success (0) revision: f32ac702a2c545f44d594b994158c59dbabf993f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.449366) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.449846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.450146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.578087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.578425) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 21:18:02-- 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% 227M=0s 2017-08-07 21:18:02 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.193766 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.813056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.813373) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.865578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:02.865989) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f32ac702a2c545f44d594b994158c59dbabf993f --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 f32ac702a2c545f44d594b994158c59dbabf993f --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=ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 21:18:02,490 truncating revision to first 12 chars 2017-08-07 21:18:02,490 Setting DEBUG logging. 2017-08-07 21:18:02,490 attempt 1/10 2017-08-07 21:18:02,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f32ac702a2c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-07 21:18:02,968 unpacking tar archive at: mozilla-beta-f32ac702a2c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.809542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:03.687860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:03.691221) ========= script_repo_revision: f32ac702a2c545f44d594b994158c59dbabf993f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:03.691644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:03.691944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 21:18:03.700899) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-07 21:18:03.701225) ========= /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=ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:18:03 INFO - MultiFileLogger online at 20170807 21:18:03 in /builds/slave/test 21:18:03 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 21:18:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:18:03 INFO - {'append_to_log': False, 21:18:03 INFO - 'base_work_dir': '/builds/slave/test', 21:18:03 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 21:18:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:18:03 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 21:18:03 INFO - 'buildbot_json_path': 'buildprops.json', 21:18:03 INFO - 'code_coverage': False, 21:18:03 INFO - 'config_files': ('talos/linux_config.py',), 21:18:03 INFO - 'default_actions': ('clobber', 21:18:03 INFO - 'read-buildbot-config', 21:18:03 INFO - 'download-and-extract', 21:18:03 INFO - 'populate-webroot', 21:18:03 INFO - 'create-virtualenv', 21:18:03 INFO - 'install', 21:18:03 INFO - 'setup-mitmproxy', 21:18:03 INFO - 'run-tests'), 21:18:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:18:03 INFO - 'disable_ccov_upload': False, 21:18:03 INFO - 'download_minidump_stackwalk': True, 21:18:03 INFO - 'download_symbols': 'ondemand', 21:18:03 INFO - 'enable_stylo': False, 21:18:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:18:03 INFO - 'tooltool.py': '/tools/tooltool.py', 21:18:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:18:03 INFO - '/tools/misc-python/virtualenv.py')}, 21:18:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:18:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:18:03 INFO - 'gecko_profile': False, 21:18:03 INFO - 'gecko_profile_interval': 0, 21:18:03 INFO - 'installer_path': 'installer.exe', 21:18:03 INFO - 'log_level': 'info', 21:18:03 INFO - 'log_name': 'talos', 21:18:03 INFO - 'log_to_console': True, 21:18:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:18:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:18:03 INFO - 'opt_config_files': (), 21:18:03 INFO - 'pip_index': False, 21:18:03 INFO - 'suite': 'dromaeojs-e10s', 21:18:03 INFO - 'system_bits': '32', 21:18:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:18:03 INFO - 'title': 'talos-linux64-ix-029', 21:18:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:18:03 INFO - 'use_talos_json': True, 21:18:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:18:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:18:03 INFO - 'work_dir': 'build'} 21:18:03 INFO - [mozharness: 2017-08-08 04:18:03.523768Z] Running clobber step. 21:18:03 INFO - Running pre-action listener: _resource_record_pre_action 21:18:03 INFO - Running main action method: clobber 21:18:03 INFO - rmtree: /builds/slave/test/build 21:18:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:18:04 INFO - Running post-action listener: _resource_record_post_action 21:18:04 INFO - [mozharness: 2017-08-08 04:18:04.501913Z] Finished clobber step (success) 21:18:04 INFO - [mozharness: 2017-08-08 04:18:04.502017Z] Running read-buildbot-config step. 21:18:04 INFO - Running pre-action listener: _resource_record_pre_action 21:18:04 INFO - Running main action method: read_buildbot_config 21:18:04 INFO - Using buildbot properties: 21:18:04 INFO - { 21:18:04 INFO - "project": "", 21:18:04 INFO - "product": "firefox", 21:18:04 INFO - "who": "asasaki@mozilla.com", 21:18:04 INFO - "installer_path": "public/build/target.tar.bz2", 21:18:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 21:18:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 21:18:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 21:18:04 INFO - "stage_platform": "linux64", 21:18:04 INFO - "basedir": "/builds/slave/test", 21:18:04 INFO - "buildnumber": 41, 21:18:04 INFO - "platform": "ubuntu64_hw", 21:18:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:18:04 INFO - "slavebuilddir": "test", 21:18:04 INFO - "taskId": "ZlZqwuAoTlWDqHRg4y5mcA", 21:18:04 INFO - "branch": "mozilla-beta", 21:18:04 INFO - "script_repo_revision": "production", 21:18:04 INFO - "revision": "f32ac702a2c545f44d594b994158c59dbabf993f", 21:18:04 INFO - "slavename": "talos-linux64-ix-029", 21:18:04 INFO - "repo_path": "releases/mozilla-beta" 21:18:04 INFO - } 21:18:04 INFO - Finding installer, test and symbols from parent task. 21:18:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZlZqwuAoTlWDqHRg4y5mcA'}, attempt #1 21:18:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZlZqwuAoTlWDqHRg4y5mcA'}, attempt #1 21:18:05 INFO - Task dependencies: X3gZNDbARHiwvp6U36z5Eg 21:18:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg'}, attempt #1 21:18:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2 21:18:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.test_packages.json 21:18:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.crashreporter-symbols.zip 21:18:05 INFO - Running post-action listener: _resource_record_post_action 21:18:05 INFO - [mozharness: 2017-08-08 04:18:05.866251Z] Finished read-buildbot-config step (success) 21:18:05 INFO - [mozharness: 2017-08-08 04:18:05.866474Z] Running download-and-extract step. 21:18:05 INFO - Running pre-action listener: _resource_record_pre_action 21:18:05 INFO - Running main action method: download_and_extract 21:18:05 INFO - mkdir: /builds/slave/test/build/tests 21:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:05 INFO - trying https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.test_packages.json 21:18:05 INFO - Downloading https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:18:06 INFO - Downloaded 989 bytes. 21:18:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:18:06 INFO - Using the following test package requirements: 21:18:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:18:06 INFO - u'common': [u'target.common.tests.zip'], 21:18:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:18:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:18:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:18:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:18:06 INFO - u'mozbase': [u'target.common.tests.zip'], 21:18:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:18:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:18:06 INFO - u'web-platform': [u'target.common.tests.zip', 21:18:06 INFO - u'target.web-platform.tests.tar.gz'], 21:18:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:18:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.common.tests.zip 21:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.common.tests.zip into memory 21:18:09 INFO - Content-Length response header: 72821095 21:18:09 INFO - Bytes received: 72821095 21:18:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:18:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.common.tests.zip 21:18:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:18:20 INFO - Fetch https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.common.tests.zip into memory 21:18:21 INFO - Content-Length response header: 72821095 21:18:21 INFO - Bytes received: 72821095 21:18:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.talos.tests.zip 21:18:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:18:38 INFO - Fetch https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.talos.tests.zip into memory 21:18:39 INFO - Content-Length response header: 14496472 21:18:39 INFO - Bytes received: 14496472 21:18:39 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')]} 21:18:39 INFO - trying https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2 21:18:39 INFO - Downloading https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:18:41 INFO - Downloaded 53655069 bytes. 21:18:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2 21:18:41 INFO - mkdir: /builds/slave/test/properties 21:18:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:18:41 INFO - Writing to file /builds/slave/test/properties/build_url 21:18:41 INFO - Contents: 21:18:41 INFO - build_url:https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2 21:18:41 INFO - Running post-action listener: _resource_record_post_action 21:18:41 INFO - Running post-action listener: set_extra_try_arguments 21:18:41 INFO - [mozharness: 2017-08-08 04:18:41.570842Z] Finished download-and-extract step (success) 21:18:41 INFO - [mozharness: 2017-08-08 04:18:41.570940Z] Running populate-webroot step. 21:18:41 INFO - Running pre-action listener: _resource_record_pre_action 21:18:41 INFO - Running main action method: populate_webroot 21:18:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:18:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:18:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:18:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:18:41 INFO - 'tests': ['damp', 'tps']}, 21:18:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:18:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:18:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:18:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:18:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:18:41 INFO - 'ts_paint', 21:18:41 INFO - 'tpaint', 21:18:41 INFO - 'sessionrestore', 21:18:41 INFO - 'sessionrestore_many_windows', 21:18:41 INFO - 'sessionrestore_no_auto_restore', 21:18:41 INFO - 'tabpaint']}, 21:18:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:18:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 21:18:41 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:18:41 INFO - 'talos_options': ['--mitmproxy', 21:18:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:18:41 INFO - '--firstNonBlankPaint'], 21:18:41 INFO - 'tests': ['quantum_pageload_google', 21:18:41 INFO - 'quantum_pageload_youtube', 21:18:41 INFO - 'quantum_pageload_amazon', 21:18:41 INFO - 'quantum_pageload_facebook']}, 21:18:41 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:18:41 INFO - 'talos_options': ['--stylo', 21:18:41 INFO - '--mitmproxy', 21:18:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:18:41 INFO - '--firstNonBlankPaint'], 21:18:41 INFO - 'tests': ['quantum_pageload_google', 21:18:41 INFO - 'quantum_pageload_youtube', 21:18:41 INFO - 'quantum_pageload_amazon', 21:18:41 INFO - 'quantum_pageload_facebook']}, 21:18:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:18:41 INFO - 'tsvgr_opacity', 21:18:41 INFO - 'tart', 21:18:41 INFO - 'tscrollx', 21:18:41 INFO - 'cart', 21:18:41 INFO - 'tsvg_static']}, 21:18:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:18:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:18:41 INFO - 'talos_options': ['--stylo', 21:18:41 INFO - '--stylo-threads=1', 21:18:41 INFO - '--mitmproxy', 21:18:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:18:41 INFO - '--firstNonBlankPaint'], 21:18:41 INFO - 'tests': ['tp6_google', 21:18:41 INFO - 'tp6_youtube', 21:18:41 INFO - 'tp6_amazon', 21:18:41 INFO - 'tp6_facebook']}, 21:18:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:18:41 INFO - 'talos_options': ['--xperf_path', 21:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:18:41 INFO - 'tests': ['tp5n']}}} 21:18:41 INFO - Running post-action listener: _resource_record_post_action 21:18:41 INFO - [mozharness: 2017-08-08 04:18:41.579558Z] Finished populate-webroot step (success) 21:18:41 INFO - [mozharness: 2017-08-08 04:18:41.579648Z] Running create-virtualenv step. 21:18:41 INFO - Running pre-action listener: _resource_record_pre_action 21:18:41 INFO - Running main action method: create_virtualenv 21:18:41 INFO - Creating virtualenv /builds/slave/test/build/venv 21:18:41 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 21:18:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:18:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:18:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:18:41 INFO - Using real prefix '/usr' 21:18:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:18:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:18:44 INFO - Installing pip.................done. 21:18:44 INFO - Return code: 0 21:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:18:44 INFO - Reading from file tmpfile_stdout 21:18:44 INFO - Output received: 21:18:44 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) 21:18:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:18:44 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')]} 21:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:44 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')]} 21:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:44 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:44 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 21:18:44 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 21:18:44 INFO - Using env: {'DISPLAY': ':0', 21:18:44 INFO - 'HOME': '/home/cltbld', 21:18:44 INFO - 'LANG': 'en_US.UTF-8', 21:18:44 INFO - 'LANGUAGE': 'en_US:en', 21:18:44 INFO - 'LOGNAME': 'cltbld', 21:18:44 INFO - 'MAIL': '/var/mail/cltbld', 21:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:44 INFO - 'MOZ_NO_REMOTE': '1', 21:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:44 INFO - 'NO_EM_RESTART': '1', 21:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:44 INFO - 'PWD': '/builds/slave/test', 21:18:44 INFO - 'SHELL': '/bin/bash', 21:18:44 INFO - 'SHLVL': '1', 21:18:44 INFO - 'TERM': 'linux', 21:18:44 INFO - 'TMOUT': '86400', 21:18:44 INFO - 'USER': 'cltbld', 21:18:44 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:44 INFO - '_': '/tools/buildbot/bin/python'} 21:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:44 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 21:18:44 INFO - Cleaning up... 21:18:44 INFO - Return code: 0 21:18:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:18:44 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')]} 21:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:44 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')]} 21:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:44 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:44 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 21:18:44 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 21:18:44 INFO - Using env: {'DISPLAY': ':0', 21:18:44 INFO - 'HOME': '/home/cltbld', 21:18:44 INFO - 'LANG': 'en_US.UTF-8', 21:18:44 INFO - 'LANGUAGE': 'en_US:en', 21:18:44 INFO - 'LOGNAME': 'cltbld', 21:18:44 INFO - 'MAIL': '/var/mail/cltbld', 21:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:44 INFO - 'MOZ_NO_REMOTE': '1', 21:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:44 INFO - 'NO_EM_RESTART': '1', 21:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:44 INFO - 'PWD': '/builds/slave/test', 21:18:44 INFO - 'SHELL': '/bin/bash', 21:18:44 INFO - 'SHLVL': '1', 21:18:44 INFO - 'TERM': 'linux', 21:18:44 INFO - 'TMOUT': '86400', 21:18:44 INFO - 'USER': 'cltbld', 21:18:44 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:44 INFO - '_': '/tools/buildbot/bin/python'} 21:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:45 INFO - Downloading/unpacking psutil>=3.1.1 21:18:45 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 21:18:45 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 21:18:45 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 21:18:45 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 21:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:18:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:18:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:18:46 INFO - Installing collected packages: psutil 21:18:46 INFO - Running setup.py install for psutil 21:18:46 INFO - building 'psutil._psutil_linux' extension 21:18:46 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 21:18:47 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 21:18:47 INFO - building 'psutil._psutil_posix' extension 21:18:47 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 21:18:47 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 21:18:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:18:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:18:47 INFO - Successfully installed psutil 21:18:47 INFO - Cleaning up... 21:18:47 INFO - Return code: 0 21:18:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:18:47 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')]} 21:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:47 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')]} 21:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:47 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:47 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 21:18:47 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 21:18:47 INFO - Using env: {'DISPLAY': ':0', 21:18:47 INFO - 'HOME': '/home/cltbld', 21:18:47 INFO - 'LANG': 'en_US.UTF-8', 21:18:47 INFO - 'LANGUAGE': 'en_US:en', 21:18:47 INFO - 'LOGNAME': 'cltbld', 21:18:47 INFO - 'MAIL': '/var/mail/cltbld', 21:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:47 INFO - 'MOZ_NO_REMOTE': '1', 21:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:47 INFO - 'NO_EM_RESTART': '1', 21:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:47 INFO - 'PWD': '/builds/slave/test', 21:18:47 INFO - 'SHELL': '/bin/bash', 21:18:47 INFO - 'SHLVL': '1', 21:18:47 INFO - 'TERM': 'linux', 21:18:47 INFO - 'TMOUT': '86400', 21:18:47 INFO - 'USER': 'cltbld', 21:18:47 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:47 INFO - '_': '/tools/buildbot/bin/python'} 21:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:18:47 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 21:18:47 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 21:18:47 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 21:18:47 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 21:18:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:18:49 INFO - Installing collected packages: mozsystemmonitor 21:18:49 INFO - Running setup.py install for mozsystemmonitor 21:18:49 INFO - Successfully installed mozsystemmonitor 21:18:49 INFO - Cleaning up... 21:18:49 INFO - Return code: 0 21:18:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:18:49 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')]} 21:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:49 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')]} 21:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:49 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:49 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 21:18:49 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 21:18:49 INFO - Using env: {'DISPLAY': ':0', 21:18:49 INFO - 'HOME': '/home/cltbld', 21:18:49 INFO - 'LANG': 'en_US.UTF-8', 21:18:49 INFO - 'LANGUAGE': 'en_US:en', 21:18:49 INFO - 'LOGNAME': 'cltbld', 21:18:49 INFO - 'MAIL': '/var/mail/cltbld', 21:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:49 INFO - 'MOZ_NO_REMOTE': '1', 21:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:49 INFO - 'NO_EM_RESTART': '1', 21:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:49 INFO - 'PWD': '/builds/slave/test', 21:18:49 INFO - 'SHELL': '/bin/bash', 21:18:49 INFO - 'SHLVL': '1', 21:18:49 INFO - 'TERM': 'linux', 21:18:49 INFO - 'TMOUT': '86400', 21:18:49 INFO - 'USER': 'cltbld', 21:18:49 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:49 INFO - '_': '/tools/buildbot/bin/python'} 21:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:49 INFO - Downloading/unpacking jsonschema==2.5.1 21:18:49 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 21:18:49 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 21:18:49 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 21:18:49 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 21:18:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:18:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:18:50 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 21:18:50 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 21:18:50 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 21:18:50 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 21:18:50 INFO - Downloading functools32-3.2.3-2.tar.gz 21:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:18:50 INFO - warning: no files found matching '*.txt' 21:18:50 INFO - no previously-included directories found matching 'build' 21:18:50 INFO - no previously-included directories found matching 'dist' 21:18:50 INFO - no previously-included directories found matching '.git*' 21:18:50 INFO - Installing collected packages: jsonschema, functools32 21:18:50 INFO - Running setup.py install for functools32 21:18:50 INFO - warning: no files found matching '*.txt' 21:18:50 INFO - no previously-included directories found matching 'build' 21:18:50 INFO - no previously-included directories found matching 'dist' 21:18:50 INFO - no previously-included directories found matching '.git*' 21:18:50 INFO - Successfully installed jsonschema functools32 21:18:50 INFO - Cleaning up... 21:18:50 INFO - Return code: 0 21:18:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:18:50 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')]} 21:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:50 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')]} 21:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:50 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:50 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 21:18:50 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 21:18:50 INFO - Using env: {'DISPLAY': ':0', 21:18:50 INFO - 'HOME': '/home/cltbld', 21:18:50 INFO - 'LANG': 'en_US.UTF-8', 21:18:50 INFO - 'LANGUAGE': 'en_US:en', 21:18:50 INFO - 'LOGNAME': 'cltbld', 21:18:50 INFO - 'MAIL': '/var/mail/cltbld', 21:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:50 INFO - 'MOZ_NO_REMOTE': '1', 21:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:50 INFO - 'NO_EM_RESTART': '1', 21:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:50 INFO - 'PWD': '/builds/slave/test', 21:18:50 INFO - 'SHELL': '/bin/bash', 21:18:50 INFO - 'SHLVL': '1', 21:18:50 INFO - 'TERM': 'linux', 21:18:50 INFO - 'TMOUT': '86400', 21:18:50 INFO - 'USER': 'cltbld', 21:18:50 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:50 INFO - '_': '/tools/buildbot/bin/python'} 21:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:18:51 INFO - Cleaning up... 21:18:51 INFO - Return code: 0 21:18:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:18:51 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')]} 21:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:51 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')]} 21:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:51 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:51 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 21:18:51 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 21:18:51 INFO - Using env: {'DISPLAY': ':0', 21:18:51 INFO - 'HOME': '/home/cltbld', 21:18:51 INFO - 'LANG': 'en_US.UTF-8', 21:18:51 INFO - 'LANGUAGE': 'en_US:en', 21:18:51 INFO - 'LOGNAME': 'cltbld', 21:18:51 INFO - 'MAIL': '/var/mail/cltbld', 21:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:51 INFO - 'MOZ_NO_REMOTE': '1', 21:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:51 INFO - 'NO_EM_RESTART': '1', 21:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:51 INFO - 'PWD': '/builds/slave/test', 21:18:51 INFO - 'SHELL': '/bin/bash', 21:18:51 INFO - 'SHLVL': '1', 21:18:51 INFO - 'TERM': 'linux', 21:18:51 INFO - 'TMOUT': '86400', 21:18:51 INFO - 'USER': 'cltbld', 21:18:51 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:51 INFO - '_': '/tools/buildbot/bin/python'} 21:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:51 INFO - Downloading/unpacking blobuploader==1.2.4 21:18:51 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 21:18:51 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 21:18:51 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 21:18:51 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 21:18:52 INFO - Downloading blobuploader-1.2.4.tar.gz 21:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:18:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:18:52 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 21:18:52 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 21:18:52 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 21:18:52 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 21:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:18:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:18:52 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 21:18:52 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 21:18:52 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 21:18:52 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 21:18:52 INFO - Downloading docopt-0.6.1.tar.gz 21:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:18:53 INFO - Installing collected packages: blobuploader, requests, docopt 21:18:53 INFO - Running setup.py install for blobuploader 21:18:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:18:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:18:53 INFO - Running setup.py install for requests 21:18:53 INFO - Running setup.py install for docopt 21:18:53 INFO - Successfully installed blobuploader requests docopt 21:18:53 INFO - Cleaning up... 21:18:53 INFO - Return code: 0 21:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:53 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:53 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 21:18:53 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 21:18:53 INFO - Using env: {'DISPLAY': ':0', 21:18:53 INFO - 'HOME': '/home/cltbld', 21:18:53 INFO - 'LANG': 'en_US.UTF-8', 21:18:53 INFO - 'LANGUAGE': 'en_US:en', 21:18:53 INFO - 'LOGNAME': 'cltbld', 21:18:53 INFO - 'MAIL': '/var/mail/cltbld', 21:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:53 INFO - 'MOZ_NO_REMOTE': '1', 21:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:53 INFO - 'NO_EM_RESTART': '1', 21:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:53 INFO - 'PWD': '/builds/slave/test', 21:18:53 INFO - 'SHELL': '/bin/bash', 21:18:53 INFO - 'SHLVL': '1', 21:18:53 INFO - 'TERM': 'linux', 21:18:53 INFO - 'TMOUT': '86400', 21:18:53 INFO - 'USER': 'cltbld', 21:18:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:53 INFO - '_': '/tools/buildbot/bin/python'} 21:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:53 INFO - Running setup.py (path:/tmp/pip-Hb8ofr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:53 INFO - Running setup.py (path:/tmp/pip-VnUK01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:54 INFO - Running setup.py (path:/tmp/pip-F5M7gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:54 INFO - Running setup.py (path:/tmp/pip-6JNa6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:54 INFO - Running setup.py (path:/tmp/pip-ivCEqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:54 INFO - Running setup.py (path:/tmp/pip-9q92iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:54 INFO - Running setup.py (path:/tmp/pip-nb4umF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:54 INFO - Running setup.py (path:/tmp/pip-faJ1jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:54 INFO - Running setup.py (path:/tmp/pip-Y0R4Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:54 INFO - Running setup.py (path:/tmp/pip-FPZGYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:54 INFO - Running setup.py (path:/tmp/pip-Kw5US5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:54 INFO - Running setup.py (path:/tmp/pip-lKuTNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:54 INFO - Running setup.py (path:/tmp/pip-L1LtoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:54 INFO - Running setup.py (path:/tmp/pip-PH71MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:54 INFO - Running setup.py (path:/tmp/pip-06HMbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:54 INFO - Running setup.py (path:/tmp/pip-7EjPO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:55 INFO - Running setup.py (path:/tmp/pip-mWv7nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:18:55 INFO - Running setup.py install for manifestparser 21:18:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Running setup.py install for mozcrash 21:18:55 INFO - Running setup.py install for mozdebug 21:18:55 INFO - Running setup.py install for mozdevice 21:18:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Running setup.py install for mozfile 21:18:55 INFO - Running setup.py install for mozhttpd 21:18:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Running setup.py install for mozinfo 21:18:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Running setup.py install for mozInstall 21:18:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:18:55 INFO - Running setup.py install for mozleak 21:18:55 INFO - Running setup.py install for mozlog 21:18:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Running setup.py install for moznetwork 21:18:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Running setup.py install for mozprocess 21:18:56 INFO - Running setup.py install for mozprofile 21:18:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Running setup.py install for mozrunner 21:18:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Running setup.py install for mozscreenshot 21:18:56 INFO - Running setup.py install for moztest 21:18:56 INFO - Running setup.py install for mozversion 21:18:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:18:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:18:56 INFO - Cleaning up... 21:18:56 INFO - Return code: 0 21:18:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:56 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')]} 21:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:56 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')]} 21:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:56 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:56 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 21:18:56 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 21:18:56 INFO - Using env: {'DISPLAY': ':0', 21:18:56 INFO - 'HOME': '/home/cltbld', 21:18:56 INFO - 'LANG': 'en_US.UTF-8', 21:18:56 INFO - 'LANGUAGE': 'en_US:en', 21:18:56 INFO - 'LOGNAME': 'cltbld', 21:18:56 INFO - 'MAIL': '/var/mail/cltbld', 21:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:56 INFO - 'MOZ_NO_REMOTE': '1', 21:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:56 INFO - 'NO_EM_RESTART': '1', 21:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:56 INFO - 'PWD': '/builds/slave/test', 21:18:56 INFO - 'SHELL': '/bin/bash', 21:18:56 INFO - 'SHLVL': '1', 21:18:56 INFO - 'TERM': 'linux', 21:18:56 INFO - 'TMOUT': '86400', 21:18:56 INFO - 'USER': 'cltbld', 21:18:56 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:56 INFO - '_': '/tools/buildbot/bin/python'} 21:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:57 INFO - Running setup.py (path:/tmp/pip-QIRxvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:57 INFO - Running setup.py (path:/tmp/pip-9tpex5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:57 INFO - Running setup.py (path:/tmp/pip-x9zucu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:57 INFO - Running setup.py (path:/tmp/pip-Xg7s32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:57 INFO - Running setup.py (path:/tmp/pip-J2wJAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:57 INFO - Running setup.py (path:/tmp/pip-DVDcVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:57 INFO - Running setup.py (path:/tmp/pip-LJaPkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:57 INFO - Running setup.py (path:/tmp/pip-Il9TKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:57 INFO - Running setup.py (path:/tmp/pip-pBwPgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:57 INFO - Running setup.py (path:/tmp/pip-fPiO0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:57 INFO - Running setup.py (path:/tmp/pip-ZmK6dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:57 INFO - Running setup.py (path:/tmp/pip-DFc9p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:57 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)) 21:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:57 INFO - Running setup.py (path:/tmp/pip-il_iyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:58 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)) 21:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:58 INFO - Running setup.py (path:/tmp/pip-pAgtNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:58 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)) 21:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:58 INFO - Running setup.py (path:/tmp/pip-ZhQdp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:58 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)) 21:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:58 INFO - Running setup.py (path:/tmp/pip-w1VAyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:58 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)) 21:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:58 INFO - Running setup.py (path:/tmp/pip-Rz97qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:58 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)) 21:18:58 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)) 21:18:58 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)) 21:18:58 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)) 21:18:58 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)) 21:18:58 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)) 21:18:58 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)) 21:18:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:59 INFO - Downloading blessings-1.6.tar.gz 21:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:18:59 INFO - Installing collected packages: blessings 21:18:59 INFO - Running setup.py install for blessings 21:18:59 INFO - Successfully installed blessings 21:18:59 INFO - Cleaning up... 21:18:59 INFO - Return code: 0 21:18:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:59 INFO - Reading from file tmpfile_stdout 21:18:59 INFO - Current package versions: 21:18:59 INFO - argparse == 1.2.1 21:18:59 INFO - blessings == 1.6 21:18:59 INFO - blobuploader == 1.2.4 21:18:59 INFO - docopt == 0.6.1 21:18:59 INFO - functools32 == 3.2.3-2 21:18:59 INFO - jsonschema == 2.5.1 21:18:59 INFO - manifestparser == 1.1 21:18:59 INFO - mozInstall == 1.13 21:18:59 INFO - mozcrash == 1.0 21:18:59 INFO - mozdebug == 0.1 21:18:59 INFO - mozdevice == 0.51 21:18:59 INFO - mozfile == 1.2 21:18:59 INFO - mozhttpd == 0.7 21:18:59 INFO - mozinfo == 0.10 21:18:59 INFO - mozleak == 0.1 21:18:59 INFO - mozlog == 3.5 21:18:59 INFO - moznetwork == 0.27 21:18:59 INFO - mozprocess == 0.25 21:18:59 INFO - mozprofile == 0.28 21:18:59 INFO - mozrunner == 6.13 21:18:59 INFO - mozscreenshot == 0.1 21:18:59 INFO - mozsystemmonitor == 0.3 21:18:59 INFO - moztest == 0.8 21:18:59 INFO - mozversion == 1.4 21:18:59 INFO - psutil == 3.1.1 21:18:59 INFO - requests == 1.2.3 21:18:59 INFO - wsgiref == 0.1.2 21:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:59 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')]} 21:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:59 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')]} 21:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:59 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 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:18:59 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 21:18:59 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 21:18:59 INFO - Using env: {'DISPLAY': ':0', 21:18:59 INFO - 'HOME': '/home/cltbld', 21:18:59 INFO - 'LANG': 'en_US.UTF-8', 21:18:59 INFO - 'LANGUAGE': 'en_US:en', 21:18:59 INFO - 'LOGNAME': 'cltbld', 21:18:59 INFO - 'MAIL': '/var/mail/cltbld', 21:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:59 INFO - 'MOZ_NO_REMOTE': '1', 21:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:59 INFO - 'NO_EM_RESTART': '1', 21:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:59 INFO - 'PWD': '/builds/slave/test', 21:18:59 INFO - 'SHELL': '/bin/bash', 21:18:59 INFO - 'SHLVL': '1', 21:18:59 INFO - 'TERM': 'linux', 21:18:59 INFO - 'TMOUT': '86400', 21:18:59 INFO - 'USER': 'cltbld', 21:18:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:59 INFO - '_': '/tools/buildbot/bin/python'} 21:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 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)) 21:19:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:19:01 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)) 21:19:01 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)) 21:19:01 INFO - Installing collected packages: simplejson 21:19:01 INFO - Running setup.py install for simplejson 21:19:01 INFO - building 'simplejson._speedups' extension 21:19:01 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 21:19:02 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 21:19:02 INFO - Successfully installed simplejson 21:19:02 INFO - Cleaning up... 21:19:02 INFO - Return code: 0 21:19:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', '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 21:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:19:02 INFO - Using env: {'DISPLAY': ':0', 21:19:02 INFO - 'HOME': '/home/cltbld', 21:19:02 INFO - 'LANG': 'en_US.UTF-8', 21:19:02 INFO - 'LANGUAGE': 'en_US:en', 21:19:02 INFO - 'LOGNAME': 'cltbld', 21:19:02 INFO - 'MAIL': '/var/mail/cltbld', 21:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:02 INFO - 'MOZ_NO_REMOTE': '1', 21:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:02 INFO - 'NO_EM_RESTART': '1', 21:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:02 INFO - 'PWD': '/builds/slave/test', 21:19:02 INFO - 'SHELL': '/bin/bash', 21:19:02 INFO - 'SHLVL': '1', 21:19:02 INFO - 'TERM': 'linux', 21:19:02 INFO - 'TMOUT': '86400', 21:19:02 INFO - 'USER': 'cltbld', 21:19:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:02 INFO - '_': '/tools/buildbot/bin/python'} 21:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:19:02 INFO - Cleaning up... 21:19:02 INFO - Return code: 0 21:19:02 INFO - Running post-action listener: _resource_record_post_action 21:19:02 INFO - Running post-action listener: _start_resource_monitoring 21:19:02 INFO - Starting resource monitoring. 21:19:02 INFO - [mozharness: 2017-08-08 04:19:02.650605Z] Finished create-virtualenv step (success) 21:19:02 INFO - [mozharness: 2017-08-08 04:19:02.651598Z] Running install step. 21:19:02 INFO - Running pre-action listener: _resource_record_pre_action 21:19:02 INFO - Running main action method: install 21:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:19:02 INFO - Reading from file tmpfile_stdout 21:19:02 INFO - Detecting whether we're running mozinstall >=1.0... 21:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:19:03 INFO - Reading from file tmpfile_stdout 21:19:03 INFO - Output received: 21:19:03 INFO - Usage: mozinstall [options] installer 21:19:03 INFO - Options: 21:19:03 INFO - -h, --help show this help message and exit 21:19:03 INFO - -d DEST, --destination=DEST 21:19:03 INFO - Directory to install application into. [default: 21:19:03 INFO - "/builds/slave/test"] 21:19:03 INFO - --app=APP Application being installed. [default: firefox] 21:19:03 INFO - mkdir: /builds/slave/test/build/application 21:19:03 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'] 21:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:19:17 INFO - Reading from file tmpfile_stdout 21:19:17 INFO - Output received: 21:19:17 INFO - /builds/slave/test/build/application/firefox/firefox 21:19:17 INFO - Running post-action listener: _resource_record_post_action 21:19:17 INFO - [mozharness: 2017-08-08 04:19:17.680720Z] Finished install step (success) 21:19:17 INFO - [mozharness: 2017-08-08 04:19:17.680870Z] Running setup-mitmproxy step. 21:19:17 INFO - Running pre-action listener: _resource_record_pre_action 21:19:17 INFO - Running main action method: setup_mitmproxy 21:19:17 INFO - Skipping: mitmproxy is not required 21:19:17 INFO - Running post-action listener: _resource_record_post_action 21:19:17 INFO - [mozharness: 2017-08-08 04:19:17.682068Z] Finished setup-mitmproxy step (success) 21:19:17 INFO - [mozharness: 2017-08-08 04:19:17.682381Z] Running run-tests step. 21:19:17 INFO - Running pre-action listener: _resource_record_pre_action 21:19:17 INFO - Running pre-action listener: _set_gcov_prefix 21:19:17 INFO - Running main action method: run_tests 21:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:19:17 INFO - Python 2.7.3 21:19:17 INFO - Return code: 0 21:19:17 INFO - grabbing minidump binary from tooltool 21:19:17 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')]} 21:19:17 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 0x1cf0050>, '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 0x1cf0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf13e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:19:17 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 21:19:17 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 21:19:17 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 21:19:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:19:17 INFO - Return code: 0 21:19:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:19:17 INFO - ENV: RUST_BACKTRACE is now 1 21:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:19:17 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/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 21:19:17 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/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 21:19:17 INFO - Using env: {'DISPLAY': ':0', 21:19:17 INFO - 'HOME': '/home/cltbld', 21:19:17 INFO - 'LANG': 'en_US.UTF-8', 21:19:17 INFO - 'LANGUAGE': 'en_US:en', 21:19:17 INFO - 'LOGNAME': 'cltbld', 21:19:17 INFO - 'MAIL': '/var/mail/cltbld', 21:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:17 INFO - 'MOZ_NO_REMOTE': '1', 21:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:17 INFO - 'NO_EM_RESTART': '1', 21:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:17 INFO - 'PWD': '/builds/slave/test', 21:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:19:17 INFO - 'RUST_BACKTRACE': '1', 21:19:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:19:17 INFO - 'SHELL': '/bin/bash', 21:19:17 INFO - 'SHLVL': '1', 21:19:17 INFO - 'TERM': 'linux', 21:19:17 INFO - 'TMOUT': '86400', 21:19:17 INFO - 'USER': 'cltbld', 21:19:17 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668', 21:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:17 INFO - '_': '/tools/buildbot/bin/python'} 21:19:17 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/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 21:19:18 INFO - mozversion application_buildid: 20170808030909 21:19:18 INFO - mozversion application_changeset: f32ac702a2c545f44d594b994158c59dbabf993f 21:19:18 INFO - mozversion application_display_name: Firefox 21:19:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:19:18 INFO - mozversion application_name: Firefox 21:19:18 INFO - mozversion application_remotingname: firefox 21:19:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:19:18 INFO - mozversion application_vendor: Mozilla 21:19:18 INFO - mozversion application_version: 56.0 21:19:18 INFO - mozversion platform_buildid: 20170808030909 21:19:18 INFO - mozversion platform_changeset: f32ac702a2c545f44d594b994158c59dbabf993f 21:19:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:19:18 INFO - mozversion platform_version: 56.0 21:19:18 INFO - using testdate: 1502165958 21:19:18 INFO - actual date: 1502165958 21:19:18 INFO - starting webserver on 'localhost:57095' 21:19:18 INFO - SUITE-START | Running 2 tests 21:19:18 INFO - TEST-START | dromaeo_css 21:19:18 INFO - Initialising browser for dromaeo_css test... 21:19:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57095/getInfo.html -profile /tmp/tmppDEVei/profile 21:19:18 INFO - TEST-INFO | started process 3329 (/builds/slave/test/build/application/firefox/firefox http://localhost:57095/getInfo.html) 21:19:24 INFO - TEST-INFO | 3329: exit 0 21:19:25 INFO - Browser initialized. 21:19:25 INFO - Running cycle 1/1 for dromaeo_css test... 21:19:25 INFO - TEST-INFO | started process 3496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppDEVei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:19:25 INFO - PID 3496 | 1502165965406 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 21:19:25 INFO - PID 3496 | 21:19:25 INFO - PID 3496 | (/builds/slave/test/build/application/firefox/firefox:3546): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:19:25 INFO - PID 3496 | 21:19:36 INFO - PID 3496 | RSS: Main: 139214848 21:19:36 INFO - PID 3496 | 21:22:34 INFO - PID 3496 | Cycle 1(1): loaded http://localhost:57095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57095/tests/dromaeo/cssquery-ext.html) 21:22:35 INFO - PID 3496 | RSS: Main: 149110784 21:22:35 INFO - PID 3496 | 21:25:36 INFO - PID 3496 | Cycle 1(1): loaded http://localhost:57095/tests/dromaeo/cssquery-ext.html (next: http://localhost:57095/tests/dromaeo/cssquery-jquery.html) 21:25:37 INFO - PID 3496 | RSS: Main: 148066304 21:25:37 INFO - PID 3496 | 21:28:38 INFO - PID 3496 | Cycle 1(1): loaded http://localhost:57095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57095/tests/dromaeo/cssquery-mootools.html) 21:28:39 INFO - PID 3496 | RSS: Main: 149848064 21:28:39 INFO - PID 3496 | 21:31:41 INFO - PID 3496 | Cycle 1(1): loaded http://localhost:57095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57095/tests/dromaeo/cssquery-prototype.html) 21:31:41 INFO - PID 3496 | RSS: Main: 150466560 21:31:41 INFO - PID 3496 | 21:34:44 INFO - PID 3496 | Cycle 1(1): loaded http://localhost:57095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57095/tests/dromaeo/cssquery-yui.html) 21:34:45 INFO - PID 3496 | RSS: Main: 152981504 21:34:45 INFO - PID 3496 | 21:37:46 INFO - PID 3496 | Cycle 1(1): loaded http://localhost:57095/tests/dromaeo/cssquery-yui.html (next: http://localhost:57095/tests/dromaeo/cssquery-dojo.html) 21:37:47 INFO - PID 3496 | RSS: Main: 155627520 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | __start_tp_report 21:37:47 INFO - PID 3496 | _x_x_mozilla_page_load 21:37:47 INFO - PID 3496 | _x_x_mozilla_page_load_details 21:37:47 INFO - PID 3496 | |i|pagename|runs| 21:37:47 INFO - PID 3496 | |0;dojo.html;3576.9463458048117;3582.3909935310994;3602;3633.8001409922445;3642.435422509511;6410.839729006765;6416.9037464438015;6476.417122458984;6481.513886458511;6520.44576211022;6424.486041116711;6467.579607325521;6470.255920569136;6542.476601871839;6553.70508327124;5468.671879687212;5505.201745746865;5543.362513310981;5551;5566.972165139168;5597.6641401516035;5631.746571404276;5641.407652196522;5662.320521537401;5670.829875103754;5575.637583557096;5611.102223644198;5687.687177205252;5690.544756419497;5719.6854173020465;5512.090505066659;5554.50009499147;5560.888782224373;5645.830625081254;5646.068398714207;5585.525230355424;5612.607117501777;5617.831465056055;5620.044592419298;5626.803061892814;6240.438360547572;6275.058741188813;6284.622922624657;6312.337204593543;6344.619322840598;6776.966115169393;6851.657417129173;6888.173419189679;6914.55055421401;6987.301269873023;6967.233604303523;7008.544444611084;7036;7037.014817925495;7059.082319298458;6444.484441244689;6475.158229430238;6477.384648458389;6486.610803351814;6522.869542609121;7094.822629434202;7107.857842843217;7133.785986420312;7137.607431591312;7139.071920650283;6742.764003259862;6744.966275168593;6746.527743057939;6748.561343512656;6761.256261811197;6940.13248343957;6975.407090397373;6977.058097156921;6986.860262794716;7000.369966703021;6857.657117144123;6858.588484690935;6883.27725588816;6948.166220053525;6987.825304367329;6817.829554261084;6879.621620810904;6918.619475928772;6926.134233220848;7000.544964577286;5056.443791182967;5060.240963855451;5068.467810879878;5089.720065396439;5127.410347809975;4553.931691024637;4555.567221113989;4617.722936623813;4620.214563524209;4657.976710116428;6597.736090556324;6641.070250164981;6685.498587605949;6691.59850408977;6711.664416779142;6848.417884479775;6956.229189445854;6965.686544105527;7029.22678505364;7031.472639552054;6538;6594.538382313288;6622.933770662328;6626.734930602722;6626.801195964129;5728.283964504437;5745.482906538432;5748.13777933305;5748.453896879873;5749.626274292241;7203.243659415791;7313.926860731431;7318.670659820321;7320.67056982437;7326.3040011198855;6907.930920690729;6930.61881596517;6971.6165610891885;6993.615351155633;7049.400800931979;6979.720811167496;7158.570485770871;7227.313405226495;7255.891161632685;7321.304476074764;6804.183497980274;6885.724571017304;6888.070110535014;6888.896666549906;6889.173299204128;6978.267281935324;7026.473014524034;7031.894521582078;7035.507514473938;7040.788776336718;6759.391654751096;6765.932340676727;6836.760713375008;6855.4172895304455;6871.106756121672;6731.158605174353;6774.762883299061;6782.220044694924;6788.86422271542;6808.978653201862;6745.898811517733;6810.965945170243;6831.282715315019;6832.521723479507;6860.176778786577;6750.35871592198;6772.25505194438;6785.457163426815;6786.728530858711;6897.448204143556;6533.640649764118;6583.670816459254;6604.801855944329;6637.568558043712;6689.030090636733 21:37:47 INFO - PID 3496 | |1;ext.html;909.6997990663077;930.1860871737232;949.5869296855868;967.8741763570735;986.8667729856468;43535.564644353544;44155.77922110393;44354;44452.555474445246;44465.555344446584;40702.79648601753;40715.185696286055;40766;40779;40870.59129408705;7160.033395491607;7301.1968683444775;7304;7310.926890731078;7333.2666733326505;7197.424206063502;7237.782866514013;7258.383037441824;7295.051643286365;7309.853802923938;7217.242189570098;7249.71001159953;7279.818004549902;7284.9271507284775;7315.4147668186415;7252.129744430649;7256.8911466328045;7274.854502909939;7282.854342913139;7287.125544934615;6598;6643.169603799525;6646.202455705298;6648.301928297507;6659.966700166517;36332;36606.63393366059;36620;36639.08402289938;36650.45024324637;3527.2945410917664;3544.521489598897;3550.91122721934;3564.625714300013;3565.5186549815703;28574.428511429862;28604.14187574376;28706;28739.42521149586;28970;4530.0939812037395;4557.589816916494;4579.496255411902;4597.241455159928;4598.402207713009;208568;208900;221948;224881;229313;53827.19259211115;53936.46063539393;54091.729541352826;54118.45881541213;54206.728966354916;55507;55540.72229638826;55685.721571391885;55824.44175558274;55832.441675583534;17316.30734770595;17546;17549.473515794547;17552.736708949375;17806;14774.556763297118;14806.185659788815;14817.555473335817;14822.258887055605;14862.925685371503;13670.31648417595;13734.381952812148;13967.580972570839;14044.929775351058;14095.718085638435;5715.8571035724435;5741.598088133791;5816.302043754692;5884.352721200665;5949.970250148722;1124.7525544380223;1127.9661610151709;1128.853249077631;1129.1192869561755;1135.9091272698329;24722.25833225006;24885;24907;24983.250502484956;25021.624675629515;1180.3744015671707;1197.024425093546;1226.687194765347;1235.975280494385;1256.863332335034;13083.41124649393;13319.334033298297;13455.730885382432;13526.93236533811;13530.18818870871;285805;290336;290748;290823;290951;61638;61952;62154.0676889847;62196.37803621996;62412.37587624066;1558.0573752879345;1569.7645353197113;1577.37693611023;1592.8646065084365;1599.5521254048886;29375.706242937296;29669.25826854346;29758.404831902808;30117.849410753683;30414.695853041187;41014.179716404906;41353.58646413618;41359.37960930528;41367.793161034;41396.586034139276;226399;228156;228333;228800;230677;35387.29225415529;36630.450543242405;38424.2315153701;38634.42048369333;38999.2200156001;51540.74229628828;52577.21134183067;52784.73607631937;53044;53252;37294.44058339073;37511.81244093871;37616.81191594025;37947.430788538746;38017;37319.44020839635;37609.247815044095;37973.430398544595;38127.42808857814;38419.6158038416;42663.57336426596;44245.336319954586;44320.77839610782;44605.55394446144;44690;35143.648563514034;35713.64286357207;35749.28501430009;35852.64147358493;36049.459258110626;26821.731782681924;26900.578947894785;27012.054578089672;27359;27802.582961256 21:37:47 INFO - PID 3496 | |2;jquery.html;613.3008370457676;613.9938600613993;615.5875563372537;616.3924663143007;642.6433329502125;23799.167029153963;24331.39171520713;24430.14494492693;24522.87738561307;24559;26440.471190576176;27388.726112738867;27393;27396.726032739665;27404.588931166047;6319;6788.01573771804;6861.828454288658;6904.13698287714;6908.585484870899;6518.348165183467;6587.47300215984;6601;6604.141461610008;6606.8678626427445;6507.154069970921;6509.739610415601;6561.606303621774;6563.835904102388;6566.179227596551;6540.803775886731;6545.083688283644;6569.80290591283;6571;6572.277049524549;6093.512518998469;6098.939010609882;6107.603005804608;6132.908006379907;6149.754009839601;30831.691683083107;31303.843480782678;32364.676353236402;32465.188370290696;32499.51250731241;2349.917752878658;2360.6931098957198;2367.9289621311386;2369.9644505332435;2387.0809738250723;20019.299324523716;20600.175992960263;20684.689729654066;20773.89613051925;20787.27244546449;2406.217979156781;2437.744036876138;2559;2566.589345704697;2571.0230112557297;150853;155709.221453892;159017;160163;168450.1577492117;15861.796623894446;16109.19454027294;16856.831431685772;17004.404845830584;17084.658306833793;25386;25501.23496295114;25520.872395637904;25521.48957020849;25531;10866.45667716611;10921.781564368668;11081.113510919107;11083.224174307721;11089.445527723581;10045.899541004643;10061.79876402468;10094.293399461967;10186.490675466346;10277.845832312521;9818.80362392748;10277.794444111076;10370;10413.587527183563;10673.519691613896;2972.1677930179585;3001.1746769638526;3016.4570377332293;3030.712082352173;3086.6758990306143;1063.361982810323;1082.767205050902;1091.3560999010622;1092.5356723392686;1099.7855418193376;22354.217602384164;26481.735182647928;27766.444671106463;27942;28237;1084.3277168155794;1119.227732864321;1140.9657710268705;1158.8609366876028;1179.9941000294943;11784.705382365339;12345.444454999546;12486.25082495035;12540.122191446693;12578;614441;622293;630251;639312;642990;136048.31975840058;142418.28790855978;143947.28026359802;144565;146066.269668651;1353.9187648741106;1370.6984463418032;1383.156274672429;1394.4561620967831;1394.776835706282;19603.70594441056;19675.40973770789;19692.803071969098;19721.21115155435;19807.207711691946;61978;62278.06582901351;65313;67087.66456167688;68638.31361686319;79175.60412197902;79618.6019069901;79916;80243;80501.59749201217;15702.450414235447;16151.919240403722;16464.917675411547;16536.834631653528;16642.334306628083;26026.73973260319;26091.347716307246;26173.214803555922;26253.606195906694;26405.60391594166;20833.479163021046;21044.47388815292;21076.47308817292;21144.78855211428;21364;16633;16971.981681099172;17033.48899533016;17150.485485435456;18906.810931891054;21220.575588488453;21398.679019815027;21410.678839817727;21479;21593.35219943404;16114.355425782838;16258.756118658466;16307.347706091623;16405.605523530634;16406.26171822247;20273.79726202778;20398.592028159055;20521.692174617692;20587;20659.380218593466 21:37:47 INFO - PID 3496 | |3;mootools.html;1444.4727674398844;1492.1793013842384;1505.2248092232496;1517.1428143099151;1528.3886445421822;15852.682946341081;16581.585460363483;16589.25348359324;16597.087160206214;16623.251953662086;16504.33982640693;16745.413910513136;16779.580510487245;16790.328386864512;16792.66414671706;2985.5521671749193;3014.2163037610217;3050.4051709916575;3052.923676908084;3061.4489391909447;2873.4253149370106;2987.625692181599;2996.2509372656837;2998.595189649391;3003.354278830051;2932.7213914678073;2936.2072240495054;2947.1747910584963;2958.541426078961;2969.6881827408133;2888.1191236672807;2894.5802858585494;2904.7088325438785;2908.3601607646283;2914.606528118698;2756.7518923297;2800.985995070032;2819.407924335892;2823.90116345929;2825.6044153818484;15942.681146377123;16210.75683864743;16225.675486490203;16270.26783794732;16288.10415427151;8736.650533978633;8882.511461869595;8975.326850486239;8981.101889811032;9008.63965441388;5266.3943646480375;5468.6171967962255;5498.862528436781;5580.190872323531;5620.775168993236;1996.161612122912;2012.6276638821719;2015.7782643909159;2031.379520418658;2064.7728749837656;28128.71871281302;28643.57034644482;28771.28071798222;28786;28787.28031799201;7435.107787065479;7495.550266983998;7526.435517336222;7666.3866890648615;7699.769006929801;19072.52318692016;19130.234790608498;19204.71192932107;19218.615627687366;19253.8074619252;8658.264047556027;8756.649734010696;8793.692220772242;8832.911670883337;8833.160849719266;7691.153973062958;7969;8211.34309255258;8224.177582241848;8226.30076443509;5308.601854860901;5434.347878254555;5798.420157984167;6040.399294187044;6044.395560444008;1714.2457318779946;1724.094850203628;1739.8086210516833;1740.9738853917202;1743.2939659437948;978.7797745507346;993.7962717642865;1003.0571263012745;1006.7231511334295;1021.8467229915572;9500.382475139093;9653.131218190256;9683.612655493702;9708.126268635715;9741;1047.8585390972273;1068.867609119811;1070.8768491623407;1075.9677209683723;1096.528492748126;6062.575619706578;6065.787697430569;6096.72564734588;6137.263528376534;6138.877222455526;22762.20332288362;23364.64953025706;23701.407464813517;23749;24182.75817241805;23232.76767232306;23240.53518929612;23244.883775581013;23268.3019509415;23491.530169396516;11617.825732614017;12748.171368860994;12811.551595694293;12822.743545129231;12826.166299190523;9405.905940940504;9822.312438129262;9929.602815887572;9993.350432221881;10276.434796086287;20357.592848142656;20626.17495300171;20661.896690516453;20737.585248294647;20972.68540971917;21044.368668939955;21057.052432640263;21061.89469052645;21128.788712113295;21235.46911327229;12890.226586404846;13234.933825330812;13260.138091024053;13270.203787772765;13273.137246078973;14864.702705946036;15140.924295378452;15192.772108418161;15237.3905043797;15435.15106669144;11725.530978761095;11980.58067967617;12214.57248996281;12295.200811947196;12443.688907777378;11879.465424055765;12006.63980080599;12096.334701591144;12203.938980305042;12477.563285284972;10850.728731781768;11087.55649774;11089.722756931142;11092.389918554558;11097.445127743742;8144.226298501633;8155.388345873965;8260.958695206726;8343.833123337377;8355.749327520183;7986.880196796937;8030.196980301923;8128.83742325162;8151.5109093454585;8198.1391953844 21:37:47 INFO - PID 3496 | |4;prototype.html;551.277258566978;552.7788884446219;566.6316894018887;567.894939436204;580.6806256558895;6237.195310860383;6237.282712488054;6246.312905580388;6257.280412752529;6360.9045864312075;6093.542984276186;6130.601510901788;6194.00895856663;6195.659238741868;6215.658138802364;4951.455339912607;4985.725785081819;4996.975015124919;5012.343457967283;5022.321986531808;4791.041791641668;4861.295112208728;4920.188168952119;4935.753212339387;4991.600671946236;4795.2807078938085;4857.951420485803;4864.489228630996;4873.34209881665;4874;4803.78382972767;4812.687175333627;4844.224924012176;4876.853694389156;4889.437714662824;4395.890102747457;4452.666050046259;4454.354118652777;4473.7986790594505;4485.596296333346;6126.509879209697;6155.938440615581;6176.783812566584;6179.227596550431;6210.782622608187;5822.097574875858;5837.795677151322;5871.383504731984;5886.117082437626;5886.999210134245;6586.110875031857;6626.840302946965;6629.635370054645;6654.900176497356;6662.600243985376;5001;5054.1407960646775;5064.898702025976;5084.567811736007;5087.287779710843;6659.667016649197;6857.828554286133;6874.896876546856;6955.89566156508;7064.717411303542;5475.808346707926;5560.527355174855;5577.860553486114;5587.329520457572;5643.633163844337;5650.660960342392;5657.12314591239;5706.857328566736;5717.912961769008;5750.108733146369;5990.430909063632;6048.758049677964;6085.878282434326;6091.604045737013;6101.694915254219;6576.86846263072;6668.99895047221;6703.932960670429;6720.126383570105;6735.696893639798;1973.2107157136973;1991.492169496798;1996.2214736252872;1996.5507760754006;2005.478575570333;1416.3484796993293;1468.41263494603;1479.2677624575904;1489.9180545069908;1518.2105305241212;6463.48292136628;6500.447461965691;6519.8044058678315;6528.967355163194;6544.411003009752;6790.898136527956;6791.456683465311;6825.385715285648;6835.726570937206;6850.6574671266235;6434.388733070351;6435.163428754232;6449.290578036413;6463.353664633593;6479.902801457982;3589.838457269429;3592.4431713084514;3594.155373487228;3641.10792855752;3641.2717456508803;6957.686904089328;7030.859382812315;7067.151941767021;7081.610511421921;7112.786616401516;6925.168979722465;6945.548539344926;6948.158737934451;6949.791506254821;7032.402245809061;6936.237013928565;6950.339717726808;7056.188538318159;7102.893456598155;7122.92877071233;6683.832904177434;6746.325367463214;6767.796966091025;6833.145856767904;6884.449244060564;6632.767853125118;6712.328767123444;6729.5625784323865;6734.797956061326;6751.6834217329115;7077.893831592633;7113.253108423748;7122.145342558926;7130;7161.785146445615;5536.695481748381;5557.277553917965;5577.832665020056;5611.298587676541;5651;6696.430803381767;6818.4771634495555;6822.965885170543;6840.760573379908;6862.210845752802;6411.294757576756;6499.2200935887995;6570.47436205112;6639.834004149741;6656.900146497903;6453.322401147811;6496.382843629847;6531.379518945692;6577.14497115372;6646.268910419946;6434.871302574016;6543.803685889431;6574.767755468946;6597.6701164940605;6662.733490660319;6607.900881486686;6626.5030122741955;6684.498662600422;6696.464282857457;6776.491763117688;6421.95416887358;6501.057346684799;6525.575837570543;6545.610852038876;6579.407853293035 21:37:47 INFO - PID 3496 | |5;yui.html;978.6379039755292;999.4453078541407;1011.8330475471547;1019.4189312092108;1021.4535223655346;16343.26455309511;19181.808181918175;19556.706649400272;19806.207751689934;21976.45058873529;19700.802991970075;21995.23016694412;22011.889940550314;22022.229221977235;22025.118995240213;1043.243648354944;1061.5753698520614;1062.0229388962134;1062.054771253585;1062.7768168684586;1055.6832950114974;1080.8000519903803;1089.7983872983523;1090.3076546393058;1101.515333253366;1151.7523732397533;1154.4112502623639;1154.5901205072205;1155.0355453196591;1155.6417510571707;1142.7257458210054;1148.0471208896638;1149.0979581028853;1150.8158694608865;1151.4070253819332;837.6733074101105;846.627483907079;847.220557087481;847.4110493207223;847.656699036891;17475.213615387212;17644.294228230854;17709;18577.907110464497;20573.279935202198;21355.25256616011;21412.46468838276;21512.569748605096;21932.342029739135;21984.670229946565;15731.842681573153;16061.91969040159;16215.837841621551;16221.432249871315;16222;3318.9170270743184;3333.4666453367586;3336.199312165087;3344.7658663893535;3346.531485592019;149851.2507437456;149898;150564.2471787634;151273;152388.9999999989;14991.17548534841;15475.226238688021;15520;15536.611584710472;15545.533633990999;31739;32490.187745306557;32691.673083268863;32699.346013079605;32749.836250818593;8349.415540912078;8452.788680283042;8467.407281490237;8506.234438900405;8511.829763404698;4073.450084238649;4147.958520414818;4165.8958526037095;4187.706860519735;4206.221848957892;5666.688332141689;5688.232088667977;5798.391168927286;5901.0558310670085;5961.463468287875;1227.0858210633135;1233.3463264469844;1235.2032938754453;1249.331607589935;1254.642426908345;717.1000394504968;725.1117381207978;744.3152299884119;744.5309455043288;748.4872862089486;12766.17019893704;12981.350932453339;13055.21668699881;13178.538751143664;13209.603711888658;764.495433014208;765.2309429023907;772.0735117858592;773.8839174123814;774.3727580659571;5942.584019118706;6060.212172417646;6065.150878876961;6151.447149433025;6231.844203894939;126421.36789316179;127186;127363;127953.36023319824;128212;113687;115115;117519.41240293915;118631.40684296524;119119;96771.51614241884;99045.50477247711;99456.50271748594;100828.98342033265;102393.48803255935;13523.797143043059;13763.997243005173;13822;14017.369218385402;14228.288585570886;44026.779866101744;46777.76611116923;50370.74814625904;51472.48527514827;51594;82540;83785;85172.1482785189;85292;85858.57070714606;19567.21731130796;19823.801761982773;19826;20062.996850157724;20783.792162078185;19917.60164796725;19964.70052949236;19989.100490478253;20189;21913.452163696034;19852;19888.70166947468;19981;20958.580828383652;21452.570948581255;20321.89839050795;20750;20895.8955205223;21007.159713611283;21291.893540532197;20757.481062973548;21424;21598.24406145777;21625.243116491478;21675.674864876724;14580.781288280896;14584.781228281372;14655.560333190022;14696.926515367355;14705.485308014597;15436.382544698086;15445.382184712485;15618.375264989727;15916.204189790233;16045.598860028593 21:37:47 INFO - PID 3496 | __end_tp_report 21:37:47 INFO - PID 3496 | __start_cc_report 21:37:47 INFO - PID 3496 | _x_x_mozilla_cycle_collect,261 21:37:47 INFO - PID 3496 | __end_cc_report 21:37:47 INFO - PID 3496 | __startTimestamp1502167067166__endTimestamp 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | ------- Summary: start ------- 21:37:47 INFO - PID 3496 | Number of tests: 6 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | [#0] dojo.html Cycles:165 Average:6386.38 Median:6744.97 stddev:820.30 (12.2%) stddev-sans-first:792.65 21:37:47 INFO - PID 3496 | Values: 3576.9 3582.4 3602.0 3633.8 3642.4 6410.8 6416.9 6476.4 6481.5 6520.4 6424.5 6467.6 6470.3 6542.5 6553.7 5468.7 5505.2 5543.4 5551.0 5567.0 5597.7 5631.7 5641.4 5662.3 5670.8 5575.6 5611.1 5687.7 5690.5 5719.7 5512.1 5554.5 5560.9 5645.8 5646.1 5585.5 5612.6 5617.8 5620.0 5626.8 6240.4 6275.1 6284.6 6312.3 6344.6 6777.0 6851.7 6888.2 6914.6 6987.3 6967.2 7008.5 7036.0 7037.0 7059.1 6444.5 6475.2 6477.4 6486.6 6522.9 7094.8 7107.9 7133.8 7137.6 7139.1 6742.8 6745.0 6746.5 6748.6 6761.3 6940.1 6975.4 6977.1 6986.9 7000.4 6857.7 6858.6 6883.3 6948.2 6987.8 6817.8 6879.6 6918.6 6926.1 7000.5 5056.4 5060.2 5068.5 5089.7 5127.4 4553.9 4555.6 4617.7 4620.2 4658.0 6597.7 6641.1 6685.5 6691.6 6711.7 6848.4 6956.2 6965.7 7029.2 7031.5 6538.0 6594.5 6622.9 6626.7 6626.8 5728.3 5745.5 5748.1 5748.5 5749.6 7203.2 7313.9 7318.7 7320.7 7326.3 6907.9 6930.6 6971.6 6993.6 7049.4 6979.7 7158.6 7227.3 7255.9 7321.3 6804.2 6885.7 6888.1 6888.9 6889.2 6978.3 7026.5 7031.9 7035.5 7040.8 6759.4 6765.9 6836.8 6855.4 6871.1 6731.2 6774.8 6782.2 6788.9 6809.0 6745.9 6811.0 6831.3 6832.5 6860.2 6750.4 6772.3 6785.5 6786.7 6897.4 6533.6 6583.7 6604.8 6637.6 6689.0 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | [#1] ext.html Cycles:180 Average:42834.36 Median:37613.03 stddev:64537.45 (171.6%) stddev-sans-first:64641.72 21:37:47 INFO - PID 3496 | Values: 909.7 930.2 949.6 967.9 986.9 43535.6 44155.8 44354.0 44452.6 44465.6 40702.8 40715.2 40766.0 40779.0 40870.6 7160.0 7301.2 7304.0 7310.9 7333.3 7197.4 7237.8 7258.4 7295.1 7309.9 7217.2 7249.7 7279.8 7284.9 7315.4 7252.1 7256.9 7274.9 7282.9 7287.1 6598.0 6643.2 6646.2 6648.3 6660.0 36332.0 36606.6 36620.0 36639.1 36650.5 3527.3 3544.5 3550.9 3564.6 3565.5 28574.4 28604.1 28706.0 28739.4 28970.0 4530.1 4557.6 4579.5 4597.2 4598.4 208568.0 208900.0 221948.0 224881.0 229313.0 53827.2 53936.5 54091.7 54118.5 54206.7 55507.0 55540.7 55685.7 55824.4 55832.4 17316.3 17546.0 17549.5 17552.7 17806.0 14774.6 14806.2 14817.6 14822.3 14862.9 13670.3 13734.4 13967.6 14044.9 14095.7 5715.9 5741.6 5816.3 5884.4 5950.0 1124.8 1128.0 1128.9 1129.1 1135.9 24722.3 24885.0 24907.0 24983.3 25021.6 1180.4 1197.0 1226.7 1236.0 1256.9 13083.4 13319.3 13455.7 13526.9 13530.2 285805.0 290336.0 290748.0 290823.0 290951.0 61638.0 61952.0 62154.1 62196.4 62412.4 1558.1 1569.8 1577.4 1592.9 1599.6 29375.7 29669.3 29758.4 30117.8 30414.7 41014.2 41353.6 41359.4 41367.8 41396.6 226399.0 228156.0 228333.0 228800.0 230677.0 35387.3 36630.5 38424.2 38634.4 38999.2 51540.7 52577.2 52784.7 53044.0 53252.0 37294.4 37511.8 37616.8 37947.4 38017.0 37319.4 37609.2 37973.4 38127.4 38419.6 42663.6 44245.3 44320.8 44605.6 44690.0 35143.6 35713.6 35749.3 35852.6 36049.5 26821.7 26900.6 27012.1 27359.0 27802.6 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | [#2] jquery.html Cycles:180 Average:41560.86 Median:2355.31 stddev:105603.24 (4483.6%) stddev-sans-first:105854.73 21:37:47 INFO - PID 3496 | Values: 613.3 614.0 615.6 616.4 642.6 23799.2 24331.4 24430.1 24522.9 24559.0 26440.5 27388.7 27393.0 27396.7 27404.6 6319.0 6788.0 6861.8 6904.1 6908.6 6518.3 6587.5 6601.0 6604.1 6606.9 6507.2 6509.7 6561.6 6563.8 6566.2 6540.8 6545.1 6569.8 6571.0 6572.3 6093.5 6098.9 6107.6 6132.9 6149.8 30831.7 31303.8 32364.7 32465.2 32499.5 2349.9 2360.7 2367.9 2370.0 2387.1 20019.3 20600.2 20684.7 20773.9 20787.3 2406.2 2437.7 2559.0 2566.6 2571.0 150853.0 155709.2 159017.0 160163.0 168450.2 15861.8 16109.2 16856.8 17004.4 17084.7 25386.0 25501.2 25520.9 25521.5 25531.0 10866.5 10921.8 11081.1 11083.2 11089.4 10045.9 10061.8 10094.3 10186.5 10277.8 9818.8 10277.8 10370.0 10413.6 10673.5 2972.2 3001.2 3016.5 3030.7 3086.7 1063.4 1082.8 1091.4 1092.5 1099.8 22354.2 26481.7 27766.4 27942.0 28237.0 1084.3 1119.2 1141.0 1158.9 1180.0 11784.7 12345.4 12486.3 12540.1 12578.0 614441.0 622293.0 630251.0 639312.0 642990.0 136048.3 142418.3 143947.3 144565.0 146066.3 1353.9 1370.7 1383.2 1394.5 1394.8 19603.7 19675.4 19692.8 19721.2 19807.2 61978.0 62278.1 65313.0 67087.7 68638.3 79175.6 79618.6 79916.0 80243.0 80501.6 15702.5 16151.9 16464.9 16536.8 16642.3 26026.7 26091.3 26173.2 26253.6 26405.6 20833.5 21044.5 21076.5 21144.8 21364.0 16633.0 16972.0 17033.5 17150.5 18906.8 21220.6 21398.7 21410.7 21479.0 21593.4 16114.4 16258.8 16307.3 16405.6 16406.3 20273.8 20398.6 20521.7 20587.0 20659.4 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | [#3] mootools.html Cycles:180 Average:10292.53 Median:23596.47 stddev:7272.10 (30.8%) stddev-sans-first:7262.11 21:37:47 INFO - PID 3496 | Values: 1444.5 1492.2 1505.2 1517.1 1528.4 15852.7 16581.6 16589.3 16597.1 16623.3 16504.3 16745.4 16779.6 16790.3 16792.7 2985.6 3014.2 3050.4 3052.9 3061.4 2873.4 2987.6 2996.3 2998.6 3003.4 2932.7 2936.2 2947.2 2958.5 2969.7 2888.1 2894.6 2904.7 2908.4 2914.6 2756.8 2801.0 2819.4 2823.9 2825.6 15942.7 16210.8 16225.7 16270.3 16288.1 8736.7 8882.5 8975.3 8981.1 9008.6 5266.4 5468.6 5498.9 5580.2 5620.8 1996.2 2012.6 2015.8 2031.4 2064.8 28128.7 28643.6 28771.3 28786.0 28787.3 7435.1 7495.6 7526.4 7666.4 7699.8 19072.5 19130.2 19204.7 19218.6 19253.8 8658.3 8756.6 8793.7 8832.9 8833.2 7691.2 7969.0 8211.3 8224.2 8226.3 5308.6 5434.3 5798.4 6040.4 6044.4 1714.2 1724.1 1739.8 1741.0 1743.3 978.8 993.8 1003.1 1006.7 1021.8 9500.4 9653.1 9683.6 9708.1 9741.0 1047.9 1068.9 1070.9 1076.0 1096.5 6062.6 6065.8 6096.7 6137.3 6138.9 22762.2 23364.6 23701.4 23749.0 24182.8 23232.8 23240.5 23244.9 23268.3 23491.5 11617.8 12748.2 12811.6 12822.7 12826.2 9405.9 9822.3 9929.6 9993.4 10276.4 20357.6 20626.2 20661.9 20737.6 20972.7 21044.4 21057.1 21061.9 21128.8 21235.5 12890.2 13234.9 13260.1 13270.2 13273.1 14864.7 15140.9 15192.8 15237.4 15435.2 11725.5 11980.6 12214.6 12295.2 12443.7 11879.5 12006.6 12096.3 12203.9 12477.6 10850.7 11087.6 11089.7 11092.4 11097.4 8144.2 8155.4 8261.0 8343.8 8355.7 7986.9 8030.2 8128.8 8151.5 8198.1 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | [#4] prototype.html Cycles:180 Average:5706.26 Median:6416.62 stddev:1568.56 (24.4%) stddev-sans-first:1524.49 21:37:47 INFO - PID 3496 | Values: 551.3 552.8 566.6 567.9 580.7 6237.2 6237.3 6246.3 6257.3 6360.9 6093.5 6130.6 6194.0 6195.7 6215.7 4951.5 4985.7 4997.0 5012.3 5022.3 4791.0 4861.3 4920.2 4935.8 4991.6 4795.3 4858.0 4864.5 4873.3 4874.0 4803.8 4812.7 4844.2 4876.9 4889.4 4395.9 4452.7 4454.4 4473.8 4485.6 6126.5 6155.9 6176.8 6179.2 6210.8 5822.1 5837.8 5871.4 5886.1 5887.0 6586.1 6626.8 6629.6 6654.9 6662.6 5001.0 5054.1 5064.9 5084.6 5087.3 6659.7 6857.8 6874.9 6955.9 7064.7 5475.8 5560.5 5577.9 5587.3 5643.6 5650.7 5657.1 5706.9 5717.9 5750.1 5990.4 6048.8 6085.9 6091.6 6101.7 6576.9 6669.0 6703.9 6720.1 6735.7 1973.2 1991.5 1996.2 1996.6 2005.5 1416.3 1468.4 1479.3 1489.9 1518.2 6463.5 6500.4 6519.8 6529.0 6544.4 6790.9 6791.5 6825.4 6835.7 6850.7 6434.4 6435.2 6449.3 6463.4 6479.9 3589.8 3592.4 3594.2 3641.1 3641.3 6957.7 7030.9 7067.2 7081.6 7112.8 6925.2 6945.5 6948.2 6949.8 7032.4 6936.2 6950.3 7056.2 7102.9 7122.9 6683.8 6746.3 6767.8 6833.1 6884.4 6632.8 6712.3 6729.6 6734.8 6751.7 7077.9 7113.3 7122.1 7130.0 7161.8 5536.7 5557.3 5577.8 5611.3 5651.0 6696.4 6818.5 6823.0 6840.8 6862.2 6411.3 6499.2 6570.5 6639.8 6656.9 6453.3 6496.4 6531.4 6577.1 6646.3 6434.9 6543.8 6574.8 6597.7 6662.7 6607.9 6626.5 6684.5 6696.5 6776.5 6422.0 6501.1 6525.6 6545.6 6579.4 21:37:47 INFO - PID 3496 | 21:37:47 INFO - PID 3496 | [#5] yui.html Cycles:180 Average:26952.40 Median:19972.85 stddev:38220.50 (191.4%) stddev-sans-first:38277.96 21:37:47 INFO - PID 3496 | Values: 978.6 999.4 1011.8 1019.4 1021.5 16343.3 19181.8 19556.7 19806.2 21976.5 19700.8 21995.2 22011.9 22022.2 22025.1 1043.2 1061.6 1062.0 1062.1 1062.8 1055.7 1080.8 1089.8 1090.3 1101.5 1151.8 1154.4 1154.6 1155.0 1155.6 1142.7 1148.0 1149.1 1150.8 1151.4 837.7 846.6 847.2 847.4 847.7 17475.2 17644.3 17709.0 18577.9 20573.3 21355.3 21412.5 21512.6 21932.3 21984.7 15731.8 16061.9 16215.8 16221.4 16222.0 3318.9 3333.5 3336.2 3344.8 3346.5 149851.3 149898.0 150564.2 151273.0 152389.0 14991.2 15475.2 15520.0 15536.6 15545.5 31739.0 32490.2 32691.7 32699.3 32749.8 8349.4 8452.8 8467.4 8506.2 8511.8 4073.5 4148.0 4165.9 4187.7 4206.2 5666.7 5688.2 5798.4 5901.1 5961.5 1227.1 1233.3 1235.2 1249.3 1254.6 717.1 725.1 744.3 744.5 748.5 12766.2 12981.4 13055.2 13178.5 13209.6 764.5 765.2 772.1 773.9 774.4 5942.6 6060.2 6065.2 6151.4 6231.8 126421.4 127186.0 127363.0 127953.4 128212.0 113687.0 115115.0 117519.4 118631.4 119119.0 96771.5 99045.5 99456.5 100829.0 102393.5 13523.8 13764.0 13822.0 14017.4 14228.3 44026.8 46777.8 50370.7 51472.5 51594.0 82540.0 83785.0 85172.1 85292.0 85858.6 19567.2 19823.8 19826.0 20063.0 20783.8 19917.6 19964.7 19989.1 20189.0 21913.5 19852.0 19888.7 19981.0 20958.6 21452.6 20321.9 20750.0 20895.9 21007.2 21291.9 20757.5 21424.0 21598.2 21625.2 21675.7 14580.8 14584.8 14655.6 14696.9 14705.5 15436.4 15445.4 15618.4 15916.2 16045.6 21:37:47 INFO - PID 3496 | -------- Summary: end -------- 21:37:47 INFO - PID 3496 | 21:37:47 INFO - TEST-INFO | 3496: exit 0 21:37:47 INFO - TEST-OK | dromaeo_css | took 1109642ms 21:37:47 INFO - TEST-START | kraken 21:37:47 INFO - Initialising browser for kraken test... 21:37:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57095/getInfo.html -profile /tmp/tmpJwR8NB/profile 21:37:47 INFO - TEST-INFO | started process 3854 (/builds/slave/test/build/application/firefox/firefox http://localhost:57095/getInfo.html) 21:37:53 INFO - TEST-INFO | 3854: exit 0 21:37:53 INFO - Browser initialized. 21:37:53 INFO - Running cycle 1/1 for kraken test... 21:37:53 INFO - TEST-INFO | started process 4021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJwR8NB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:37:54 INFO - PID 4021 | 1502167074104 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 21:37:54 INFO - PID 4021 | 21:37:54 INFO - PID 4021 | (/builds/slave/test/build/application/firefox/firefox:4070): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:37:54 INFO - PID 4021 | 21:38:05 INFO - PID 4021 | RSS: Main: 138801152 21:38:05 INFO - PID 4021 | 21:38:07 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57095/tests/kraken/driver.html?testName=audio-beat-detection) 21:38:08 INFO - PID 4021 | RSS: Main: 146378752 21:38:08 INFO - PID 4021 | 21:38:10 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57095/tests/kraken/driver.html?testName=audio-dft) 21:38:11 INFO - PID 4021 | RSS: Main: 147038208 21:38:11 INFO - PID 4021 | 21:38:14 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57095/tests/kraken/driver.html?testName=audio-fft) 21:38:15 INFO - PID 4021 | RSS: Main: 147509248 21:38:15 INFO - PID 4021 | 21:38:17 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57095/tests/kraken/driver.html?testName=audio-oscillator) 21:38:17 INFO - PID 4021 | RSS: Main: 147472384 21:38:17 INFO - PID 4021 | 21:38:19 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:38:20 INFO - PID 4021 | RSS: Main: 146624512 21:38:20 INFO - PID 4021 | 21:38:23 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57095/tests/kraken/driver.html?testName=imaging-darkroom) 21:38:24 INFO - PID 4021 | RSS: Main: 146939904 21:38:24 INFO - PID 4021 | 21:38:27 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57095/tests/kraken/driver.html?testName=imaging-desaturate) 21:38:27 INFO - PID 4021 | RSS: Main: 150220800 21:38:27 INFO - PID 4021 | 21:38:30 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57095/tests/kraken/driver.html?testName=json-parse-financial) 21:38:31 INFO - PID 4021 | RSS: Main: 150966272 21:38:31 INFO - PID 4021 | 21:38:32 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:38:33 INFO - PID 4021 | RSS: Main: 150683648 21:38:33 INFO - PID 4021 | 21:38:35 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:38:35 INFO - PID 4021 | RSS: Main: 150540288 21:38:35 INFO - PID 4021 | 21:38:37 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:38:38 INFO - PID 4021 | RSS: Main: 150540288 21:38:38 INFO - PID 4021 | 21:38:40 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:38:41 INFO - PID 4021 | RSS: Main: 150794240 21:38:41 INFO - PID 4021 | 21:38:44 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:38:44 INFO - PID 4021 | RSS: Main: 150839296 21:38:44 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | Cycle 1(1): loaded http://localhost:57095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57095/tests/kraken/driver.html?testName=ai-astar) 21:38:46 INFO - PID 4021 | RSS: Main: 152535040 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | __start_tp_report 21:38:46 INFO - PID 4021 | _x_x_mozilla_page_load 21:38:46 INFO - PID 4021 | _x_x_mozilla_page_load_details 21:38:46 INFO - PID 4021 | |i|pagename|runs| 21:38:46 INFO - PID 4021 | |0;ai-astar;95;107;98;104;105;107;107;97;106;107 21:38:46 INFO - PID 4021 | |1;audio-beat-detection;142;112;140;170;117;150;144;112;179;114 21:38:46 INFO - PID 4021 | |2;audio-dft;162;163;162;162;161;163;160;162;162;159 21:38:46 INFO - PID 4021 | |3;audio-fft;75;74;72;184;74;75;73;74;158;78 21:38:46 INFO - PID 4021 | |4;audio-oscillator;77;78;131;77;78;78;143;77;78;124 21:38:46 INFO - PID 4021 | |5;imaging-gaussian-blur;113;113;114;113;114;114;116;113;113;113 21:38:46 INFO - PID 4021 | |6;imaging-darkroom;151;146;148;147;147;147;147;148;147;147 21:38:46 INFO - PID 4021 | |7;imaging-desaturate;94;94;94;93;94;94;93;95;93;94 21:38:46 INFO - PID 4021 | |8;json-parse-financial;46;46;50;44;48;46;46;46;45;49 21:38:46 INFO - PID 4021 | |9;json-stringify-tinderbox;53;53;53;53;53;53;53;53;53;53 21:38:46 INFO - PID 4021 | |10;stanford-crypto-aes;79;72;74;73;74;72;73;73;73;72 21:38:46 INFO - PID 4021 | |11;stanford-crypto-ccm;120;113;117;115;116;115;112;115;118;147 21:38:46 INFO - PID 4021 | |12;stanford-crypto-pbkdf2;157;159;157;165;156;156;160;155;166;159 21:38:46 INFO - PID 4021 | |13;stanford-crypto-sha256-iterative;58;59;61;61;59;58;60;58;61;58 21:38:46 INFO - PID 4021 | __end_tp_report 21:38:46 INFO - PID 4021 | __start_cc_report 21:38:46 INFO - PID 4021 | _x_x_mozilla_cycle_collect,739 21:38:46 INFO - PID 4021 | __end_cc_report 21:38:46 INFO - PID 4021 | __startTimestamp1502167126840__endTimestamp 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | ------- Summary: start ------- 21:38:46 INFO - PID 4021 | Number of tests: 14 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#0] ai-astar Cycles:10 Average:103.30 Median:107.00 stddev:4.74 (4.4%) stddev-sans-first:3.96 21:38:46 INFO - PID 4021 | Values: 95.0 107.0 98.0 104.0 105.0 107.0 107.0 97.0 106.0 107.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:143.00 stddev:24.21 (16.9%) stddev-sans-first:25.63 21:38:46 INFO - PID 4021 | Values: 142.0 112.0 140.0 170.0 117.0 150.0 144.0 112.0 179.0 114.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 21:38:46 INFO - PID 4021 | Values: 162.0 163.0 162.0 162.0 161.0 163.0 160.0 162.0 162.0 159.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#3] audio-fft Cycles:10 Average:93.70 Median:74.00 stddev:41.23 (55.7%) stddev-sans-first:43.17 21:38:46 INFO - PID 4021 | Values: 75.0 74.0 72.0 184.0 74.0 75.0 73.0 74.0 158.0 78.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:77.50 stddev:27.00 (34.8%) stddev-sans-first:27.92 21:38:46 INFO - PID 4021 | Values: 77.0 78.0 131.0 77.0 78.0 78.0 143.0 77.0 78.0 124.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 21:38:46 INFO - PID 4021 | Values: 113.0 113.0 114.0 113.0 114.0 114.0 116.0 113.0 113.0 113.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:0.60 21:38:46 INFO - PID 4021 | Values: 151.0 146.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:38:46 INFO - PID 4021 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 93.0 95.0 93.0 94.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#8] json-parse-financial Cycles:10 Average:46.60 Median:46.00 stddev:1.84 (4.0%) stddev-sans-first:1.94 21:38:46 INFO - PID 4021 | Values: 46.0 46.0 50.0 44.0 48.0 46.0 46.0 46.0 45.0 49.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 21:38:46 INFO - PID 4021 | Values: 53.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.00 stddev:2.07 (2.8%) stddev-sans-first:0.78 21:38:46 INFO - PID 4021 | Values: 79.0 72.0 74.0 73.0 74.0 72.0 73.0 73.0 73.0 72.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:116.50 stddev:10.17 (8.7%) stddev-sans-first:10.78 21:38:46 INFO - PID 4021 | Values: 120.0 113.0 117.0 115.0 116.0 115.0 112.0 115.0 118.0 147.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:159.00 stddev:3.77 (2.4%) stddev-sans-first:3.93 21:38:46 INFO - PID 4021 | Values: 157.0 159.0 157.0 165.0 156.0 156.0 160.0 155.0 166.0 159.0 21:38:46 INFO - PID 4021 | 21:38:46 INFO - PID 4021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.50 stddev:1.34 (2.2%) stddev-sans-first:1.33 21:38:46 INFO - PID 4021 | Values: 58.0 59.0 61.0 61.0 59.0 58.0 60.0 58.0 61.0 58.0 21:38:46 INFO - PID 4021 | -------- Summary: end -------- 21:38:46 INFO - PID 4021 | 21:38:47 INFO - PID 4021 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:38:47 INFO - TEST-INFO | 4021: exit 0 21:38:47 INFO - TEST-OK | kraken | took 59960ms 21:38:47 INFO - SUITE-END | took 1169s 21:38:48 INFO - Completed test suite (00:19:29) 21:38:48 INFO - javascript benchmark 21:38:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9166.072912732887, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3576.9463458048117, 3582.3909935310994, 3602.0, 3633.8001409922445, 3642.435422509511, 6410.839729006765, 6416.9037464438015, 6476.417122458984, 6481.513886458511, 6520.44576211022, 6424.486041116711, 6467.579607325521, 6470.255920569136, 6542.476601871839, 6553.70508327124, 5468.671879687212, 5505.201745746865, 5543.362513310981, 5551.0, 5566.972165139168, 5597.6641401516035, 5631.746571404276, 5641.407652196522, 5662.320521537401, 5670.829875103754, 5575.637583557096, 5611.102223644198, 5687.687177205252, 5690.544756419497, 5719.6854173020465, 5512.090505066659, 5554.50009499147, 5560.888782224373, 5645.830625081254, 5646.068398714207, 5585.525230355424, 5612.607117501777, 5617.831465056055, 5620.044592419298, 5626.803061892814, 6240.438360547572, 6275.058741188813, 6284.622922624657, 6312.337204593543, 6344.619322840598, 6776.966115169393, 6851.657417129173, 6888.173419189679, 6914.55055421401, 6987.301269873023, 6967.233604303523, 7008.544444611084, 7036.0, 7037.014817925495, 7059.082319298458, 6444.484441244689, 6475.158229430238, 6477.384648458389, 6486.610803351814, 6522.869542609121, 7094.822629434202, 7107.857842843217, 7133.785986420312, 7137.607431591312, 7139.071920650283, 6742.764003259862, 6744.966275168593, 6746.527743057939, 6748.561343512656, 6761.256261811197, 6940.13248343957, 6975.407090397373, 6977.058097156921, 6986.860262794716, 7000.369966703021, 6857.657117144123, 6858.588484690935, 6883.27725588816, 6948.166220053525, 6987.825304367329, 6817.829554261084, 6879.621620810904, 6918.619475928772, 6926.134233220848, 7000.544964577286, 5056.443791182967, 5060.240963855451, 5068.467810879878, 5089.720065396439, 5127.410347809975, 4553.931691024637, 4555.567221113989, 4617.722936623813, 4620.214563524209, 4657.976710116428, 6597.736090556324, 6641.070250164981, 6685.498587605949, 6691.59850408977, 6711.664416779142, 6848.417884479775, 6956.229189445854, 6965.686544105527, 7029.22678505364, 7031.472639552054, 6538.0, 6594.538382313288, 6622.933770662328, 6626.734930602722, 6626.801195964129, 5728.283964504437, 5745.482906538432, 5748.13777933305, 5748.453896879873, 5749.626274292241, 7203.243659415791, 7313.926860731431, 7318.670659820321, 7320.67056982437, 7326.3040011198855, 6907.930920690729, 6930.61881596517, 6971.6165610891885, 6993.615351155633, 7049.400800931979, 6979.720811167496, 7158.570485770871, 7227.313405226495, 7255.891161632685, 7321.304476074764, 6804.183497980274, 6885.724571017304, 6888.070110535014, 6888.896666549906, 6889.173299204128, 6978.267281935324, 7026.473014524034, 7031.894521582078, 7035.507514473938, 7040.788776336718, 6759.391654751096, 6765.932340676727, 6836.760713375008, 6855.4172895304455, 6871.106756121672, 6731.158605174353, 6774.762883299061, 6782.220044694924, 6788.86422271542, 6808.978653201862, 6745.898811517733, 6810.965945170243, 6831.282715315019, 6832.521723479507, 6860.176778786577, 6750.35871592198, 6772.25505194438, 6785.457163426815, 6786.728530858711, 6897.448204143556, 6533.640649764118, 6583.670816459254, 6604.801855944329, 6637.568558043712, 6689.030090636733], "value": 6324.162595269243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.6997990663077, 930.1860871737232, 949.5869296855868, 967.8741763570735, 986.8667729856468, 43535.564644353544, 44155.77922110393, 44354.0, 44452.555474445246, 44465.555344446584, 40702.79648601753, 40715.185696286055, 40766.0, 40779.0, 40870.59129408705, 7160.033395491607, 7301.1968683444775, 7304.0, 7310.926890731078, 7333.2666733326505, 7197.424206063502, 7237.782866514013, 7258.383037441824, 7295.051643286365, 7309.853802923938, 7217.242189570098, 7249.71001159953, 7279.818004549902, 7284.9271507284775, 7315.4147668186415, 7252.129744430649, 7256.8911466328045, 7274.854502909939, 7282.854342913139, 7287.125544934615, 6598.0, 6643.169603799525, 6646.202455705298, 6648.301928297507, 6659.966700166517, 36332.0, 36606.63393366059, 36620.0, 36639.08402289938, 36650.45024324637, 3527.2945410917664, 3544.521489598897, 3550.91122721934, 3564.625714300013, 3565.5186549815703, 28574.428511429862, 28604.14187574376, 28706.0, 28739.42521149586, 28970.0, 4530.0939812037395, 4557.589816916494, 4579.496255411902, 4597.241455159928, 4598.402207713009, 208568.0, 208900.0, 221948.0, 224881.0, 229313.0, 53827.19259211115, 53936.46063539393, 54091.729541352826, 54118.45881541213, 54206.728966354916, 55507.0, 55540.72229638826, 55685.721571391885, 55824.44175558274, 55832.441675583534, 17316.30734770595, 17546.0, 17549.473515794547, 17552.736708949375, 17806.0, 14774.556763297118, 14806.185659788815, 14817.555473335817, 14822.258887055605, 14862.925685371503, 13670.31648417595, 13734.381952812148, 13967.580972570839, 14044.929775351058, 14095.718085638435, 5715.8571035724435, 5741.598088133791, 5816.302043754692, 5884.352721200665, 5949.970250148722, 1124.7525544380223, 1127.9661610151709, 1128.853249077631, 1129.1192869561755, 1135.9091272698329, 24722.25833225006, 24885.0, 24907.0, 24983.250502484956, 25021.624675629515, 1180.3744015671707, 1197.024425093546, 1226.687194765347, 1235.975280494385, 1256.863332335034, 13083.41124649393, 13319.334033298297, 13455.730885382432, 13526.93236533811, 13530.18818870871, 285805.0, 290336.0, 290748.0, 290823.0, 290951.0, 61638.0, 61952.0, 62154.0676889847, 62196.37803621996, 62412.37587624066, 1558.0573752879345, 1569.7645353197113, 1577.37693611023, 1592.8646065084365, 1599.5521254048886, 29375.706242937296, 29669.25826854346, 29758.404831902808, 30117.849410753683, 30414.695853041187, 41014.179716404906, 41353.58646413618, 41359.37960930528, 41367.793161034, 41396.586034139276, 226399.0, 228156.0, 228333.0, 228800.0, 230677.0, 35387.29225415529, 36630.450543242405, 38424.2315153701, 38634.42048369333, 38999.2200156001, 51540.74229628828, 52577.21134183067, 52784.73607631937, 53044.0, 53252.0, 37294.44058339073, 37511.81244093871, 37616.81191594025, 37947.430788538746, 38017.0, 37319.44020839635, 37609.247815044095, 37973.430398544595, 38127.42808857814, 38419.6158038416, 42663.57336426596, 44245.336319954586, 44320.77839610782, 44605.55394446144, 44690.0, 35143.648563514034, 35713.64286357207, 35749.28501430009, 35852.64147358493, 36049.459258110626, 26821.731782681924, 26900.578947894785, 27012.054578089672, 27359.0, 27802.582961256], "value": 18388.729113324214, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.3008370457676, 613.9938600613993, 615.5875563372537, 616.3924663143007, 642.6433329502125, 23799.167029153963, 24331.39171520713, 24430.14494492693, 24522.87738561307, 24559.0, 26440.471190576176, 27388.726112738867, 27393.0, 27396.726032739665, 27404.588931166047, 6319.0, 6788.01573771804, 6861.828454288658, 6904.13698287714, 6908.585484870899, 6518.348165183467, 6587.47300215984, 6601.0, 6604.141461610008, 6606.8678626427445, 6507.154069970921, 6509.739610415601, 6561.606303621774, 6563.835904102388, 6566.179227596551, 6540.803775886731, 6545.083688283644, 6569.80290591283, 6571.0, 6572.277049524549, 6093.512518998469, 6098.939010609882, 6107.603005804608, 6132.908006379907, 6149.754009839601, 30831.691683083107, 31303.843480782678, 32364.676353236402, 32465.188370290696, 32499.51250731241, 2349.917752878658, 2360.6931098957198, 2367.9289621311386, 2369.9644505332435, 2387.0809738250723, 20019.299324523716, 20600.175992960263, 20684.689729654066, 20773.89613051925, 20787.27244546449, 2406.217979156781, 2437.744036876138, 2559.0, 2566.589345704697, 2571.0230112557297, 150853.0, 155709.221453892, 159017.0, 160163.0, 168450.1577492117, 15861.796623894446, 16109.19454027294, 16856.831431685772, 17004.404845830584, 17084.658306833793, 25386.0, 25501.23496295114, 25520.872395637904, 25521.48957020849, 25531.0, 10866.45667716611, 10921.781564368668, 11081.113510919107, 11083.224174307721, 11089.445527723581, 10045.899541004643, 10061.79876402468, 10094.293399461967, 10186.490675466346, 10277.845832312521, 9818.80362392748, 10277.794444111076, 10370.0, 10413.587527183563, 10673.519691613896, 2972.1677930179585, 3001.1746769638526, 3016.4570377332293, 3030.712082352173, 3086.6758990306143, 1063.361982810323, 1082.767205050902, 1091.3560999010622, 1092.5356723392686, 1099.7855418193376, 22354.217602384164, 26481.735182647928, 27766.444671106463, 27942.0, 28237.0, 1084.3277168155794, 1119.227732864321, 1140.9657710268705, 1158.8609366876028, 1179.9941000294943, 11784.705382365339, 12345.444454999546, 12486.25082495035, 12540.122191446693, 12578.0, 614441.0, 622293.0, 630251.0, 639312.0, 642990.0, 136048.31975840058, 142418.28790855978, 143947.28026359802, 144565.0, 146066.269668651, 1353.9187648741106, 1370.6984463418032, 1383.156274672429, 1394.4561620967831, 1394.776835706282, 19603.70594441056, 19675.40973770789, 19692.803071969098, 19721.21115155435, 19807.207711691946, 61978.0, 62278.06582901351, 65313.0, 67087.66456167688, 68638.31361686319, 79175.60412197902, 79618.6019069901, 79916.0, 80243.0, 80501.59749201217, 15702.450414235447, 16151.919240403722, 16464.917675411547, 16536.834631653528, 16642.334306628083, 26026.73973260319, 26091.347716307246, 26173.214803555922, 26253.606195906694, 26405.60391594166, 20833.479163021046, 21044.47388815292, 21076.47308817292, 21144.78855211428, 21364.0, 16633.0, 16971.981681099172, 17033.48899533016, 17150.485485435456, 18906.810931891054, 21220.575588488453, 21398.679019815027, 21410.678839817727, 21479.0, 21593.35219943404, 16114.355425782838, 16258.756118658466, 16307.347706091623, 16405.605523530634, 16406.26171822247, 20273.79726202778, 20398.592028159055, 20521.692174617692, 20587.0, 20659.380218593466], "value": 13249.911952829229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.4727674398844, 1492.1793013842384, 1505.2248092232496, 1517.1428143099151, 1528.3886445421822, 15852.682946341081, 16581.585460363483, 16589.25348359324, 16597.087160206214, 16623.251953662086, 16504.33982640693, 16745.413910513136, 16779.580510487245, 16790.328386864512, 16792.66414671706, 2985.5521671749193, 3014.2163037610217, 3050.4051709916575, 3052.923676908084, 3061.4489391909447, 2873.4253149370106, 2987.625692181599, 2996.2509372656837, 2998.595189649391, 3003.354278830051, 2932.7213914678073, 2936.2072240495054, 2947.1747910584963, 2958.541426078961, 2969.6881827408133, 2888.1191236672807, 2894.5802858585494, 2904.7088325438785, 2908.3601607646283, 2914.606528118698, 2756.7518923297, 2800.985995070032, 2819.407924335892, 2823.90116345929, 2825.6044153818484, 15942.681146377123, 16210.75683864743, 16225.675486490203, 16270.26783794732, 16288.10415427151, 8736.650533978633, 8882.511461869595, 8975.326850486239, 8981.101889811032, 9008.63965441388, 5266.3943646480375, 5468.6171967962255, 5498.862528436781, 5580.190872323531, 5620.775168993236, 1996.161612122912, 2012.6276638821719, 2015.7782643909159, 2031.379520418658, 2064.7728749837656, 28128.71871281302, 28643.57034644482, 28771.28071798222, 28786.0, 28787.28031799201, 7435.107787065479, 7495.550266983998, 7526.435517336222, 7666.3866890648615, 7699.769006929801, 19072.52318692016, 19130.234790608498, 19204.71192932107, 19218.615627687366, 19253.8074619252, 8658.264047556027, 8756.649734010696, 8793.692220772242, 8832.911670883337, 8833.160849719266, 7691.153973062958, 7969.0, 8211.34309255258, 8224.177582241848, 8226.30076443509, 5308.601854860901, 5434.347878254555, 5798.420157984167, 6040.399294187044, 6044.395560444008, 1714.2457318779946, 1724.094850203628, 1739.8086210516833, 1740.9738853917202, 1743.2939659437948, 978.7797745507346, 993.7962717642865, 1003.0571263012745, 1006.7231511334295, 1021.8467229915572, 9500.382475139093, 9653.131218190256, 9683.612655493702, 9708.126268635715, 9741.0, 1047.8585390972273, 1068.867609119811, 1070.8768491623407, 1075.9677209683723, 1096.528492748126, 6062.575619706578, 6065.787697430569, 6096.72564734588, 6137.263528376534, 6138.877222455526, 22762.20332288362, 23364.64953025706, 23701.407464813517, 23749.0, 24182.75817241805, 23232.76767232306, 23240.53518929612, 23244.883775581013, 23268.3019509415, 23491.530169396516, 11617.825732614017, 12748.171368860994, 12811.551595694293, 12822.743545129231, 12826.166299190523, 9405.905940940504, 9822.312438129262, 9929.602815887572, 9993.350432221881, 10276.434796086287, 20357.592848142656, 20626.17495300171, 20661.896690516453, 20737.585248294647, 20972.68540971917, 21044.368668939955, 21057.052432640263, 21061.89469052645, 21128.788712113295, 21235.46911327229, 12890.226586404846, 13234.933825330812, 13260.138091024053, 13270.203787772765, 13273.137246078973, 14864.702705946036, 15140.924295378452, 15192.772108418161, 15237.3905043797, 15435.15106669144, 11725.530978761095, 11980.58067967617, 12214.57248996281, 12295.200811947196, 12443.688907777378, 11879.465424055765, 12006.63980080599, 12096.334701591144, 12203.938980305042, 12477.563285284972, 10850.728731781768, 11087.55649774, 11089.722756931142, 11092.389918554558, 11097.445127743742, 8144.226298501633, 8155.388345873965, 8260.958695206726, 8343.833123337377, 8355.749327520183, 7986.880196796937, 8030.196980301923, 8128.83742325162, 8151.5109093454585, 8198.1391953844], "value": 7371.493649401627, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.277258566978, 552.7788884446219, 566.6316894018887, 567.894939436204, 580.6806256558895, 6237.195310860383, 6237.282712488054, 6246.312905580388, 6257.280412752529, 6360.9045864312075, 6093.542984276186, 6130.601510901788, 6194.00895856663, 6195.659238741868, 6215.658138802364, 4951.455339912607, 4985.725785081819, 4996.975015124919, 5012.343457967283, 5022.321986531808, 4791.041791641668, 4861.295112208728, 4920.188168952119, 4935.753212339387, 4991.600671946236, 4795.2807078938085, 4857.951420485803, 4864.489228630996, 4873.34209881665, 4874.0, 4803.78382972767, 4812.687175333627, 4844.224924012176, 4876.853694389156, 4889.437714662824, 4395.890102747457, 4452.666050046259, 4454.354118652777, 4473.7986790594505, 4485.596296333346, 6126.509879209697, 6155.938440615581, 6176.783812566584, 6179.227596550431, 6210.782622608187, 5822.097574875858, 5837.795677151322, 5871.383504731984, 5886.117082437626, 5886.999210134245, 6586.110875031857, 6626.840302946965, 6629.635370054645, 6654.900176497356, 6662.600243985376, 5001.0, 5054.1407960646775, 5064.898702025976, 5084.567811736007, 5087.287779710843, 6659.667016649197, 6857.828554286133, 6874.896876546856, 6955.89566156508, 7064.717411303542, 5475.808346707926, 5560.527355174855, 5577.860553486114, 5587.329520457572, 5643.633163844337, 5650.660960342392, 5657.12314591239, 5706.857328566736, 5717.912961769008, 5750.108733146369, 5990.430909063632, 6048.758049677964, 6085.878282434326, 6091.604045737013, 6101.694915254219, 6576.86846263072, 6668.99895047221, 6703.932960670429, 6720.126383570105, 6735.696893639798, 1973.2107157136973, 1991.492169496798, 1996.2214736252872, 1996.5507760754006, 2005.478575570333, 1416.3484796993293, 1468.41263494603, 1479.2677624575904, 1489.9180545069908, 1518.2105305241212, 6463.48292136628, 6500.447461965691, 6519.8044058678315, 6528.967355163194, 6544.411003009752, 6790.898136527956, 6791.456683465311, 6825.385715285648, 6835.726570937206, 6850.6574671266235, 6434.388733070351, 6435.163428754232, 6449.290578036413, 6463.353664633593, 6479.902801457982, 3589.838457269429, 3592.4431713084514, 3594.155373487228, 3641.10792855752, 3641.2717456508803, 6957.686904089328, 7030.859382812315, 7067.151941767021, 7081.610511421921, 7112.786616401516, 6925.168979722465, 6945.548539344926, 6948.158737934451, 6949.791506254821, 7032.402245809061, 6936.237013928565, 6950.339717726808, 7056.188538318159, 7102.893456598155, 7122.92877071233, 6683.832904177434, 6746.325367463214, 6767.796966091025, 6833.145856767904, 6884.449244060564, 6632.767853125118, 6712.328767123444, 6729.5625784323865, 6734.797956061326, 6751.6834217329115, 7077.893831592633, 7113.253108423748, 7122.145342558926, 7130.0, 7161.785146445615, 5536.695481748381, 5557.277553917965, 5577.832665020056, 5611.298587676541, 5651.0, 6696.430803381767, 6818.4771634495555, 6822.965885170543, 6840.760573379908, 6862.210845752802, 6411.294757576756, 6499.2200935887995, 6570.47436205112, 6639.834004149741, 6656.900146497903, 6453.322401147811, 6496.382843629847, 6531.379518945692, 6577.14497115372, 6646.268910419946, 6434.871302574016, 6543.803685889431, 6574.767755468946, 6597.6701164940605, 6662.733490660319, 6607.900881486686, 6626.5030122741955, 6684.498662600422, 6696.464282857457, 6776.491763117688, 6421.95416887358, 6501.057346684799, 6525.575837570543, 6545.610852038876, 6579.407853293035], "value": 5267.574020109644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.6379039755292, 999.4453078541407, 1011.8330475471547, 1019.4189312092108, 1021.4535223655346, 16343.26455309511, 19181.808181918175, 19556.706649400272, 19806.207751689934, 21976.45058873529, 19700.802991970075, 21995.23016694412, 22011.889940550314, 22022.229221977235, 22025.118995240213, 1043.243648354944, 1061.5753698520614, 1062.0229388962134, 1062.054771253585, 1062.7768168684586, 1055.6832950114974, 1080.8000519903803, 1089.7983872983523, 1090.3076546393058, 1101.515333253366, 1151.7523732397533, 1154.4112502623639, 1154.5901205072205, 1155.0355453196591, 1155.6417510571707, 1142.7257458210054, 1148.0471208896638, 1149.0979581028853, 1150.8158694608865, 1151.4070253819332, 837.6733074101105, 846.627483907079, 847.220557087481, 847.4110493207223, 847.656699036891, 17475.213615387212, 17644.294228230854, 17709.0, 18577.907110464497, 20573.279935202198, 21355.25256616011, 21412.46468838276, 21512.569748605096, 21932.342029739135, 21984.670229946565, 15731.842681573153, 16061.91969040159, 16215.837841621551, 16221.432249871315, 16222.0, 3318.9170270743184, 3333.4666453367586, 3336.199312165087, 3344.7658663893535, 3346.531485592019, 149851.2507437456, 149898.0, 150564.2471787634, 151273.0, 152388.9999999989, 14991.17548534841, 15475.226238688021, 15520.0, 15536.611584710472, 15545.533633990999, 31739.0, 32490.187745306557, 32691.673083268863, 32699.346013079605, 32749.836250818593, 8349.415540912078, 8452.788680283042, 8467.407281490237, 8506.234438900405, 8511.829763404698, 4073.450084238649, 4147.958520414818, 4165.8958526037095, 4187.706860519735, 4206.221848957892, 5666.688332141689, 5688.232088667977, 5798.391168927286, 5901.0558310670085, 5961.463468287875, 1227.0858210633135, 1233.3463264469844, 1235.2032938754453, 1249.331607589935, 1254.642426908345, 717.1000394504968, 725.1117381207978, 744.3152299884119, 744.5309455043288, 748.4872862089486, 12766.17019893704, 12981.350932453339, 13055.21668699881, 13178.538751143664, 13209.603711888658, 764.495433014208, 765.2309429023907, 772.0735117858592, 773.8839174123814, 774.3727580659571, 5942.584019118706, 6060.212172417646, 6065.150878876961, 6151.447149433025, 6231.844203894939, 126421.36789316179, 127186.0, 127363.0, 127953.36023319824, 128212.0, 113687.0, 115115.0, 117519.41240293915, 118631.40684296524, 119119.0, 96771.51614241884, 99045.50477247711, 99456.50271748594, 100828.98342033265, 102393.48803255935, 13523.797143043059, 13763.997243005173, 13822.0, 14017.369218385402, 14228.288585570886, 44026.779866101744, 46777.76611116923, 50370.74814625904, 51472.48527514827, 51594.0, 82540.0, 83785.0, 85172.1482785189, 85292.0, 85858.57070714606, 19567.21731130796, 19823.801761982773, 19826.0, 20062.996850157724, 20783.792162078185, 19917.60164796725, 19964.70052949236, 19989.100490478253, 20189.0, 21913.452163696034, 19852.0, 19888.70166947468, 19981.0, 20958.580828383652, 21452.570948581255, 20321.89839050795, 20750.0, 20895.8955205223, 21007.159713611283, 21291.893540532197, 20757.481062973548, 21424.0, 21598.24406145777, 21625.243116491478, 21675.674864876724, 14580.781288280896, 14584.781228281372, 14655.560333190022, 14696.926515367355, 14705.485308014597, 15436.382544698086, 15445.382184712485, 15618.375264989727, 15916.204189790233, 16045.598860028593], "value": 9911.514291016636, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 107.0, 98.0, 104.0, 105.0, 107.0, 107.0, 97.0, 106.0, 107.0], "value": 103.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 140.0, 170.0, 117.0, 150.0, 144.0, 112.0, 179.0, 114.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 163.0, 160.0, 162.0, 162.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 184.0, 74.0, 75.0, 73.0, 74.0, 158.0, 78.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 131.0, 77.0, 78.0, 78.0, 143.0, 77.0, 78.0, 124.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 116.0, 113.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 95.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 50.0, 44.0, 48.0, 46.0, 46.0, 46.0, 45.0, 49.0], "value": 46.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 74.0, 73.0, 74.0, 72.0, 73.0, 73.0, 73.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 113.0, 117.0, 115.0, 116.0, 115.0, 112.0, 115.0, 118.0, 147.0], "value": 118.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 157.0, 165.0, 156.0, 156.0, 160.0, 155.0, 166.0, 159.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 61.0, 61.0, 59.0, 58.0, 60.0, 58.0, 61.0, 58.0], "value": 59.3, "unit": "score"}]}]} 21:38:48 INFO - Return code: 0 21:38:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:38:48 INFO - # TBPL SUCCESS # 21:38:48 INFO - Running post-action listener: _package_coverage_data 21:38:48 INFO - Running post-action listener: _resource_record_post_action 21:38:48 INFO - [mozharness: 2017-08-08 04:38:48.119013Z] Finished run-tests step (success) 21:38:48 INFO - Running post-run listener: _resource_record_post_run 21:38:48 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 5894144; Write bytes: 375402496; Read time: 2536; Write time: 592368 21:38:48 INFO - TinderboxPrint: CPU usage
13.0% 21:38:48 INFO - TinderboxPrint: I/O read bytes / time
5,894,144 / 2,536 21:38:48 INFO - TinderboxPrint: I/O write bytes / time
375,402,496 / 592,368 21:38:48 INFO - TinderboxPrint: CPU idle
8,214.9 (86.9%) 21:38:48 INFO - TinderboxPrint: CPU user
1,180.0 (12.5%) 21:38:48 INFO - TinderboxPrint: Swap in / out
0 / 0 21:38:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 98226176; Read time: 0; Write time: 261908 21:38:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:38:48 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 3522560; Write bytes: 277176320; Read time: 1824; Write time: 330460 21:38:48 INFO - Running post-run listener: _upload_blobber_files 21:38:48 INFO - Blob upload gear active. 21:38:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:38:48 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 21:38:48 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'] 21:38:48 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 21:38:49 INFO - (blobuploader) - INFO - Open directory for files ... 21:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:50 INFO - (blobuploader) - INFO - Done attempting. 21:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:50 INFO - (blobuploader) - INFO - Done attempting. 21:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:51 INFO - (blobuploader) - INFO - Done attempting. 21:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:38:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:57 INFO - (blobuploader) - INFO - Done attempting. 21:38:57 INFO - (blobuploader) - INFO - Iteration through files over. 21:38:57 INFO - Return code: 0 21:38:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:38:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:38:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e368e98ecbcc31c535b3edfe1eff049ea015f4d5965ee75923ba3364f2cbaaaaaa5be225e34b9c546b057448c0d82530757306a2fabc036eda84b17b2593ab7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/329c8a01e50bd6fe2e559ee32fec2f4746a9b0dc74244f8b71d49ce3d10b28129bc5179f93e7505d9d3a46679166f0ead2c9c3062c7730c0d9beb763ce398636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/809c087cef81e9bce702832446d7d59921dd689dae066a964e635ac0ac7b56bd47fcad3083c34e51be0ef3117cae2bac81d46e4485d272c872448b8863a134fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/589a6ae9809e85127ff4af6cede3baca34f5d6a42257be2c8292fe7a5f4587766a1c2b22d67a63c85dab54deb6c2c061ab2f7274501cb238ac6c85b9980bbb71"} 21:38:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:38:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:38:57 INFO - Contents: 21:38:57 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e368e98ecbcc31c535b3edfe1eff049ea015f4d5965ee75923ba3364f2cbaaaaaa5be225e34b9c546b057448c0d82530757306a2fabc036eda84b17b2593ab7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/329c8a01e50bd6fe2e559ee32fec2f4746a9b0dc74244f8b71d49ce3d10b28129bc5179f93e7505d9d3a46679166f0ead2c9c3062c7730c0d9beb763ce398636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/809c087cef81e9bce702832446d7d59921dd689dae066a964e635ac0ac7b56bd47fcad3083c34e51be0ef3117cae2bac81d46e4485d272c872448b8863a134fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/589a6ae9809e85127ff4af6cede3baca34f5d6a42257be2c8292fe7a5f4587766a1c2b22d67a63c85dab54deb6c2c061ab2f7274501cb238ac6c85b9980bbb71"} 21:38:57 INFO - Running post-run listener: copy_logs_to_upload_dir 21:38:57 INFO - Copying logs to upload dir... 21:38:57 INFO - mkdir: /builds/slave/test/build/upload/logs 21:38:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.673349 ========= master_lag: -0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-07 21:38:58.110188) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 21:38:58.113404) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668 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/0e368e98ecbcc31c535b3edfe1eff049ea015f4d5965ee75923ba3364f2cbaaaaaa5be225e34b9c546b057448c0d82530757306a2fabc036eda84b17b2593ab7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/329c8a01e50bd6fe2e559ee32fec2f4746a9b0dc74244f8b71d49ce3d10b28129bc5179f93e7505d9d3a46679166f0ead2c9c3062c7730c0d9beb763ce398636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/809c087cef81e9bce702832446d7d59921dd689dae066a964e635ac0ac7b56bd47fcad3083c34e51be0ef3117cae2bac81d46e4485d272c872448b8863a134fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/589a6ae9809e85127ff4af6cede3baca34f5d6a42257be2c8292fe7a5f4587766a1c2b22d67a63c85dab54deb6c2c061ab2f7274501cb238ac6c85b9980bbb71"} build_url:https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/X3gZNDbARHiwvp6U36z5Eg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0e368e98ecbcc31c535b3edfe1eff049ea015f4d5965ee75923ba3364f2cbaaaaaa5be225e34b9c546b057448c0d82530757306a2fabc036eda84b17b2593ab7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/329c8a01e50bd6fe2e559ee32fec2f4746a9b0dc74244f8b71d49ce3d10b28129bc5179f93e7505d9d3a46679166f0ead2c9c3062c7730c0d9beb763ce398636", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/809c087cef81e9bce702832446d7d59921dd689dae066a964e635ac0ac7b56bd47fcad3083c34e51be0ef3117cae2bac81d46e4485d272c872448b8863a134fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/589a6ae9809e85127ff4af6cede3baca34f5d6a42257be2c8292fe7a5f4587766a1c2b22d67a63c85dab54deb6c2c061ab2f7274501cb238ac6c85b9980bbb71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 21:38:58.144664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:38:58.144978) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502165880.776166-2018606668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 21:38:58.224641) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 21:38:58.227957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 21:38:58.228266) ========= ========= Total master_lag: -0.08 =========