builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1505833165.73 results: success (0) revision: 60a702a06b11a12298fc7fca463b6abcaa067582 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.731399) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.731816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.732079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.750089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.750481) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 07:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2017-09-19 07:59:26 (105 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.926601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.926888) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015837 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.983626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:25.983928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60a702a06b11a12298fc7fca463b6abcaa067582 --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 60a702a06b11a12298fc7fca463b6abcaa067582 --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=14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 07:59:26,271 truncating revision to first 12 chars 2017-09-19 07:59:26,271 Setting DEBUG logging. 2017-09-19 07:59:26,271 attempt 1/10 2017-09-19 07:59:26,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60a702a06b11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 07:59:26,627 unpacking tar archive at: mozilla-beta-60a702a06b11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:26.666561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:26.666876) ========= script_repo_revision: 60a702a06b11a12298fc7fca463b6abcaa067582 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:26.667282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:26.667548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 07:59:26.684152) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-19 07:59:26.684525) ========= /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=14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:59:27 INFO - MultiFileLogger online at 20170919 07:59:27 in /builds/slave/test 07:59:27 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 07:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:27 INFO - {'append_to_log': False, 07:59:27 INFO - 'base_work_dir': '/builds/slave/test', 07:59:27 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:27 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:27 INFO - 'code_coverage': False, 07:59:27 INFO - 'config_files': ('talos/linux_config.py',), 07:59:27 INFO - 'default_actions': ('clobber', 07:59:27 INFO - 'read-buildbot-config', 07:59:27 INFO - 'download-and-extract', 07:59:27 INFO - 'populate-webroot', 07:59:27 INFO - 'create-virtualenv', 07:59:27 INFO - 'install', 07:59:27 INFO - 'setup-mitmproxy', 07:59:27 INFO - 'run-tests'), 07:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:27 INFO - 'disable_ccov_upload': False, 07:59:27 INFO - 'disable_stylo': False, 07:59:27 INFO - 'download_minidump_stackwalk': True, 07:59:27 INFO - 'download_symbols': 'ondemand', 07:59:27 INFO - 'enable_stylo': False, 07:59:27 INFO - 'enable_webrender': False, 07:59:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:27 INFO - 'gecko_profile': False, 07:59:27 INFO - 'gecko_profile_interval': 0, 07:59:27 INFO - 'installer_path': 'installer.exe', 07:59:27 INFO - 'log_level': 'info', 07:59:27 INFO - 'log_name': 'talos', 07:59:27 INFO - 'log_to_console': True, 07:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:59:27 INFO - 'opt_config_files': (), 07:59:27 INFO - 'pip_index': False, 07:59:27 INFO - 'suite': 'dromaeojs-e10s', 07:59:27 INFO - 'system_bits': '32', 07:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:27 INFO - 'title': 'talos-linux64-ix-036', 07:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:27 INFO - 'use_talos_json': True, 07:59:27 INFO - 'verify': 'False', 07:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:27 INFO - 'work_dir': 'build'} 07:59:27 INFO - [mozharness: 2017-09-19 14:59:27.104332Z] Running clobber step. 07:59:27 INFO - Running pre-action listener: _resource_record_pre_action 07:59:27 INFO - Running main action method: clobber 07:59:27 INFO - rmtree: /builds/slave/test/build 07:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:28 INFO - Running post-action listener: _resource_record_post_action 07:59:28 INFO - [mozharness: 2017-09-19 14:59:28.108276Z] Finished clobber step (success) 07:59:28 INFO - [mozharness: 2017-09-19 14:59:28.108374Z] Running read-buildbot-config step. 07:59:28 INFO - Running pre-action listener: _resource_record_pre_action 07:59:28 INFO - Running main action method: read_buildbot_config 07:59:28 INFO - Using buildbot properties: 07:59:28 INFO - { 07:59:28 INFO - "project": "", 07:59:28 INFO - "product": "firefox", 07:59:28 INFO - "who": "ryanvm@gmail.com", 07:59:28 INFO - "installer_path": "public/build/target.tar.bz2", 07:59:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:59:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:59:28 INFO - "stage_platform": "linux64", 07:59:28 INFO - "basedir": "/builds/slave/test", 07:59:28 INFO - "buildnumber": 96, 07:59:28 INFO - "platform": "ubuntu64_hw", 07:59:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:59:28 INFO - "slavebuilddir": "test", 07:59:28 INFO - "taskId": "Y15ejQlATfeyiNtyxc5sKQ", 07:59:28 INFO - "branch": "mozilla-beta", 07:59:28 INFO - "script_repo_revision": "production", 07:59:28 INFO - "revision": "60a702a06b11a12298fc7fca463b6abcaa067582", 07:59:28 INFO - "slavename": "talos-linux64-ix-036", 07:59:28 INFO - "repo_path": "releases/mozilla-beta" 07:59:28 INFO - } 07:59:28 INFO - Finding installer, test and symbols from parent task. 07:59:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y15ejQlATfeyiNtyxc5sKQ'}, attempt #1 07:59:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y15ejQlATfeyiNtyxc5sKQ'}, attempt #1 07:59:29 INFO - Task dependencies: S7rsSIHMSlWKc6HsIfSCSA 07:59:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA'}, attempt #1 07:59:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2 07:59:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.test_packages.json 07:59:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.crashreporter-symbols.zip 07:59:29 INFO - Running post-action listener: _resource_record_post_action 07:59:29 INFO - [mozharness: 2017-09-19 14:59:29.485317Z] Finished read-buildbot-config step (success) 07:59:29 INFO - [mozharness: 2017-09-19 14:59:29.485534Z] Running download-and-extract step. 07:59:29 INFO - Running pre-action listener: _resource_record_pre_action 07:59:29 INFO - Running main action method: download_and_extract 07:59:29 INFO - mkdir: /builds/slave/test/build/tests 07:59:29 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')]} 07:59:29 INFO - trying https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.test_packages.json 07:59:29 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:59:30 INFO - Downloaded 989 bytes. 07:59:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:59:30 INFO - Using the following test package requirements: 07:59:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:59:30 INFO - u'common': [u'target.common.tests.zip'], 07:59:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:59:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:59:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:59:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:59:30 INFO - u'mozbase': [u'target.common.tests.zip'], 07:59:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:59:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:59:30 INFO - u'web-platform': [u'target.common.tests.zip', 07:59:30 INFO - u'target.web-platform.tests.tar.gz'], 07:59:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:59:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:59:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.common.tests.zip 07:59:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:59:30 INFO - Fetch https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.common.tests.zip into memory 07:59:32 INFO - Content-Length response header: 55168618 07:59:32 INFO - Bytes received: 55168618 07:59:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.talos.tests.zip 07:59:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:59:42 INFO - Fetch https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.talos.tests.zip into memory 07:59:44 INFO - Content-Length response header: 14508787 07:59:44 INFO - Bytes received: 14508787 07:59: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')]} 07:59:44 INFO - trying https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2 07:59:44 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:59:47 INFO - Downloaded 53414396 bytes. 07:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2 07:59:47 INFO - mkdir: /builds/slave/test/properties 07:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:59:47 INFO - Contents: 07:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2 07:59:47 INFO - Running post-action listener: _resource_record_post_action 07:59:47 INFO - Running post-action listener: find_tests_for_verification 07:59:47 INFO - Running post-action listener: set_extra_try_arguments 07:59:47 INFO - [mozharness: 2017-09-19 14:59:47.169466Z] Finished download-and-extract step (success) 07:59:47 INFO - [mozharness: 2017-09-19 14:59:47.169589Z] Running populate-webroot step. 07:59:47 INFO - Running pre-action listener: _resource_record_pre_action 07:59:47 INFO - Running main action method: populate_webroot 07:59:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:59:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['tresize', 07:59:47 INFO - 'tcanvasmark']}, 07:59:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:59:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['dromaeo_css', 07:59:47 INFO - 'kraken']}, 07:59:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:59:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'tests': ['damp', 'tps']}, 07:59:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['damp', 'tps']}, 07:59:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:59:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['dromaeo_dom']}, 07:59:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:59:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['basic_compositor_video', 07:59:47 INFO - 'glvideo']}, 07:59:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:59:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['ts_paint_webext', 07:59:47 INFO - 'tp5o_webext']}, 07:59:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:59:47 INFO - 'ts_paint', 07:59:47 INFO - 'tpaint', 07:59:47 INFO - 'sessionrestore', 07:59:47 INFO - 'sessionrestore_many_windows', 07:59:47 INFO - 'sessionrestore_no_auto_restore', 07:59:47 INFO - 'tabpaint']}, 07:59:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['a11yr', 07:59:47 INFO - 'ts_paint', 07:59:47 INFO - 'tpaint', 07:59:47 INFO - 'sessionrestore', 07:59:47 INFO - 'sessionrestore_many_windows', 07:59:47 INFO - 'sessionrestore_no_auto_restore', 07:59:47 INFO - 'tabpaint']}, 07:59:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:59:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:59:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['perf_reftest_singletons']}, 07:59:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['bloom_basic']}, 07:59:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:59:47 INFO - 'tsvgr_opacity', 07:59:47 INFO - 'tart', 07:59:47 INFO - 'tscrollx', 07:59:47 INFO - 'tsvg_static']}, 07:59:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['tsvgx', 07:59:47 INFO - 'tsvgr_opacity', 07:59:47 INFO - 'tart', 07:59:47 INFO - 'tscrollx', 07:59:47 INFO - 'tsvg_static']}, 07:59:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:59:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'talos_options': ['--disable-stylo'], 07:59:47 INFO - 'tests': ['tp5o']}, 07:59:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:59:47 INFO - 'talos_options': ['--mitmproxy', 07:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:59:47 INFO - '--firstNonBlankPaint'], 07:59:47 INFO - 'tests': ['tp6_google', 07:59:47 INFO - 'tp6_youtube', 07:59:47 INFO - 'tp6_amazon', 07:59:47 INFO - 'tp6_facebook']}, 07:59:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:59:47 INFO - 'talos_options': ['--disable-stylo', 07:59:47 INFO - '--mitmproxy', 07:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:59:47 INFO - '--firstNonBlankPaint'], 07:59:47 INFO - 'tests': ['tp6_google', 07:59:47 INFO - 'tp6_youtube', 07:59:47 INFO - 'tp6_amazon', 07:59:47 INFO - 'tp6_facebook']}, 07:59:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:59:47 INFO - 'talos_options': ['--stylo-threads=1', 07:59:47 INFO - '--mitmproxy', 07:59:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:59:47 INFO - '--firstNonBlankPaint'], 07:59:47 INFO - 'tests': ['tp6_google', 07:59:47 INFO - 'tp6_youtube', 07:59:47 INFO - 'tp6_amazon', 07:59:47 INFO - 'tp6_facebook']}, 07:59:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'talos_options': ['--xperf_path', 07:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:47 INFO - 'tests': ['tp5n']}, 07:59:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:59:47 INFO - 'talos_options': ['--disable-stylo', 07:59:47 INFO - '--xperf_path', 07:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:59:47 INFO - 'tests': ['tp5n']}}} 07:59:47 INFO - Running post-action listener: _resource_record_post_action 07:59:47 INFO - [mozharness: 2017-09-19 14:59:47.186718Z] Finished populate-webroot step (success) 07:59:47 INFO - [mozharness: 2017-09-19 14:59:47.186809Z] Running create-virtualenv step. 07:59:47 INFO - Running pre-action listener: _resource_record_pre_action 07:59:47 INFO - Running main action method: create_virtualenv 07:59:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:59:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:59:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:59:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:59:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:59:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:59:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:59:48 INFO - Installing pip...............done. 07:59:48 INFO - Return code: 0 07:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:59:48 INFO - Reading from file tmpfile_stdout 07:59:48 INFO - Output received: 07:59:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:59:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:59:48 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')]} 07:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:48 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')]} 07:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:48 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59:48 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 07:59:48 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 07:59:48 INFO - Using env: {'DISPLAY': ':0', 07:59:48 INFO - 'HOME': '/home/cltbld', 07:59:48 INFO - 'LANG': 'en_US.UTF-8', 07:59:48 INFO - 'LANGUAGE': 'en_US:en', 07:59:48 INFO - 'LOGNAME': 'cltbld', 07:59:48 INFO - 'MAIL': '/var/mail/cltbld', 07:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:48 INFO - 'MOZ_NO_REMOTE': '1', 07:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:48 INFO - 'NO_EM_RESTART': '1', 07:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:48 INFO - 'PWD': '/builds/slave/test', 07:59:48 INFO - 'SHELL': '/bin/bash', 07:59:48 INFO - 'SHLVL': '1', 07:59:48 INFO - 'TERM': 'linux', 07:59:48 INFO - 'TMOUT': '86400', 07:59:48 INFO - 'USER': 'cltbld', 07:59:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:48 INFO - '_': '/tools/buildbot/bin/python'} 07:59:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:59:49 INFO - Downloading/unpacking pip>=1.5 07:59:49 INFO - Running setup.py egg_info for package pip 07:59:49 INFO - warning: no files found matching 'pip/cacert.pem' 07:59:49 INFO - warning: no files found matching '*.html' under directory 'docs' 07:59:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:59:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:59:49 INFO - Installing collected packages: pip 07:59:49 INFO - Found existing installation: pip 1.1 07:59:49 INFO - Uninstalling pip: 07:59:49 INFO - Successfully uninstalled pip 07:59:49 INFO - Running setup.py install for pip 07:59:49 INFO - warning: no files found matching 'pip/cacert.pem' 07:59:49 INFO - warning: no files found matching '*.html' under directory 'docs' 07:59:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:59:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:59:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:59:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:59:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:59:49 INFO - Successfully installed pip 07:59:49 INFO - Cleaning up... 07:59:49 INFO - Return code: 0 07:59:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59: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')]} 07:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59: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', '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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:59: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 psutil>=3.1.1 07:59:49 INFO - Using env: {'DISPLAY': ':0', 07:59:49 INFO - 'HOME': '/home/cltbld', 07:59:49 INFO - 'LANG': 'en_US.UTF-8', 07:59:49 INFO - 'LANGUAGE': 'en_US:en', 07:59:49 INFO - 'LOGNAME': 'cltbld', 07:59:49 INFO - 'MAIL': '/var/mail/cltbld', 07:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:49 INFO - 'MOZ_NO_REMOTE': '1', 07:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:49 INFO - 'NO_EM_RESTART': '1', 07:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:49 INFO - 'PWD': '/builds/slave/test', 07:59:49 INFO - 'SHELL': '/bin/bash', 07:59:49 INFO - 'SHLVL': '1', 07:59:49 INFO - 'TERM': 'linux', 07:59:49 INFO - 'TMOUT': '86400', 07:59:49 INFO - 'USER': 'cltbld', 07:59:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:49 INFO - '_': '/tools/buildbot/bin/python'} 07:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:49 INFO - Downloading/unpacking psutil>=3.1.1 07:59: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 07:59: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 07:59: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 07:59: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 07:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:50 INFO - Installing collected packages: psutil 07:59:50 INFO - Running setup.py install for psutil 07:59:50 INFO - building 'psutil._psutil_linux' extension 07:59:50 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 07:59:51 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 07:59:51 INFO - building 'psutil._psutil_posix' extension 07:59:51 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 07:59:51 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 07:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:51 INFO - Successfully installed psutil 07:59:51 INFO - Cleaning up... 07:59:51 INFO - Return code: 0 07:59:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59: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')]} 07:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:59: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 mozsystemmonitor==0.3 07:59:51 INFO - Using env: {'DISPLAY': ':0', 07:59:51 INFO - 'HOME': '/home/cltbld', 07:59:51 INFO - 'LANG': 'en_US.UTF-8', 07:59:51 INFO - 'LANGUAGE': 'en_US:en', 07:59:51 INFO - 'LOGNAME': 'cltbld', 07:59:51 INFO - 'MAIL': '/var/mail/cltbld', 07:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:51 INFO - 'MOZ_NO_REMOTE': '1', 07:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:51 INFO - 'NO_EM_RESTART': '1', 07:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:51 INFO - 'PWD': '/builds/slave/test', 07:59:51 INFO - 'SHELL': '/bin/bash', 07:59:51 INFO - 'SHLVL': '1', 07:59:51 INFO - 'TERM': 'linux', 07:59:51 INFO - 'TMOUT': '86400', 07:59:51 INFO - 'USER': 'cltbld', 07:59:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:51 INFO - '_': '/tools/buildbot/bin/python'} 07:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:59: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 07:59: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 07:59: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 07:59: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 07:59:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:52 INFO - Installing collected packages: mozsystemmonitor 07:59:52 INFO - Running setup.py install for mozsystemmonitor 07:59:52 INFO - Successfully installed mozsystemmonitor 07:59:52 INFO - Cleaning up... 07:59:53 INFO - Return code: 0 07:59:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59: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')]} 07:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:53 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59:53 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 07:59:53 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 07:59:53 INFO - Using env: {'DISPLAY': ':0', 07:59:53 INFO - 'HOME': '/home/cltbld', 07:59:53 INFO - 'LANG': 'en_US.UTF-8', 07:59:53 INFO - 'LANGUAGE': 'en_US:en', 07:59:53 INFO - 'LOGNAME': 'cltbld', 07:59:53 INFO - 'MAIL': '/var/mail/cltbld', 07:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:53 INFO - 'MOZ_NO_REMOTE': '1', 07:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:53 INFO - 'NO_EM_RESTART': '1', 07:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:53 INFO - 'PWD': '/builds/slave/test', 07:59:53 INFO - 'SHELL': '/bin/bash', 07:59:53 INFO - 'SHLVL': '1', 07:59:53 INFO - 'TERM': 'linux', 07:59:53 INFO - 'TMOUT': '86400', 07:59:53 INFO - 'USER': 'cltbld', 07:59:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:53 INFO - '_': '/tools/buildbot/bin/python'} 07:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:53 INFO - Downloading/unpacking jsonschema==2.5.1 07:59:53 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 07:59:53 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 07:59:53 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 07:59:53 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 07:59:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 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 07:59:55 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:55 INFO - warning: no files found matching '*.txt' 07:59:55 INFO - no previously-included directories found matching 'build' 07:59:55 INFO - no previously-included directories found matching 'dist' 07:59:55 INFO - no previously-included directories found matching '.git*' 07:59:55 INFO - Installing collected packages: jsonschema, functools32 07:59:55 INFO - Running setup.py install for functools32 07:59:55 INFO - warning: no files found matching '*.txt' 07:59:55 INFO - no previously-included directories found matching 'build' 07:59:55 INFO - no previously-included directories found matching 'dist' 07:59:55 INFO - no previously-included directories found matching '.git*' 07:59:55 INFO - Successfully installed jsonschema functools32 07:59:55 INFO - Cleaning up... 07:59:55 INFO - Return code: 0 07:59:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:55 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')]} 07:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:55 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')]} 07:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:55 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59:55 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 07:59:55 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 07:59:55 INFO - Using env: {'DISPLAY': ':0', 07:59:55 INFO - 'HOME': '/home/cltbld', 07:59:55 INFO - 'LANG': 'en_US.UTF-8', 07:59:55 INFO - 'LANGUAGE': 'en_US:en', 07:59:55 INFO - 'LOGNAME': 'cltbld', 07:59:55 INFO - 'MAIL': '/var/mail/cltbld', 07:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:55 INFO - 'MOZ_NO_REMOTE': '1', 07:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:55 INFO - 'NO_EM_RESTART': '1', 07:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:55 INFO - 'PWD': '/builds/slave/test', 07:59:55 INFO - 'SHELL': '/bin/bash', 07:59:55 INFO - 'SHLVL': '1', 07:59:55 INFO - 'TERM': 'linux', 07:59:55 INFO - 'TMOUT': '86400', 07:59:55 INFO - 'USER': 'cltbld', 07:59:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:55 INFO - '_': '/tools/buildbot/bin/python'} 07:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:55 INFO - Cleaning up... 07:59:55 INFO - Return code: 0 07:59:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:55 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')]} 07:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:55 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')]} 07:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:55 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59:55 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 07:59:55 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 07:59:55 INFO - Using env: {'DISPLAY': ':0', 07:59:55 INFO - 'HOME': '/home/cltbld', 07:59:55 INFO - 'LANG': 'en_US.UTF-8', 07:59:55 INFO - 'LANGUAGE': 'en_US:en', 07:59:55 INFO - 'LOGNAME': 'cltbld', 07:59:55 INFO - 'MAIL': '/var/mail/cltbld', 07:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:55 INFO - 'MOZ_NO_REMOTE': '1', 07:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:55 INFO - 'NO_EM_RESTART': '1', 07:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:55 INFO - 'PWD': '/builds/slave/test', 07:59:55 INFO - 'SHELL': '/bin/bash', 07:59:55 INFO - 'SHLVL': '1', 07:59:55 INFO - 'TERM': 'linux', 07:59:55 INFO - 'TMOUT': '86400', 07:59:55 INFO - 'USER': 'cltbld', 07:59:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:55 INFO - '_': '/tools/buildbot/bin/python'} 07:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:56 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 07:59:56 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 07:59:56 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 07:59:56 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 07:59:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:57 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 07:59:57 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 07:59:57 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 07:59:57 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 07:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:57 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 07:59:57 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 07:59:57 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 07:59:57 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 07:59:57 INFO - Downloading docopt-0.6.1.tar.gz 07:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:57 INFO - Running setup.py install for blobuploader 07:59:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:57 INFO - Running setup.py install for requests 07:59:58 INFO - Running setup.py install for docopt 07:59:58 INFO - Successfully installed blobuploader requests docopt 07:59:58 INFO - Cleaning up... 07:59:58 INFO - Return code: 0 07:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:58 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 07:59:58 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 07:59:58 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 07:59:58 INFO - Using env: {'DISPLAY': ':0', 07:59:58 INFO - 'HOME': '/home/cltbld', 07:59:58 INFO - 'LANG': 'en_US.UTF-8', 07:59:58 INFO - 'LANGUAGE': 'en_US:en', 07:59:58 INFO - 'LOGNAME': 'cltbld', 07:59:58 INFO - 'MAIL': '/var/mail/cltbld', 07:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:58 INFO - 'MOZ_NO_REMOTE': '1', 07:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:58 INFO - 'NO_EM_RESTART': '1', 07:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:58 INFO - 'PWD': '/builds/slave/test', 07:59:58 INFO - 'SHELL': '/bin/bash', 07:59:58 INFO - 'SHLVL': '1', 07:59:58 INFO - 'TERM': 'linux', 07:59:58 INFO - 'TMOUT': '86400', 07:59:58 INFO - 'USER': 'cltbld', 07:59:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 07:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:58 INFO - '_': '/tools/buildbot/bin/python'} 07:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:58 INFO - Running setup.py (path:/tmp/pip-ChIld4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:58 INFO - Running setup.py (path:/tmp/pip-LmMpL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:58 INFO - Running setup.py (path:/tmp/pip-TtPUvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:58 INFO - Running setup.py (path:/tmp/pip-8bfnUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:58 INFO - Running setup.py (path:/tmp/pip-YwztR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:59 INFO - Running setup.py (path:/tmp/pip-kyvIfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:59 INFO - Running setup.py (path:/tmp/pip-kixlX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:59 INFO - Running setup.py (path:/tmp/pip-N41LVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:59 INFO - Running setup.py (path:/tmp/pip-jm6qst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:59 INFO - Running setup.py (path:/tmp/pip-ALQhBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:59 INFO - Running setup.py (path:/tmp/pip-dYZGrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:59 INFO - Running setup.py (path:/tmp/pip-25PoXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:59 INFO - Running setup.py (path:/tmp/pip-yqj9Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:59 INFO - Running setup.py (path:/tmp/pip-U8hxqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:59 INFO - Running setup.py (path:/tmp/pip-PuO8h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:59 INFO - Running setup.py (path:/tmp/pip-g1XMcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:59 INFO - Running setup.py (path:/tmp/pip-kAJw9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:59 INFO - Running setup.py install for manifestparser 07:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:59 INFO - Running setup.py install for mozcrash 08:00:00 INFO - Running setup.py install for mozdebug 08:00:00 INFO - Running setup.py install for mozdevice 08:00:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Running setup.py install for mozfile 08:00:00 INFO - Running setup.py install for mozhttpd 08:00:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Running setup.py install for mozinfo 08:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Running setup.py install for mozInstall 08:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Running setup.py install for mozleak 08:00:00 INFO - Running setup.py install for mozlog 08:00:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Running setup.py install for moznetwork 08:00:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:00 INFO - Running setup.py install for mozprocess 08:00:01 INFO - Running setup.py install for mozprofile 08:00:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:01 INFO - Running setup.py install for mozrunner 08:00:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:01 INFO - Running setup.py install for mozscreenshot 08:00:01 INFO - Running setup.py install for moztest 08:00:01 INFO - Running setup.py install for mozversion 08:00:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:01 INFO - Cleaning up... 08:00:01 INFO - Return code: 0 08:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:01 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 08:00:01 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 08:00:01 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 08:00:01 INFO - Using env: {'DISPLAY': ':0', 08:00:01 INFO - 'HOME': '/home/cltbld', 08:00:01 INFO - 'LANG': 'en_US.UTF-8', 08:00:01 INFO - 'LANGUAGE': 'en_US:en', 08:00:01 INFO - 'LOGNAME': 'cltbld', 08:00:01 INFO - 'MAIL': '/var/mail/cltbld', 08:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:01 INFO - 'MOZ_NO_REMOTE': '1', 08:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:01 INFO - 'NO_EM_RESTART': '1', 08:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:01 INFO - 'PWD': '/builds/slave/test', 08:00:01 INFO - 'SHELL': '/bin/bash', 08:00:01 INFO - 'SHLVL': '1', 08:00:01 INFO - 'TERM': 'linux', 08:00:01 INFO - 'TMOUT': '86400', 08:00:01 INFO - 'USER': 'cltbld', 08:00:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 08:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:01 INFO - '_': '/tools/buildbot/bin/python'} 08:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:01 INFO - Running setup.py (path:/tmp/pip-bPjDzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:01 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)) 08:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:01 INFO - Running setup.py (path:/tmp/pip-zRl6L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:01 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:02 INFO - Running setup.py (path:/tmp/pip-vcJYfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:02 INFO - Running setup.py (path:/tmp/pip-yCJVuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:02 INFO - Running setup.py (path:/tmp/pip-8ytihv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:02 INFO - Running setup.py (path:/tmp/pip-5aYUp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:02 INFO - Running setup.py (path:/tmp/pip-u0LUs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:02 INFO - Running setup.py (path:/tmp/pip-1BIk1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:02 INFO - Running setup.py (path:/tmp/pip-asD97l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:02 INFO - Running setup.py (path:/tmp/pip-sAuMBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:02 INFO - Running setup.py (path:/tmp/pip-Ehe8Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:02 INFO - Running setup.py (path:/tmp/pip-qeU8L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:02 INFO - Running setup.py (path:/tmp/pip-dVIYbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:02 INFO - Running setup.py (path:/tmp/pip-5hjj6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:02 INFO - Running setup.py (path:/tmp/pip-4CfLb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:02 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)) 08:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:02 INFO - Running setup.py (path:/tmp/pip-L6Xw3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:03 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)) 08:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:03 INFO - Running setup.py (path:/tmp/pip-jZrhWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 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)) 08:00:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:04 INFO - Downloading blessings-1.6.tar.gz 08:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:04 INFO - Installing collected packages: blessings 08:00:04 INFO - Running setup.py install for blessings 08:00:04 INFO - Successfully installed blessings 08:00:04 INFO - Cleaning up... 08:00:04 INFO - Return code: 0 08:00:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:04 INFO - Reading from file tmpfile_stdout 08:00:04 INFO - Current package versions: 08:00:04 INFO - argparse == 1.2.1 08:00:04 INFO - blessings == 1.6 08:00:04 INFO - blobuploader == 1.2.4 08:00:04 INFO - docopt == 0.6.1 08:00:04 INFO - functools32 == 3.2.3-2 08:00:04 INFO - jsonschema == 2.5.1 08:00:04 INFO - manifestparser == 1.1 08:00:04 INFO - mozInstall == 1.13 08:00:04 INFO - mozcrash == 1.0 08:00:04 INFO - mozdebug == 0.1 08:00:04 INFO - mozdevice == 0.51 08:00:04 INFO - mozfile == 1.2 08:00:04 INFO - mozhttpd == 0.7 08:00:04 INFO - mozinfo == 0.10 08:00:04 INFO - mozleak == 0.1 08:00:04 INFO - mozlog == 3.5 08:00:04 INFO - moznetwork == 0.27 08:00:04 INFO - mozprocess == 0.25 08:00:04 INFO - mozprofile == 0.28 08:00:04 INFO - mozrunner == 6.13 08:00:04 INFO - mozscreenshot == 0.1 08:00:04 INFO - mozsystemmonitor == 0.3 08:00:04 INFO - moztest == 0.8 08:00:04 INFO - mozversion == 1.4 08:00:04 INFO - psutil == 3.1.1 08:00:04 INFO - requests == 1.2.3 08:00:04 INFO - wsgiref == 0.1.2 08:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:04 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 08:00:04 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 08:00:04 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 08:00:04 INFO - Using env: {'DISPLAY': ':0', 08:00:04 INFO - 'HOME': '/home/cltbld', 08:00:04 INFO - 'LANG': 'en_US.UTF-8', 08:00:04 INFO - 'LANGUAGE': 'en_US:en', 08:00:04 INFO - 'LOGNAME': 'cltbld', 08:00:04 INFO - 'MAIL': '/var/mail/cltbld', 08:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:04 INFO - 'MOZ_NO_REMOTE': '1', 08:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:04 INFO - 'NO_EM_RESTART': '1', 08:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:04 INFO - 'PWD': '/builds/slave/test', 08:00:04 INFO - 'SHELL': '/bin/bash', 08:00:04 INFO - 'SHLVL': '1', 08:00:04 INFO - 'TERM': 'linux', 08:00:04 INFO - 'TMOUT': '86400', 08:00:04 INFO - 'USER': 'cltbld', 08:00:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 08:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:04 INFO - '_': '/tools/buildbot/bin/python'} 08:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 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)) 08:00:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:00:06 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)) 08:00:06 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)) 08:00:06 INFO - Installing collected packages: simplejson 08:00:06 INFO - Running setup.py install for simplejson 08:00:06 INFO - building 'simplejson._speedups' extension 08:00:06 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 08:00:06 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 08:00:07 INFO - Successfully installed simplejson 08:00:07 INFO - Cleaning up... 08:00:07 INFO - Return code: 0 08:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:07 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 0x239d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2565a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2708a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', '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 08:00:07 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 08:00:07 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 08:00:07 INFO - Using env: {'DISPLAY': ':0', 08:00:07 INFO - 'HOME': '/home/cltbld', 08:00:07 INFO - 'LANG': 'en_US.UTF-8', 08:00:07 INFO - 'LANGUAGE': 'en_US:en', 08:00:07 INFO - 'LOGNAME': 'cltbld', 08:00:07 INFO - 'MAIL': '/var/mail/cltbld', 08:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:07 INFO - 'MOZ_NO_REMOTE': '1', 08:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:07 INFO - 'NO_EM_RESTART': '1', 08:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:07 INFO - 'PWD': '/builds/slave/test', 08:00:07 INFO - 'SHELL': '/bin/bash', 08:00:07 INFO - 'SHLVL': '1', 08:00:07 INFO - 'TERM': 'linux', 08:00:07 INFO - 'TMOUT': '86400', 08:00:07 INFO - 'USER': 'cltbld', 08:00:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 08:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:07 INFO - '_': '/tools/buildbot/bin/python'} 08:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:07 INFO - Cleaning up... 08:00:07 INFO - Return code: 0 08:00:07 INFO - Running post-action listener: _resource_record_post_action 08:00:07 INFO - Running post-action listener: _start_resource_monitoring 08:00:07 INFO - Starting resource monitoring. 08:00:07 INFO - [mozharness: 2017-09-19 15:00:07.378945Z] Finished create-virtualenv step (success) 08:00:07 INFO - [mozharness: 2017-09-19 15:00:07.379467Z] Running install step. 08:00:07 INFO - Running pre-action listener: _resource_record_pre_action 08:00:07 INFO - Running main action method: install 08:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:07 INFO - Reading from file tmpfile_stdout 08:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:07 INFO - Reading from file tmpfile_stdout 08:00:07 INFO - Output received: 08:00:07 INFO - Usage: mozinstall [options] installer 08:00:07 INFO - Options: 08:00:07 INFO - -h, --help show this help message and exit 08:00:07 INFO - -d DEST, --destination=DEST 08:00:07 INFO - Directory to install application into. [default: 08:00:07 INFO - "/builds/slave/test"] 08:00:07 INFO - --app=APP Application being installed. [default: firefox] 08:00:07 INFO - mkdir: /builds/slave/test/build/application 08:00:07 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'] 08:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:00:22 INFO - Reading from file tmpfile_stdout 08:00:22 INFO - Output received: 08:00:22 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:22 INFO - Running post-action listener: _resource_record_post_action 08:00:22 INFO - [mozharness: 2017-09-19 15:00:22.344211Z] Finished install step (success) 08:00:22 INFO - [mozharness: 2017-09-19 15:00:22.344463Z] Running setup-mitmproxy step. 08:00:22 INFO - Running pre-action listener: _resource_record_pre_action 08:00:22 INFO - Running main action method: setup_mitmproxy 08:00:22 INFO - Skipping: mitmproxy is not required 08:00:22 INFO - Running post-action listener: _resource_record_post_action 08:00:22 INFO - [mozharness: 2017-09-19 15:00:22.345583Z] Finished setup-mitmproxy step (success) 08:00:22 INFO - [mozharness: 2017-09-19 15:00:22.345804Z] Running run-tests step. 08:00:22 INFO - Running pre-action listener: _resource_record_pre_action 08:00:22 INFO - Running pre-action listener: _set_gcov_prefix 08:00:22 INFO - Running main action method: run_tests 08:00:22 WARNING - Try message not found. 08:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:22 INFO - Python 2.7.3 08:00:22 INFO - Return code: 0 08:00:22 INFO - grabbing minidump binary from tooltool 08:00:22 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')]} 08:00:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x270c090>, '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 0x270cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2706f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 08:00:22 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:00:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 08:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:22 INFO - Return code: 0 08:00:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:22 INFO - ENV: RUST_BACKTRACE is now full 08:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:22 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/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:00:22 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/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 08:00:22 INFO - Using env: {'DISPLAY': ':0', 08:00:22 INFO - 'HOME': '/home/cltbld', 08:00:22 INFO - 'LANG': 'en_US.UTF-8', 08:00:22 INFO - 'LANGUAGE': 'en_US:en', 08:00:22 INFO - 'LOGNAME': 'cltbld', 08:00:22 INFO - 'MAIL': '/var/mail/cltbld', 08:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:22 INFO - 'MOZ_NO_REMOTE': '1', 08:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:22 INFO - 'NO_EM_RESTART': '1', 08:00:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:22 INFO - 'PWD': '/builds/slave/test', 08:00:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:22 INFO - 'RUST_BACKTRACE': 'full', 08:00:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:00:22 INFO - 'SHELL': '/bin/bash', 08:00:22 INFO - 'SHLVL': '1', 08:00:22 INFO - 'TERM': 'linux', 08:00:22 INFO - 'TMOUT': '86400', 08:00:22 INFO - 'USER': 'cltbld', 08:00:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 08:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:22 INFO - '_': '/tools/buildbot/bin/python'} 08:00:22 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/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 08:00:22 INFO - mozversion application_buildid: 20170919134128 08:00:22 INFO - mozversion application_changeset: 60a702a06b11a12298fc7fca463b6abcaa067582 08:00:22 INFO - mozversion application_display_name: Firefox 08:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:22 INFO - mozversion application_name: Firefox 08:00:22 INFO - mozversion application_remotingname: firefox 08:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:00:22 INFO - mozversion application_vendor: Mozilla 08:00:22 INFO - mozversion application_version: 57.0 08:00:22 INFO - mozversion platform_buildid: 20170919134128 08:00:22 INFO - mozversion platform_changeset: 60a702a06b11a12298fc7fca463b6abcaa067582 08:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:00:22 INFO - mozversion platform_version: 57.0 08:00:22 INFO - using testdate: 1505833222 08:00:22 INFO - actual date: 1505833222 08:00:22 INFO - starting webserver on 'localhost:43171' 08:00:22 INFO - SUITE-START | Running 2 tests 08:00:22 INFO - TEST-START | dromaeo_css 08:00:22 INFO - Initialising browser for dromaeo_css test... 08:00:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43171/getInfo.html -profile /tmp/tmppcAD7p/profile 08:00:22 INFO - TEST-INFO | started process 25703 (/builds/slave/test/build/application/firefox/firefox http://localhost:43171/getInfo.html) 08:00:28 INFO - TEST-INFO | 25703: exit 0 08:00:28 INFO - Browser initialized. 08:00:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:28 INFO - Using env: {'DISPLAY': ':0', 08:00:28 INFO - 'HOME': '/home/cltbld', 08:00:28 INFO - 'JSGC_DISABLE_POISONING': '1', 08:00:28 INFO - 'LANG': 'en_US.UTF-8', 08:00:28 INFO - 'LANGUAGE': 'en_US:en', 08:00:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:00:28 INFO - 'LOGNAME': 'cltbld', 08:00:28 INFO - 'MAIL': '/var/mail/cltbld', 08:00:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:28 INFO - 'MOZ_CRASHREPORTER': '1', 08:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:00:28 INFO - 'MOZ_NO_REMOTE': '1', 08:00:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:28 INFO - 'NO_EM_RESTART': '1', 08:00:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:28 INFO - 'PWD': '/builds/slave/test', 08:00:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:28 INFO - 'RUST_BACKTRACE': 'full', 08:00:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:00:28 INFO - 'SHELL': '/bin/bash', 08:00:28 INFO - 'SHLVL': '1', 08:00:28 INFO - 'TERM': 'linux', 08:00:28 INFO - 'TMOUT': '86400', 08:00:28 INFO - 'USER': 'cltbld', 08:00:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 08:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:28 INFO - '_': '/tools/buildbot/bin/python'} 08:00:28 INFO - TEST-INFO | started process 25892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppcAD7p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:39 INFO - PID 25892 | RSS: Main: 143482880 08:00:39 INFO - PID 25892 | 08:03:36 INFO - PID 25892 | Cycle 1(1): loaded http://localhost:43171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43171/tests/dromaeo/cssquery-ext.html) 08:03:37 INFO - PID 25892 | RSS: Main: 147050496 08:03:37 INFO - PID 25892 | 08:06:39 INFO - PID 25892 | Cycle 1(1): loaded http://localhost:43171/tests/dromaeo/cssquery-ext.html (next: http://localhost:43171/tests/dromaeo/cssquery-jquery.html) 08:06:39 INFO - PID 25892 | RSS: Main: 145637376 08:06:39 INFO - PID 25892 | 08:09:41 INFO - PID 25892 | Cycle 1(1): loaded http://localhost:43171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43171/tests/dromaeo/cssquery-mootools.html) 08:09:41 INFO - PID 25892 | RSS: Main: 147001344 08:09:41 INFO - PID 25892 | 08:12:43 INFO - PID 25892 | Cycle 1(1): loaded http://localhost:43171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43171/tests/dromaeo/cssquery-prototype.html) 08:12:43 INFO - PID 25892 | RSS: Main: 145547264 08:12:43 INFO - PID 25892 | 08:15:46 INFO - PID 25892 | Cycle 1(1): loaded http://localhost:43171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43171/tests/dromaeo/cssquery-yui.html) 08:15:47 INFO - PID 25892 | RSS: Main: 148234240 08:15:47 INFO - PID 25892 | 08:18:48 INFO - PID 25892 | Cycle 1(1): loaded http://localhost:43171/tests/dromaeo/cssquery-yui.html (next: http://localhost:43171/tests/dromaeo/cssquery-dojo.html) 08:18:49 INFO - PID 25892 | RSS: Main: 151318528 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | __start_tp_report 08:18:49 INFO - PID 25892 | _x_x_mozilla_page_load 08:18:49 INFO - PID 25892 | _x_x_mozilla_page_load_details 08:18:49 INFO - PID 25892 | |i|pagename|runs| 08:18:49 INFO - PID 25892 | |0;dojo.html;3921.4509968604402;3930.547986981498;3952.8616498422552;3970.0670342469534;3997.6002399760027;6294.496440284777;6354.173957385539;6423.486121110312;6456.967715161418;6484.837879053026;6366.522510811685;6403.647799371044;6494.415502604765;6494.74021039159;6502.902456463157;5683.715814209294;5748.885022299552;5794.565407594426;5816.447437493432;5856.414358564152;5748.683822389767;5780.7687692492245;5801.24583804107;5863.149843272723;5894.17481552583;5811.651300921937;5820.039693450575;5834.941650583503;5861.8827623447505;5864.384239654839;5772.884542309131;5781.479666830005;5863.179154918314;5902.734376953026;5919.230500035011;5641.71791410432;5669.433056694339;5740.282464691913;5774.220480235199;5802;6267.655278959655;6288.402601752826;6321.87356252877;6328.082428047954;6353.904691429586;6859.588424694534;6861.416779573742;6942.958556216558;6949.096617439751;6961.025456436103;6917.619530925797;6927;6950.783612867728;7011.3339232772805;7017.403520700746;6432.678366081724;6444.097826304321;6451.645159516224;6453.774117905851;6483.643399613019;7111.893321600181;7124.821879453055;7199.856002879913;7213.134423869169;7213.711451541984;6869.107016087876;6896.827579310457;6967.024616553686;6969.756058537927;6974.128233970754;6887.104676392037;6940.583564986016;6962.373386395248;6979.616121113388;7017.087778588751;6922.550034247758;6954.3045695431065;6970.825729356807;7008.0188773571745;7014.19336776267;6914.274001229899;6920.861582768316;6939.930600693929;6959.338862808025;7037.859242815115;5094.694318340911;5118.411382690963;5134.152864777345;5150.639455238173;5186.429492755794;4721.929171062437;4745.501722319176;4775.450823155312;4781.163296423112;4807.18277892759;6591.670416479157;6603.834904127435;6625.768098116543;6675.198976122896;6684.933150668431;6876.965615171892;6952.513324067267;6980.406665433394;6980.685869135901;7066.434685225169;6536.379043990813;6590;6601.76893808724;6603.636799976048;6622.966885165543;5831.912521312183;5838.1242813577455;5854.326752423441;5854.824355269348;5874.441928016831;7265.309795569412;7287.854242915112;7290.526115802456;7292.3801476874;7395.445341599401;6900.447964162755;6964.686589103401;6989.231184569591;6989.231184569795;6998.545094568837;7125.67934442941;7219.711211551479;7242;7244.492885497964;7245;6796.864062718817;6857.382835544825;6885.862282754417;6894.96575513677;6900.689468973807;6935.7225710971;6952.756653517103;6988.846840271502;7010.4041156500225;7016.158061032709;6704.530682852349;6711.429528490133;6780.796576102724;6788.287229840796;6796.456283497209;6685.732570697118;6706.66466676674;6774.559653622498;6784.86430271382;6789.049533065276;6553.901691474536;6627.734890604322;6663.566868153554;6684.0642310075655;6712.026756120433;6775.525713200029;6789.15135608049;6850.6574671267235;6894.965525172543;6898.896516552155;6596.80209593713;6600.141981542369;6683.398494135551;6695.799126026227;6710.328967103251 08:18:49 INFO - PID 25892 | |1;ext.html;987.7481242283217;993.9850902236473;1011.7217765114592;1019.8929112443195;1023.278588595041;45526.772366138204;46647.76676116623;46653.300200496975;46742.532574674246;46778.53221467784;43977.56022439775;44019.779901100526;44065;44175;46600.30099548509;8831.602577883994;8931.866022009675;9031.367804253705;9070.54647267634;9081.727548173532;8961.327900407463;8990.505522196276;9046.86429703555;9049.457032578033;9073.500957447337;8920.776980575472;8983.505907175102;8985.101489851028;8987.910120898805;9010.59452324647;8920.866187007168;9025.232855207283;9055.049219831955;9056.13966673165;9072.59173337198;8923.643054277822;8960.731178064603;8962.879640044994;8991.730248092503;9020.548972551345;43854;43970.92203545753;44074.33888491675;44202;44225;3790.4882840816413;3844.9231015379537;3862.4206369044587;3864.0339915021245;3869.129445874684;35675.464868027004;36177.638223617956;36248.45627315593;36358.454623180674;36368.45447318292;5299.947000529984;5343.946560534384;5346.946530534684;5371.704556249405;5392.56859451243;228250;229937;230385.9999999983;230794;231061.9999999983;50224.74887625612;51773.48226517686;55454.72272638691;55889.441105589234;56862;58983;59329.70335148297;59406.40593594095;59465.70267148637;59545;17214.39749608758;17274.04992725387;17352.47942561725;17419.39032133869;17438.65122697539;14163.858361416254;14215.076020058663;14226.14643121416;14419.567412977627;14452;14085.507007254697;14100.224487653073;14217;14252.928735356258;14334.354954027094;5408;5409.891802163935;5497.175423686399;5511.779528818803;5530.5022547970875;1111.3109871879487;1113.5323164271026;1120.1878637987556;1128.7686024364984;1132.5752842683994;26518.734812652012;26972.865135674587;27005.594916076276;27026.054088106823;27222.591661125098;1238.5293588436336;1240.528599132342;1246.1152581666936;1260.8171815086762;1270.4600544768437;13862.514811981733;14130.576082717535;14263.286835658175;14263.358148883326;14435.133891966516;304370;311659;317133;318132;319788;65822.34177658257;67055.66472167705;67103.30931798798;67190.66404668044;67202.66398667975;1542.1826431991062;1562.429713154713;1562.9606311802524;1564.8669863061766;1588.9523314300588;31905.68094319027;32156.356872862878;32226.67773322237;32495.675043249266;32730.181745456553;44348.556514434444;44367.77816110899;44542.77728611466;44605.77697111494;44621.55378446304;262955;263948;265482;265990;266404;37869.24261514809;37973.240535189696;38321.23357532889;38387.232255355295;38429.80785096168;49800.75099624479;49812.501874982234;49997.500025000736;50252;50279.74860125676;36807;37115.25769484649;37300.44049339208;37402.625973739916;37519.249615007;36683;36786;36931.81534092312;36948.44577331396;37139;42606.1478770429;42815;42891.142177155656;43062;43493.34759978666;35625.82187089048;35635.287294254485;35955.640443596276;36653;36676.26647467089;26104.216873493824;26648.733512664625;26666.00164592695;26914.59628105541;27212.455750884474 08:18:49 INFO - PID 25892 | |2;jquery.html;600.1537831657364;605.724395400093;615.375393975115;629.9496040316775;650.2262307853655;23519.176828810996;23690.5261894762;24075.75924240755;24193.75806241937;24379.146729864457;26092.60861087085;27043.1887043389;27064.458710825773;27122;27177.86411067942;6601.5708978916455;6749.12261406019;6764;6772.390484856362;6784.525083244175;6544.312847151052;6865.244823069484;6866.896996545056;6867.656617169122;6876.793696189123;6794.184697836266;6834.043233947252;6843.965780171092;6846.452283817308;6848.246692863781;6788.253292137861;6833.043373927679;6833.760818371383;6834.726610935557;6834.794956151323;6375.45808606269;6388.137601423841;6405.48756099511;6406.199225096863;6422.389872962061;31148.065558033297;31459.685403145904;31694.524582131286;31895.88364407258;31921.52117718236;2271.681964524968;2282.6233671444356;2288.0962020002007;2292.86242825431;2293.7706229377095;21601.67597486039;21927.67108493374;21935;21967.670484942737;22096;2558.872056397173;2589.6115582662565;2645.2725500487327;2656.0570997295877;2657.0567448555676;145930;151292;153967;156544;158669.41330586662;16061.678766424606;16453.83546164547;17031.978081314912;17034.318627254772;17330.220140093727;26271.868640657056;26318.73681263163;26429.33926651849;26444.73555264461;26448.074317399183;11538.307701537768;11849.348285844362;11927.582534611247;11957;12145.271283723005;10928.508217130247;10962.397068161328;11038.13008617765;11056.613018544313;11182.66452006441;10089.949550252348;10232.386056836614;10233.232507561814;10269.332493387907;10543.630972916064;3050.481418158874;3056.6921973910003;3078.7690923180403;3099.318150006995;3144.371125774854;1076.4025965589174;1082.2965072702807;1082.680609220282;1095.397531357766;1109.589451902801;21476.463088422915;22182.667259991114;22220.888895555418;22406.439839004157;22734.886325568266;1140.361397617337;1146.9254498457574;1147.770445910821;1165.4231155577875;1165.854268216473;12252.44863981123;12454.564090256797;12553.874461255271;12662.303573303558;12709.93645031769;607066;615855;623989;632054;636226;135794.32102839422;136444.31777841246;137042;138864;140497;1180.698921774942;1216.9209001415056;1268.2707443220186;1268.8033354830015;1333.7199188170398;23425.88287058622;24075;24184.758152418955;24243.51512969766;24455.38861528476;62079.689601551705;63290.683546581975;63663.681681593145;64438.35561644511;66402.66798665976;79639.20360796318;81279.18720812953;81358.18641813743;81409.59295203486;81471.18528814636;16313.59216019609;16446.75329870077;16517.66964660676;16593.66812663716;16655.91672041632;25310;25701;25735.227943161735;25774.484510309314;25903.0933917312;20914.16343346249;20954.580908381442;20990.895045524674;21014.159433623096;21159.153633854472;18167.636647266718;18545.814541854408;18620.534486637942;18655.533611659816;18699.906500467412;21127.788722112582;21338.573228535653;21379.78620213778;21398;21513;16072.276747546623;16211;16216.594585135466;16252.349906003627;16322.183890805174;20163.39509814708;20419.8979005104;20439;20614.072366743232;20702.896485517475 08:18:49 INFO - PID 25892 | |3;mootools.html;1440.4526280013592;1483.0730793254213;1525.4965861265769;1536.9923150384238;1539.0457916092018;18122.27510899564;18714;18738.4378468646;18751.718724219147;18760.155792989313;18337.44987650369;18368.540786480313;18377;18454.815451845476;18480.722789158175;2924.283550530123;2990.6411230652243;2990.7308342249194;2995.5806187133817;3004.8347340896353;2829.5472724364004;2979.9404011919855;3033.2568520712457;3034.6358436987593;3035.81785092894;3034.620672415948;3074.077776667002;3075.046735511987;3075.046735511987;3075.9077227683206;2978.2405486600887;2979.597754303163;3011.6687164411787;3027.56100365448;3028.0764366868098;2886.7690584753377;2909.461749576335;2996.4456575533377;3047.3295874907485;3047.7866549341556;17098.31606735729;17403.912980435143;17439.73840392395;17547.64904701899;17585.912070439696;8270.421070525006;8493.702720404755;8559.443636163629;8566.571671416405;8611.61247743853;5049.64652474327;5220.705239161757;5388.595855310868;5409.7295135243085;5421.674699518042;1967.252444071258;2014.6575082235909;2041.3263623004373;2078.5011597216712;2083.802038806311;32673.346533069205;32777.18057048569;32881.50677739836;32887.34225315504;32974.50538241928;7134.500584959107;7207.495475316678;7213.422926165894;7345.77962661121;7389.408847292311;20526.38420847377;20556.177752890017;20583.279585214445;20584.073716682786;20596.691049634268;8333.250007499233;8526.488410695378;8542.957285213533;8571;8615.009273933578;7561.886571701429;7702.922970770221;7724.8455030900195;7739.922600774033;7856.528608283521;5630.943690563124;5707.914381284284;5760.164776107525;5804.390538993429;5845.970770146122;1529.992350038265;1562.4453319071565;1618.8381161883717;1664.6837100950781;1700.8129105798353;1018.7351288665001;1025.4206373399154;1030.7680771826278;1034.1726618705006;1045.1429827541494;9850.852237216448;9932.602695892083;9932.950335248277;9972.650957216463;10128.03783640553;1091.624553063146;1094.698957786615;1094.7810437912449;1097.742030622803;1126.808442564766;5669.43305669438;6129.233845769279;6165.167702360213;6327.683615819191;6470.126532917996;27181.592276115873;27712.168634940983;27780.58329125065;27822.44355112927;27887.581686274723;25991.74008259893;27480.450390992068;27597.724022759514;27599.17202483929;27677.446451070868;12118.81821772674;12986.220826750425;13180.736385272241;13184.0111991601;13237.205767653972;10030.147437467605;10089.394636321844;10125.240606954361;10288;10344.689659310232;21078.57842843165;22831;22997.54004919859;23184.18855340055;23387.415314617272;23425.648615270442;23440.76559234454;24025.639615405435;24248.87875560611;24315.75684243135;12860.228386296478;12903.354832258537;12959.546415875777;12996.350182491027;13189.274589897648;16507.9174604131;16557.83442165563;16644;16694.165291735608;16709.830311878053;13317.733645327233;13430.865691342962;13441.193528388329;13550.119242249222;13695.315234238447;12887;12986.415611297325;13046.217226966412;13323;13390.196588204739;11289.604863829727;11635.41822908868;11665;11798.646040618794;11845.289282643069;8780.429272097294;8817.559122044;8986.460812351279;9014.41406308614;9074.591643375932;8648.264897483785;8729.734188542752;8799.648014079365;8808.383413161017;8894.42186257891 08:18:49 INFO - PID 25892 | |4;prototype.html;554.556354916067;559.6054781379127;577.1717585265144;582.6358525921299;591.5977135547826;6268.561200715952;6354.555181137316;6369;6395.840103997402;6426.650403415282;6230.5950113242725;6238.968805155968;6245.968770156154;6250.687465626712;6309.337519560438;4913.385826771653;5117.7185254810975;5131.461196574362;5199.428062913076;5202.115640341141;5035.697858128506;5047.107334749469;5050.7222102784335;5069.2142717878605;5098.847034588968;5005.524475174852;5053.9241911371355;5069.417017043051;5074.4925507449325;5085.821996230133;4969.950300497021;5031.52200540948;5036.269740887587;5048.368953880765;5097.592192624581;4614.323692258516;4621.052684199731;4648.674592778507;4654.743989080599;4677.111348843743;6063.969680151571;6194.287656919467;6218.253809542839;6279.529035322324;6350.555461117724;5795.3045634523705;5928.940710592925;5951.345352011275;5974.551908606872;6006.399360064002;6679.465642748569;6711.630860302681;6712.851887396036;6713.899291510631;6738.338356349263;5043.167877300278;5091.1090559152;5093.465186155438;5123.205903085028;5137.61467889906;6729.528932974694;6785.185777706657;6874.759383421606;6883.3116688330765;6929.272426395206;5222.477752224747;5246.160614301693;5252.527272545489;5268.473152684701;5306;5318.154787188835;5335.519803217651;5341.679499230058;5355.866103347447;5418.701971391612;5856.950067476349;5876.265466816648;5895.322037965603;5903.406080358279;5942.435468630473;6705.966470167618;6751.5611485254285;6759.324067593299;6770.661466926733;6788.558743681645;1845.5478407789908;1849.824266694662;1853.6478069166815;1853.9536511587319;1856.8885866848032;1271.9809202861964;1276.9680757980939;1310.8033794930645;1312.9803052954214;1326.3898606641053;6358.491320694333;6372;6381.202349706286;6390.392912673288;6474;6558.114654521674;6683.398494135551;6760.18877734675;6768.784827207037;6852.794416167523;6308.779192728232;6384.297727250092;6442.9355706443275;6452.322506136882;6457.677116144174;3503;3517.736169787276;3570.0182449826507;3592.550931133608;3611.1513794258326;7090.787276381717;7093.964530177419;7117.6085315308155;7129.322714342129;7227.963860180771;6850.691718872663;6899.412720229914;6901.206361268519;6976.720931162697;7026.683799229047;6908.620025898624;6978.685959131852;7036.8630899444715;7048.577085374894;7130.3939165170505;6499.415052645285;6629.502787291069;6865.828354291183;6870.416014638811;6874.9375187442565;6800.591964482147;6806.366472046772;6832.385085342343;6835;6872.828179295558;7184.425245980414;7235.3488186063505;7236.20401755817;7241.5293005954445;7252.746153884589;5144.511271429208;5241.68549887008;5247.737613119405;5293.814716484904;5293.855988324734;6642.4021838034805;6857.348551887762;6863.313668633096;6941.271166527442;6960.686769095504;6263.404976527223;6587.374199451045;6596.439302659328;6611;6626.602403855784;6526.412622863965;6563.474922006132;6597;6608;6649.340263894481;6546.149000629887;6555.672216389257;6623.602583844985;6644.60132392058;6685.064091027163;6585.440237579668;6600.910849709936;6656.472069803012;6686.297938716365;6742.831429214113;6448.355164483514;6529.216494020748;6531.314212007861;6567.868642627216;6568.540202185801 08:18:49 INFO - PID 25892 | |5;yui.html;988.5600907596123;1012.9949350253247;1027.8972102789717;1029.4389557691059;1041.5573381312943;18977.525561860944;19519.316823911166;19544.90227548862;19547.902260488678;19617.11722972466;17281.222344994472;17408.564785880328;17504.21231044603;18495.907520462413;18660;1071.6410002649122;1096.3750662122593;1096.7587130831205;1096.9122470202406;1096.950637221323;1060.5863713151878;1089.4607169451094;1097.253867370188;1097.6706987903638;1105.6351404036648;1179.204037274836;1182.6924999500106;1183.0240051957128;1183.6449065280424;1183.9112066594996;1159.9362035088068;1165.8600967883865;1172.0389280789757;1172.197045024157;1173.1084375874311;863.1109956744563;863.6890719341033;864.3992425264444;865.7446053414258;866.1598249697784;19686.80313196864;20379.694304585442;20452.693209601868;20509.589808203902;20585.58828823415;23683.644745328835;23969.880150599136;24162.395940101636;24167.2749817504;24206.51586968251;17184.398546050827;17384.130793460277;17605;17635.206415711196;17739.201735921913;3783.5459744830523;3795.772253664789;3818.102745854722;3818.732688711791;3835.9808200959096;156772.21613891973;161142;162508.9999999988;162900;167034;17094;17633.7354939676;17676.91161544184;17684.646307074043;17693.55766105832;32895.342093158004;35393.64606353955;35465.82267088648;35556.28887422237;35595.64404355923;9627.229821614254;9634.325597208128;9642.373245739005;9719.951400242953;9749.512524373753;4677.64917631179;4746.07451546952;4766.809327626856;4767.118083154558;4782.378290822171;5636.098224284095;5659.320881494247;5681.77272909079;5743.8564035899435;5753.108268218432;1157.7915975124558;1162.3490845126587;1183.633073747124;1184.9170558060853;1186.2526608236756;769.0540635018958;777.5684495105157;786.6853258696567;787.220651554968;797.1948332184535;12449.688757781129;12855.550055748005;13322.933385333012;13760.380782864795;14146.575602731935;776.7786180938406;782.2060608482395;785.795693119793;798.0981490915344;800.87986801979;6119.949816811329;6212.844678882973;6291.087792270096;6296.087067375205;6408.583442076343;152850;153568;154731.22634386757;155406.22296888442;162476.18761906115;132631.33684331708;133294.33352833366;137620.31189843986;138541.3072934629;139649;111950.44024779987;114009;115945.42027289978;117526.41236793932;119966.99999999825;12465.5013799447;12657.810132848199;12679.80980285278;12941.352932353533;12986.285754283605;54641.63395915134;55514;55657.72171139118;55747.721261395054;57291;72089.27910720826;72364.27635723575;72714.18214544679;74170;75410;21070.894645526674;21360.252391166236;21539.138434462446;21621.675674864575;21681;21755.891220543795;22512.32463026112;22555.210567630053;22763.430914227276;22820.543589128458;22057.77942220557;22197.778022220216;22230.110795567995;22553.097876084772;22578.20976265823;20325.288614898407;20393.49016274605;20708.68936965977;20800.791992079885;20918.895405522875;21976.670349945085;22392.888035559718;22466.77533224712;22489.32532024042;22600;14222.786658200343;14410.063345882483;14515.129092254498;14542.781858272347;14668.70662586721;13886;13907.860921391062;13973.301334933416;14020.228887411291;14107.224102674041 08:18:49 INFO - PID 25892 | __end_tp_report 08:18:49 INFO - PID 25892 | __start_cc_report 08:18:49 INFO - PID 25892 | _x_x_mozilla_cycle_collect,257 08:18:49 INFO - PID 25892 | __end_cc_report 08:18:49 INFO - PID 25892 | __startTimestamp1505834329232__endTimestamp 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | ------- Summary: start ------- 08:18:49 INFO - PID 25892 | Number of tests: 6 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | [#0] dojo.html Cycles:165 Average:6436.37 Median:6685.73 stddev:743.87 (11.1%) stddev-sans-first:719.51 08:18:49 INFO - PID 25892 | Values: 3921.5 3930.5 3952.9 3970.1 3997.6 6294.5 6354.2 6423.5 6457.0 6484.8 6366.5 6403.6 6494.4 6494.7 6502.9 5683.7 5748.9 5794.6 5816.4 5856.4 5748.7 5780.8 5801.2 5863.1 5894.2 5811.7 5820.0 5834.9 5861.9 5864.4 5772.9 5781.5 5863.2 5902.7 5919.2 5641.7 5669.4 5740.3 5774.2 5802.0 6267.7 6288.4 6321.9 6328.1 6353.9 6859.6 6861.4 6943.0 6949.1 6961.0 6917.6 6927.0 6950.8 7011.3 7017.4 6432.7 6444.1 6451.6 6453.8 6483.6 7111.9 7124.8 7199.9 7213.1 7213.7 6869.1 6896.8 6967.0 6969.8 6974.1 6887.1 6940.6 6962.4 6979.6 7017.1 6922.6 6954.3 6970.8 7008.0 7014.2 6914.3 6920.9 6939.9 6959.3 7037.9 5094.7 5118.4 5134.2 5150.6 5186.4 4721.9 4745.5 4775.5 4781.2 4807.2 6591.7 6603.8 6625.8 6675.2 6684.9 6877.0 6952.5 6980.4 6980.7 7066.4 6536.4 6590.0 6601.8 6603.6 6623.0 5831.9 5838.1 5854.3 5854.8 5874.4 7265.3 7287.9 7290.5 7292.4 7395.4 6900.4 6964.7 6989.2 6989.2 6998.5 7125.7 7219.7 7242.0 7244.5 7245.0 6796.9 6857.4 6885.9 6895.0 6900.7 6935.7 6952.8 6988.8 7010.4 7016.2 6704.5 6711.4 6780.8 6788.3 6796.5 6685.7 6706.7 6774.6 6784.9 6789.0 6553.9 6627.7 6663.6 6684.1 6712.0 6775.5 6789.2 6850.7 6895.0 6898.9 6596.8 6600.1 6683.4 6695.8 6710.3 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | [#1] ext.html Cycles:180 Average:46036.30 Median:38147.24 stddev:70838.09 (185.7%) stddev-sans-first:70956.05 08:18:49 INFO - PID 25892 | Values: 987.7 994.0 1011.7 1019.9 1023.3 45526.8 46647.8 46653.3 46742.5 46778.5 43977.6 44019.8 44065.0 44175.0 46600.3 8831.6 8931.9 9031.4 9070.5 9081.7 8961.3 8990.5 9046.9 9049.5 9073.5 8920.8 8983.5 8985.1 8987.9 9010.6 8920.9 9025.2 9055.0 9056.1 9072.6 8923.6 8960.7 8962.9 8991.7 9020.5 43854.0 43970.9 44074.3 44202.0 44225.0 3790.5 3844.9 3862.4 3864.0 3869.1 35675.5 36177.6 36248.5 36358.5 36368.5 5299.9 5343.9 5346.9 5371.7 5392.6 228250.0 229937.0 230386.0 230794.0 231062.0 50224.7 51773.5 55454.7 55889.4 56862.0 58983.0 59329.7 59406.4 59465.7 59545.0 17214.4 17274.0 17352.5 17419.4 17438.7 14163.9 14215.1 14226.1 14419.6 14452.0 14085.5 14100.2 14217.0 14252.9 14334.4 5408.0 5409.9 5497.2 5511.8 5530.5 1111.3 1113.5 1120.2 1128.8 1132.6 26518.7 26972.9 27005.6 27026.1 27222.6 1238.5 1240.5 1246.1 1260.8 1270.5 13862.5 14130.6 14263.3 14263.4 14435.1 304370.0 311659.0 317133.0 318132.0 319788.0 65822.3 67055.7 67103.3 67190.7 67202.7 1542.2 1562.4 1563.0 1564.9 1589.0 31905.7 32156.4 32226.7 32495.7 32730.2 44348.6 44367.8 44542.8 44605.8 44621.6 262955.0 263948.0 265482.0 265990.0 266404.0 37869.2 37973.2 38321.2 38387.2 38429.8 49800.8 49812.5 49997.5 50252.0 50279.7 36807.0 37115.3 37300.4 37402.6 37519.2 36683.0 36786.0 36931.8 36948.4 37139.0 42606.1 42815.0 42891.1 43062.0 43493.3 35625.8 35635.3 35955.6 36653.0 36676.3 26104.2 26648.7 26666.0 26914.6 27212.5 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | [#2] jquery.html Cycles:180 Average:41224.81 Median:12508.75 stddev:104201.87 (833.0%) stddev-sans-first:104449.54 08:18:49 INFO - PID 25892 | Values: 600.2 605.7 615.4 629.9 650.2 23519.2 23690.5 24075.8 24193.8 24379.1 26092.6 27043.2 27064.5 27122.0 27177.9 6601.6 6749.1 6764.0 6772.4 6784.5 6544.3 6865.2 6866.9 6867.7 6876.8 6794.2 6834.0 6844.0 6846.5 6848.2 6788.3 6833.0 6833.8 6834.7 6834.8 6375.5 6388.1 6405.5 6406.2 6422.4 31148.1 31459.7 31694.5 31895.9 31921.5 2271.7 2282.6 2288.1 2292.9 2293.8 21601.7 21927.7 21935.0 21967.7 22096.0 2558.9 2589.6 2645.3 2656.1 2657.1 145930.0 151292.0 153967.0 156544.0 158669.4 16061.7 16453.8 17032.0 17034.3 17330.2 26271.9 26318.7 26429.3 26444.7 26448.1 11538.3 11849.3 11927.6 11957.0 12145.3 10928.5 10962.4 11038.1 11056.6 11182.7 10089.9 10232.4 10233.2 10269.3 10543.6 3050.5 3056.7 3078.8 3099.3 3144.4 1076.4 1082.3 1082.7 1095.4 1109.6 21476.5 22182.7 22220.9 22406.4 22734.9 1140.4 1146.9 1147.8 1165.4 1165.9 12252.4 12454.6 12553.9 12662.3 12709.9 607066.0 615855.0 623989.0 632054.0 636226.0 135794.3 136444.3 137042.0 138864.0 140497.0 1180.7 1216.9 1268.3 1268.8 1333.7 23425.9 24075.0 24184.8 24243.5 24455.4 62079.7 63290.7 63663.7 64438.4 66402.7 79639.2 81279.2 81358.2 81409.6 81471.2 16313.6 16446.8 16517.7 16593.7 16655.9 25310.0 25701.0 25735.2 25774.5 25903.1 20914.2 20954.6 20990.9 21014.2 21159.2 18167.6 18545.8 18620.5 18655.5 18699.9 21127.8 21338.6 21379.8 21398.0 21513.0 16072.3 16211.0 16216.6 16252.3 16322.2 20163.4 20419.9 20439.0 20614.1 20702.9 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | [#3] mootools.html Cycles:180 Average:11098.06 Median:25153.75 stddev:8402.81 (33.4%) stddev-sans-first:8395.05 08:18:49 INFO - PID 25892 | Values: 1440.5 1483.1 1525.5 1537.0 1539.0 18122.3 18714.0 18738.4 18751.7 18760.2 18337.4 18368.5 18377.0 18454.8 18480.7 2924.3 2990.6 2990.7 2995.6 3004.8 2829.5 2979.9 3033.3 3034.6 3035.8 3034.6 3074.1 3075.0 3075.0 3075.9 2978.2 2979.6 3011.7 3027.6 3028.1 2886.8 2909.5 2996.4 3047.3 3047.8 17098.3 17403.9 17439.7 17547.6 17585.9 8270.4 8493.7 8559.4 8566.6 8611.6 5049.6 5220.7 5388.6 5409.7 5421.7 1967.3 2014.7 2041.3 2078.5 2083.8 32673.3 32777.2 32881.5 32887.3 32974.5 7134.5 7207.5 7213.4 7345.8 7389.4 20526.4 20556.2 20583.3 20584.1 20596.7 8333.3 8526.5 8543.0 8571.0 8615.0 7561.9 7702.9 7724.8 7739.9 7856.5 5630.9 5707.9 5760.2 5804.4 5846.0 1530.0 1562.4 1618.8 1664.7 1700.8 1018.7 1025.4 1030.8 1034.2 1045.1 9850.9 9932.6 9933.0 9972.7 10128.0 1091.6 1094.7 1094.8 1097.7 1126.8 5669.4 6129.2 6165.2 6327.7 6470.1 27181.6 27712.2 27780.6 27822.4 27887.6 25991.7 27480.5 27597.7 27599.2 27677.4 12118.8 12986.2 13180.7 13184.0 13237.2 10030.1 10089.4 10125.2 10288.0 10344.7 21078.6 22831.0 22997.5 23184.2 23387.4 23425.6 23440.8 24025.6 24248.9 24315.8 12860.2 12903.4 12959.5 12996.4 13189.3 16507.9 16557.8 16644.0 16694.2 16709.8 13317.7 13430.9 13441.2 13550.1 13695.3 12887.0 12986.4 13046.2 13323.0 13390.2 11289.6 11635.4 11665.0 11798.6 11845.3 8780.4 8817.6 8986.5 9014.4 9074.6 8648.3 8729.7 8799.6 8808.4 8894.4 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | [#4] prototype.html Cycles:180 Average:5703.21 Median:6370.50 stddev:1591.21 (25.0%) stddev-sans-first:1548.03 08:18:49 INFO - PID 25892 | Values: 554.6 559.6 577.2 582.6 591.6 6268.6 6354.6 6369.0 6395.8 6426.7 6230.6 6239.0 6246.0 6250.7 6309.3 4913.4 5117.7 5131.5 5199.4 5202.1 5035.7 5047.1 5050.7 5069.2 5098.8 5005.5 5053.9 5069.4 5074.5 5085.8 4970.0 5031.5 5036.3 5048.4 5097.6 4614.3 4621.1 4648.7 4654.7 4677.1 6064.0 6194.3 6218.3 6279.5 6350.6 5795.3 5928.9 5951.3 5974.6 6006.4 6679.5 6711.6 6712.9 6713.9 6738.3 5043.2 5091.1 5093.5 5123.2 5137.6 6729.5 6785.2 6874.8 6883.3 6929.3 5222.5 5246.2 5252.5 5268.5 5306.0 5318.2 5335.5 5341.7 5355.9 5418.7 5857.0 5876.3 5895.3 5903.4 5942.4 6706.0 6751.6 6759.3 6770.7 6788.6 1845.5 1849.8 1853.6 1854.0 1856.9 1272.0 1277.0 1310.8 1313.0 1326.4 6358.5 6372.0 6381.2 6390.4 6474.0 6558.1 6683.4 6760.2 6768.8 6852.8 6308.8 6384.3 6442.9 6452.3 6457.7 3503.0 3517.7 3570.0 3592.6 3611.2 7090.8 7094.0 7117.6 7129.3 7228.0 6850.7 6899.4 6901.2 6976.7 7026.7 6908.6 6978.7 7036.9 7048.6 7130.4 6499.4 6629.5 6865.8 6870.4 6874.9 6800.6 6806.4 6832.4 6835.0 6872.8 7184.4 7235.3 7236.2 7241.5 7252.7 5144.5 5241.7 5247.7 5293.8 5293.9 6642.4 6857.3 6863.3 6941.3 6960.7 6263.4 6587.4 6596.4 6611.0 6626.6 6526.4 6563.5 6597.0 6608.0 6649.3 6546.1 6555.7 6623.6 6644.6 6685.1 6585.4 6600.9 6656.5 6686.3 6742.8 6448.4 6529.2 6531.3 6567.9 6568.5 08:18:49 INFO - PID 25892 | 08:18:49 INFO - PID 25892 | [#5] yui.html Cycles:180 Average:29280.03 Median:20352.49 stddev:43294.97 (212.7%) stddev-sans-first:43364.31 08:18:49 INFO - PID 25892 | Values: 988.6 1013.0 1027.9 1029.4 1041.6 18977.5 19519.3 19544.9 19547.9 19617.1 17281.2 17408.6 17504.2 18495.9 18660.0 1071.6 1096.4 1096.8 1096.9 1097.0 1060.6 1089.5 1097.3 1097.7 1105.6 1179.2 1182.7 1183.0 1183.6 1183.9 1159.9 1165.9 1172.0 1172.2 1173.1 863.1 863.7 864.4 865.7 866.2 19686.8 20379.7 20452.7 20509.6 20585.6 23683.6 23969.9 24162.4 24167.3 24206.5 17184.4 17384.1 17605.0 17635.2 17739.2 3783.5 3795.8 3818.1 3818.7 3836.0 156772.2 161142.0 162509.0 162900.0 167034.0 17094.0 17633.7 17676.9 17684.6 17693.6 32895.3 35393.6 35465.8 35556.3 35595.6 9627.2 9634.3 9642.4 9720.0 9749.5 4677.6 4746.1 4766.8 4767.1 4782.4 5636.1 5659.3 5681.8 5743.9 5753.1 1157.8 1162.3 1183.6 1184.9 1186.3 769.1 777.6 786.7 787.2 797.2 12449.7 12855.6 13322.9 13760.4 14146.6 776.8 782.2 785.8 798.1 800.9 6119.9 6212.8 6291.1 6296.1 6408.6 152850.0 153568.0 154731.2 155406.2 162476.2 132631.3 133294.3 137620.3 138541.3 139649.0 111950.4 114009.0 115945.4 117526.4 119967.0 12465.5 12657.8 12679.8 12941.4 12986.3 54641.6 55514.0 55657.7 55747.7 57291.0 72089.3 72364.3 72714.2 74170.0 75410.0 21070.9 21360.3 21539.1 21621.7 21681.0 21755.9 22512.3 22555.2 22763.4 22820.5 22057.8 22197.8 22230.1 22553.1 22578.2 20325.3 20393.5 20708.7 20800.8 20918.9 21976.7 22392.9 22466.8 22489.3 22600.0 14222.8 14410.1 14515.1 14542.8 14668.7 13886.0 13907.9 13973.3 14020.2 14107.2 08:18:49 INFO - PID 25892 | -------- Summary: end -------- 08:18:49 INFO - PID 25892 | 08:18:49 INFO - TEST-INFO | 25892: exit 0 08:18:49 INFO - TEST-OK | dromaeo_css | took 1107137ms 08:18:49 INFO - TEST-START | kraken 08:18:49 INFO - Initialising browser for kraken test... 08:18:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43171/getInfo.html -profile /tmp/tmpHLXX4c/profile 08:18:49 INFO - TEST-INFO | started process 26255 (/builds/slave/test/build/application/firefox/firefox http://localhost:43171/getInfo.html) 08:18:54 INFO - TEST-INFO | 26255: exit 0 08:18:54 INFO - Browser initialized. 08:18:54 INFO - Running cycle 1/1 for kraken test... 08:18:54 INFO - Using env: {'DISPLAY': ':0', 08:18:54 INFO - 'HOME': '/home/cltbld', 08:18:54 INFO - 'JSGC_DISABLE_POISONING': '1', 08:18:54 INFO - 'LANG': 'en_US.UTF-8', 08:18:54 INFO - 'LANGUAGE': 'en_US:en', 08:18:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:18:54 INFO - 'LOGNAME': 'cltbld', 08:18:54 INFO - 'MAIL': '/var/mail/cltbld', 08:18:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:54 INFO - 'MOZ_CRASHREPORTER': '1', 08:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:18:54 INFO - 'MOZ_NO_REMOTE': '1', 08:18:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:54 INFO - 'NO_EM_RESTART': '1', 08:18:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:54 INFO - 'PWD': '/builds/slave/test', 08:18:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:54 INFO - 'RUST_BACKTRACE': 'full', 08:18:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:18:54 INFO - 'SHELL': '/bin/bash', 08:18:54 INFO - 'SHLVL': '1', 08:18:54 INFO - 'TERM': 'linux', 08:18:54 INFO - 'TMOUT': '86400', 08:18:54 INFO - 'USER': 'cltbld', 08:18:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051', 08:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:54 INFO - '_': '/tools/buildbot/bin/python'} 08:18:54 INFO - TEST-INFO | started process 26438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHLXX4c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:06 INFO - PID 26438 | RSS: Main: 146550784 08:19:06 INFO - PID 26438 | 08:19:08 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43171/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:09 INFO - PID 26438 | RSS: Main: 151564288 08:19:09 INFO - PID 26438 | 08:19:11 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43171/tests/kraken/driver.html?testName=audio-dft) 08:19:12 INFO - PID 26438 | RSS: Main: 152031232 08:19:12 INFO - PID 26438 | 08:19:15 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43171/tests/kraken/driver.html?testName=audio-fft) 08:19:16 INFO - PID 26438 | RSS: Main: 153837568 08:19:16 INFO - PID 26438 | 08:19:18 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43171/tests/kraken/driver.html?testName=audio-oscillator) 08:19:18 INFO - PID 26438 | RSS: Main: 153870336 08:19:18 INFO - PID 26438 | 08:19:20 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:19:21 INFO - PID 26438 | RSS: Main: 153808896 08:19:21 INFO - PID 26438 | 08:19:24 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43171/tests/kraken/driver.html?testName=imaging-darkroom) 08:19:24 INFO - PID 26438 | RSS: Main: 153108480 08:19:24 INFO - PID 26438 | 08:19:28 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43171/tests/kraken/driver.html?testName=imaging-desaturate) 08:19:29 INFO - PID 26438 | RSS: Main: 155664384 08:19:29 INFO - PID 26438 | 08:19:31 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43171/tests/kraken/driver.html?testName=json-parse-financial) 08:19:32 INFO - PID 26438 | RSS: Main: 156319744 08:19:32 INFO - PID 26438 | 08:19:33 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:34 INFO - PID 26438 | RSS: Main: 156000256 08:19:34 INFO - PID 26438 | 08:19:36 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:36 INFO - PID 26438 | RSS: Main: 155533312 08:19:36 INFO - PID 26438 | 08:19:38 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:39 INFO - PID 26438 | RSS: Main: 152883200 08:19:39 INFO - PID 26438 | 08:19:41 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:42 INFO - PID 26438 | RSS: Main: 152973312 08:19:42 INFO - PID 26438 | 08:19:44 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:45 INFO - PID 26438 | RSS: Main: 153239552 08:19:45 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | Cycle 1(1): loaded http://localhost:43171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43171/tests/kraken/driver.html?testName=ai-astar) 08:19:47 INFO - PID 26438 | RSS: Main: 155226112 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | __start_tp_report 08:19:47 INFO - PID 26438 | _x_x_mozilla_page_load 08:19:47 INFO - PID 26438 | _x_x_mozilla_page_load_details 08:19:47 INFO - PID 26438 | |i|pagename|runs| 08:19:47 INFO - PID 26438 | |0;ai-astar;105;104;104;104;105;104;108;104;105;106 08:19:47 INFO - PID 26438 | |1;audio-beat-detection;120;111;114;110;110;110;107;141;112;119 08:19:47 INFO - PID 26438 | |2;audio-dft;162;161;163;163;163;161;162;161;161;162 08:19:47 INFO - PID 26438 | |3;audio-fft;73;72;72;73;72;73;79;73;74;73 08:19:47 INFO - PID 26438 | |4;audio-oscillator;83;83;82;77;78;76;77;79;77;76 08:19:47 INFO - PID 26438 | |5;imaging-gaussian-blur;114;115;113;113;113;114;114;110;114;113 08:19:47 INFO - PID 26438 | |6;imaging-darkroom;148;149;148;148;147;150;150;149;149;148 08:19:47 INFO - PID 26438 | |7;imaging-desaturate;93;94;95;93;99;93;94;94;94;95 08:19:47 INFO - PID 26438 | |8;json-parse-financial;44;43;43;44;47;44;45;43;44;43 08:19:47 INFO - PID 26438 | |9;json-stringify-tinderbox;36;36;35;36;35;36;39;36;36;35 08:19:47 INFO - PID 26438 | |10;stanford-crypto-aes;74;74;70;71;70;69;69;69;69;72 08:19:47 INFO - PID 26438 | |11;stanford-crypto-ccm;99;102;101;101;110;99;107;103;106;102 08:19:47 INFO - PID 26438 | |12;stanford-crypto-pbkdf2;148;149;146;158;146;149;150;147;146;149 08:19:47 INFO - PID 26438 | |13;stanford-crypto-sha256-iterative;58;56;57;62;60;58;58;58;58;62 08:19:47 INFO - PID 26438 | __end_tp_report 08:19:47 INFO - PID 26438 | __start_cc_report 08:19:47 INFO - PID 26438 | _x_x_mozilla_cycle_collect,702 08:19:47 INFO - PID 26438 | __end_cc_report 08:19:47 INFO - PID 26438 | __startTimestamp1505834387447__endTimestamp 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | ------- Summary: start ------- 08:19:47 INFO - PID 26438 | Number of tests: 14 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#0] ai-astar Cycles:10 Average:104.90 Median:105.00 stddev:1.29 (1.2%) stddev-sans-first:1.36 08:19:47 INFO - PID 26438 | Values: 105.0 104.0 104.0 104.0 105.0 104.0 108.0 104.0 105.0 106.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:113.00 stddev:9.89 (8.8%) stddev-sans-first:10.35 08:19:47 INFO - PID 26438 | Values: 120.0 111.0 114.0 110.0 110.0 110.0 107.0 141.0 112.0 119.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 08:19:47 INFO - PID 26438 | Values: 162.0 161.0 163.0 163.0 163.0 161.0 162.0 161.0 161.0 162.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:2.07 (2.8%) stddev-sans-first:2.19 08:19:47 INFO - PID 26438 | Values: 73.0 72.0 72.0 73.0 72.0 73.0 79.0 73.0 74.0 73.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:78.50 stddev:2.82 (3.6%) stddev-sans-first:2.55 08:19:47 INFO - PID 26438 | Values: 83.0 83.0 82.0 77.0 78.0 76.0 77.0 79.0 77.0 76.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 08:19:47 INFO - PID 26438 | Values: 114.0 115.0 113.0 113.0 113.0 114.0 114.0 110.0 114.0 113.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 08:19:47 INFO - PID 26438 | Values: 148.0 149.0 148.0 148.0 147.0 150.0 150.0 149.0 149.0 148.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.78 (1.9%) stddev-sans-first:1.81 08:19:47 INFO - PID 26438 | Values: 93.0 94.0 95.0 93.0 99.0 93.0 94.0 94.0 94.0 95.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#8] json-parse-financial Cycles:10 Average:44.00 Median:44.00 stddev:1.25 (2.8%) stddev-sans-first:1.32 08:19:47 INFO - PID 26438 | Values: 44.0 43.0 43.0 44.0 47.0 44.0 45.0 43.0 44.0 43.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#9] json-stringify-tinderbox Cycles:10 Average:36.00 Median:36.00 stddev:1.15 (3.2%) stddev-sans-first:1.22 08:19:47 INFO - PID 26438 | Values: 36.0 36.0 35.0 36.0 35.0 36.0 39.0 36.0 36.0 35.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#10] stanford-crypto-aes Cycles:10 Average:70.70 Median:70.50 stddev:2.00 (2.8%) stddev-sans-first:1.73 08:19:47 INFO - PID 26438 | Values: 74.0 74.0 70.0 71.0 70.0 69.0 69.0 69.0 69.0 72.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#11] stanford-crypto-ccm Cycles:10 Average:103.00 Median:106.50 stddev:3.59 (3.4%) stddev-sans-first:3.50 08:19:47 INFO - PID 26438 | Values: 99.0 102.0 101.0 101.0 110.0 99.0 107.0 103.0 106.0 102.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:149.00 stddev:3.55 (2.4%) stddev-sans-first:3.76 08:19:47 INFO - PID 26438 | Values: 148.0 149.0 146.0 158.0 146.0 149.0 150.0 147.0 146.0 149.0 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.70 Median:58.00 stddev:2.00 (3.5%) stddev-sans-first:2.11 08:19:47 INFO - PID 26438 | Values: 58.0 56.0 57.0 62.0 60.0 58.0 58.0 58.0 58.0 62.0 08:19:47 INFO - PID 26438 | -------- Summary: end -------- 08:19:47 INFO - PID 26438 | 08:19:47 INFO - PID 26438 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:19:48 INFO - TEST-INFO | 26438: exit 0 08:19:48 INFO - TEST-OK | kraken | took 58291ms 08:19:48 INFO - SUITE-END | took 1165s 08:19:48 INFO - Completed test suite (00:19:25) 08:19:48 INFO - javascript benchmark 08:19:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9430.843034934825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3921.4509968604402, 3930.547986981498, 3952.8616498422552, 3970.0670342469534, 3997.6002399760027, 6294.496440284777, 6354.173957385539, 6423.486121110312, 6456.967715161418, 6484.837879053026, 6366.522510811685, 6403.647799371044, 6494.415502604765, 6494.74021039159, 6502.902456463157, 5683.715814209294, 5748.885022299552, 5794.565407594426, 5816.447437493432, 5856.414358564152, 5748.683822389767, 5780.7687692492245, 5801.24583804107, 5863.149843272723, 5894.17481552583, 5811.651300921937, 5820.039693450575, 5834.941650583503, 5861.8827623447505, 5864.384239654839, 5772.884542309131, 5781.479666830005, 5863.179154918314, 5902.734376953026, 5919.230500035011, 5641.71791410432, 5669.433056694339, 5740.282464691913, 5774.220480235199, 5802.0, 6267.655278959655, 6288.402601752826, 6321.87356252877, 6328.082428047954, 6353.904691429586, 6859.588424694534, 6861.416779573742, 6942.958556216558, 6949.096617439751, 6961.025456436103, 6917.619530925797, 6927.0, 6950.783612867728, 7011.3339232772805, 7017.403520700746, 6432.678366081724, 6444.097826304321, 6451.645159516224, 6453.774117905851, 6483.643399613019, 7111.893321600181, 7124.821879453055, 7199.856002879913, 7213.134423869169, 7213.711451541984, 6869.107016087876, 6896.827579310457, 6967.024616553686, 6969.756058537927, 6974.128233970754, 6887.104676392037, 6940.583564986016, 6962.373386395248, 6979.616121113388, 7017.087778588751, 6922.550034247758, 6954.3045695431065, 6970.825729356807, 7008.0188773571745, 7014.19336776267, 6914.274001229899, 6920.861582768316, 6939.930600693929, 6959.338862808025, 7037.859242815115, 5094.694318340911, 5118.411382690963, 5134.152864777345, 5150.639455238173, 5186.429492755794, 4721.929171062437, 4745.501722319176, 4775.450823155312, 4781.163296423112, 4807.18277892759, 6591.670416479157, 6603.834904127435, 6625.768098116543, 6675.198976122896, 6684.933150668431, 6876.965615171892, 6952.513324067267, 6980.406665433394, 6980.685869135901, 7066.434685225169, 6536.379043990813, 6590.0, 6601.76893808724, 6603.636799976048, 6622.966885165543, 5831.912521312183, 5838.1242813577455, 5854.326752423441, 5854.824355269348, 5874.441928016831, 7265.309795569412, 7287.854242915112, 7290.526115802456, 7292.3801476874, 7395.445341599401, 6900.447964162755, 6964.686589103401, 6989.231184569591, 6989.231184569795, 6998.545094568837, 7125.67934442941, 7219.711211551479, 7242.0, 7244.492885497964, 7245.0, 6796.864062718817, 6857.382835544825, 6885.862282754417, 6894.96575513677, 6900.689468973807, 6935.7225710971, 6952.756653517103, 6988.846840271502, 7010.4041156500225, 7016.158061032709, 6704.530682852349, 6711.429528490133, 6780.796576102724, 6788.287229840796, 6796.456283497209, 6685.732570697118, 6706.66466676674, 6774.559653622498, 6784.86430271382, 6789.049533065276, 6553.901691474536, 6627.734890604322, 6663.566868153554, 6684.0642310075655, 6712.026756120433, 6775.525713200029, 6789.15135608049, 6850.6574671267235, 6894.965525172543, 6898.896516552155, 6596.80209593713, 6600.141981542369, 6683.398494135551, 6695.799126026227, 6710.328967103251], "value": 6386.953473894725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [987.7481242283217, 993.9850902236473, 1011.7217765114592, 1019.8929112443195, 1023.278588595041, 45526.772366138204, 46647.76676116623, 46653.300200496975, 46742.532574674246, 46778.53221467784, 43977.56022439775, 44019.779901100526, 44065.0, 44175.0, 46600.30099548509, 8831.602577883994, 8931.866022009675, 9031.367804253705, 9070.54647267634, 9081.727548173532, 8961.327900407463, 8990.505522196276, 9046.86429703555, 9049.457032578033, 9073.500957447337, 8920.776980575472, 8983.505907175102, 8985.101489851028, 8987.910120898805, 9010.59452324647, 8920.866187007168, 9025.232855207283, 9055.049219831955, 9056.13966673165, 9072.59173337198, 8923.643054277822, 8960.731178064603, 8962.879640044994, 8991.730248092503, 9020.548972551345, 43854.0, 43970.92203545753, 44074.33888491675, 44202.0, 44225.0, 3790.4882840816413, 3844.9231015379537, 3862.4206369044587, 3864.0339915021245, 3869.129445874684, 35675.464868027004, 36177.638223617956, 36248.45627315593, 36358.454623180674, 36368.45447318292, 5299.947000529984, 5343.946560534384, 5346.946530534684, 5371.704556249405, 5392.56859451243, 228250.0, 229937.0, 230385.9999999983, 230794.0, 231061.9999999983, 50224.74887625612, 51773.48226517686, 55454.72272638691, 55889.441105589234, 56862.0, 58983.0, 59329.70335148297, 59406.40593594095, 59465.70267148637, 59545.0, 17214.39749608758, 17274.04992725387, 17352.47942561725, 17419.39032133869, 17438.65122697539, 14163.858361416254, 14215.076020058663, 14226.14643121416, 14419.567412977627, 14452.0, 14085.507007254697, 14100.224487653073, 14217.0, 14252.928735356258, 14334.354954027094, 5408.0, 5409.891802163935, 5497.175423686399, 5511.779528818803, 5530.5022547970875, 1111.3109871879487, 1113.5323164271026, 1120.1878637987556, 1128.7686024364984, 1132.5752842683994, 26518.734812652012, 26972.865135674587, 27005.594916076276, 27026.054088106823, 27222.591661125098, 1238.5293588436336, 1240.528599132342, 1246.1152581666936, 1260.8171815086762, 1270.4600544768437, 13862.514811981733, 14130.576082717535, 14263.286835658175, 14263.358148883326, 14435.133891966516, 304370.0, 311659.0, 317133.0, 318132.0, 319788.0, 65822.34177658257, 67055.66472167705, 67103.30931798798, 67190.66404668044, 67202.66398667975, 1542.1826431991062, 1562.429713154713, 1562.9606311802524, 1564.8669863061766, 1588.9523314300588, 31905.68094319027, 32156.356872862878, 32226.67773322237, 32495.675043249266, 32730.181745456553, 44348.556514434444, 44367.77816110899, 44542.77728611466, 44605.77697111494, 44621.55378446304, 262955.0, 263948.0, 265482.0, 265990.0, 266404.0, 37869.24261514809, 37973.240535189696, 38321.23357532889, 38387.232255355295, 38429.80785096168, 49800.75099624479, 49812.501874982234, 49997.500025000736, 50252.0, 50279.74860125676, 36807.0, 37115.25769484649, 37300.44049339208, 37402.625973739916, 37519.249615007, 36683.0, 36786.0, 36931.81534092312, 36948.44577331396, 37139.0, 42606.1478770429, 42815.0, 42891.142177155656, 43062.0, 43493.34759978666, 35625.82187089048, 35635.287294254485, 35955.640443596276, 36653.0, 36676.26647467089, 26104.216873493824, 26648.733512664625, 26666.00164592695, 26914.59628105541, 27212.455750884474], "value": 19728.930067767586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1537831657364, 605.724395400093, 615.375393975115, 629.9496040316775, 650.2262307853655, 23519.176828810996, 23690.5261894762, 24075.75924240755, 24193.75806241937, 24379.146729864457, 26092.60861087085, 27043.1887043389, 27064.458710825773, 27122.0, 27177.86411067942, 6601.5708978916455, 6749.12261406019, 6764.0, 6772.390484856362, 6784.525083244175, 6544.312847151052, 6865.244823069484, 6866.896996545056, 6867.656617169122, 6876.793696189123, 6794.184697836266, 6834.043233947252, 6843.965780171092, 6846.452283817308, 6848.246692863781, 6788.253292137861, 6833.043373927679, 6833.760818371383, 6834.726610935557, 6834.794956151323, 6375.45808606269, 6388.137601423841, 6405.48756099511, 6406.199225096863, 6422.389872962061, 31148.065558033297, 31459.685403145904, 31694.524582131286, 31895.88364407258, 31921.52117718236, 2271.681964524968, 2282.6233671444356, 2288.0962020002007, 2292.86242825431, 2293.7706229377095, 21601.67597486039, 21927.67108493374, 21935.0, 21967.670484942737, 22096.0, 2558.872056397173, 2589.6115582662565, 2645.2725500487327, 2656.0570997295877, 2657.0567448555676, 145930.0, 151292.0, 153967.0, 156544.0, 158669.41330586662, 16061.678766424606, 16453.83546164547, 17031.978081314912, 17034.318627254772, 17330.220140093727, 26271.868640657056, 26318.73681263163, 26429.33926651849, 26444.73555264461, 26448.074317399183, 11538.307701537768, 11849.348285844362, 11927.582534611247, 11957.0, 12145.271283723005, 10928.508217130247, 10962.397068161328, 11038.13008617765, 11056.613018544313, 11182.66452006441, 10089.949550252348, 10232.386056836614, 10233.232507561814, 10269.332493387907, 10543.630972916064, 3050.481418158874, 3056.6921973910003, 3078.7690923180403, 3099.318150006995, 3144.371125774854, 1076.4025965589174, 1082.2965072702807, 1082.680609220282, 1095.397531357766, 1109.589451902801, 21476.463088422915, 22182.667259991114, 22220.888895555418, 22406.439839004157, 22734.886325568266, 1140.361397617337, 1146.9254498457574, 1147.770445910821, 1165.4231155577875, 1165.854268216473, 12252.44863981123, 12454.564090256797, 12553.874461255271, 12662.303573303558, 12709.93645031769, 607066.0, 615855.0, 623989.0, 632054.0, 636226.0, 135794.32102839422, 136444.31777841246, 137042.0, 138864.0, 140497.0, 1180.698921774942, 1216.9209001415056, 1268.2707443220186, 1268.8033354830015, 1333.7199188170398, 23425.88287058622, 24075.0, 24184.758152418955, 24243.51512969766, 24455.38861528476, 62079.689601551705, 63290.683546581975, 63663.681681593145, 64438.35561644511, 66402.66798665976, 79639.20360796318, 81279.18720812953, 81358.18641813743, 81409.59295203486, 81471.18528814636, 16313.59216019609, 16446.75329870077, 16517.66964660676, 16593.66812663716, 16655.91672041632, 25310.0, 25701.0, 25735.227943161735, 25774.484510309314, 25903.0933917312, 20914.16343346249, 20954.580908381442, 20990.895045524674, 21014.159433623096, 21159.153633854472, 18167.636647266718, 18545.814541854408, 18620.534486637942, 18655.533611659816, 18699.906500467412, 21127.788722112582, 21338.573228535653, 21379.78620213778, 21398.0, 21513.0, 16072.276747546623, 16211.0, 16216.594585135466, 16252.349906003627, 16322.183890805174, 20163.39509814708, 20419.8979005104, 20439.0, 20614.072366743232, 20702.896485517475], "value": 13376.19736880943, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.4526280013592, 1483.0730793254213, 1525.4965861265769, 1536.9923150384238, 1539.0457916092018, 18122.27510899564, 18714.0, 18738.4378468646, 18751.718724219147, 18760.155792989313, 18337.44987650369, 18368.540786480313, 18377.0, 18454.815451845476, 18480.722789158175, 2924.283550530123, 2990.6411230652243, 2990.7308342249194, 2995.5806187133817, 3004.8347340896353, 2829.5472724364004, 2979.9404011919855, 3033.2568520712457, 3034.6358436987593, 3035.81785092894, 3034.620672415948, 3074.077776667002, 3075.046735511987, 3075.046735511987, 3075.9077227683206, 2978.2405486600887, 2979.597754303163, 3011.6687164411787, 3027.56100365448, 3028.0764366868098, 2886.7690584753377, 2909.461749576335, 2996.4456575533377, 3047.3295874907485, 3047.7866549341556, 17098.31606735729, 17403.912980435143, 17439.73840392395, 17547.64904701899, 17585.912070439696, 8270.421070525006, 8493.702720404755, 8559.443636163629, 8566.571671416405, 8611.61247743853, 5049.64652474327, 5220.705239161757, 5388.595855310868, 5409.7295135243085, 5421.674699518042, 1967.252444071258, 2014.6575082235909, 2041.3263623004373, 2078.5011597216712, 2083.802038806311, 32673.346533069205, 32777.18057048569, 32881.50677739836, 32887.34225315504, 32974.50538241928, 7134.500584959107, 7207.495475316678, 7213.422926165894, 7345.77962661121, 7389.408847292311, 20526.38420847377, 20556.177752890017, 20583.279585214445, 20584.073716682786, 20596.691049634268, 8333.250007499233, 8526.488410695378, 8542.957285213533, 8571.0, 8615.009273933578, 7561.886571701429, 7702.922970770221, 7724.8455030900195, 7739.922600774033, 7856.528608283521, 5630.943690563124, 5707.914381284284, 5760.164776107525, 5804.390538993429, 5845.970770146122, 1529.992350038265, 1562.4453319071565, 1618.8381161883717, 1664.6837100950781, 1700.8129105798353, 1018.7351288665001, 1025.4206373399154, 1030.7680771826278, 1034.1726618705006, 1045.1429827541494, 9850.852237216448, 9932.602695892083, 9932.950335248277, 9972.650957216463, 10128.03783640553, 1091.624553063146, 1094.698957786615, 1094.7810437912449, 1097.742030622803, 1126.808442564766, 5669.43305669438, 6129.233845769279, 6165.167702360213, 6327.683615819191, 6470.126532917996, 27181.592276115873, 27712.168634940983, 27780.58329125065, 27822.44355112927, 27887.581686274723, 25991.74008259893, 27480.450390992068, 27597.724022759514, 27599.17202483929, 27677.446451070868, 12118.81821772674, 12986.220826750425, 13180.736385272241, 13184.0111991601, 13237.205767653972, 10030.147437467605, 10089.394636321844, 10125.240606954361, 10288.0, 10344.689659310232, 21078.57842843165, 22831.0, 22997.54004919859, 23184.18855340055, 23387.415314617272, 23425.648615270442, 23440.76559234454, 24025.639615405435, 24248.87875560611, 24315.75684243135, 12860.228386296478, 12903.354832258537, 12959.546415875777, 12996.350182491027, 13189.274589897648, 16507.9174604131, 16557.83442165563, 16644.0, 16694.165291735608, 16709.830311878053, 13317.733645327233, 13430.865691342962, 13441.193528388329, 13550.119242249222, 13695.315234238447, 12887.0, 12986.415611297325, 13046.217226966412, 13323.0, 13390.196588204739, 11289.604863829727, 11635.41822908868, 11665.0, 11798.646040618794, 11845.289282643069, 8780.429272097294, 8817.559122044, 8986.460812351279, 9014.41406308614, 9074.591643375932, 8648.264897483785, 8729.734188542752, 8799.648014079365, 8808.383413161017, 8894.42186257891], "value": 7691.9790385802335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.556354916067, 559.6054781379127, 577.1717585265144, 582.6358525921299, 591.5977135547826, 6268.561200715952, 6354.555181137316, 6369.0, 6395.840103997402, 6426.650403415282, 6230.5950113242725, 6238.968805155968, 6245.968770156154, 6250.687465626712, 6309.337519560438, 4913.385826771653, 5117.7185254810975, 5131.461196574362, 5199.428062913076, 5202.115640341141, 5035.697858128506, 5047.107334749469, 5050.7222102784335, 5069.2142717878605, 5098.847034588968, 5005.524475174852, 5053.9241911371355, 5069.417017043051, 5074.4925507449325, 5085.821996230133, 4969.950300497021, 5031.52200540948, 5036.269740887587, 5048.368953880765, 5097.592192624581, 4614.323692258516, 4621.052684199731, 4648.674592778507, 4654.743989080599, 4677.111348843743, 6063.969680151571, 6194.287656919467, 6218.253809542839, 6279.529035322324, 6350.555461117724, 5795.3045634523705, 5928.940710592925, 5951.345352011275, 5974.551908606872, 6006.399360064002, 6679.465642748569, 6711.630860302681, 6712.851887396036, 6713.899291510631, 6738.338356349263, 5043.167877300278, 5091.1090559152, 5093.465186155438, 5123.205903085028, 5137.61467889906, 6729.528932974694, 6785.185777706657, 6874.759383421606, 6883.3116688330765, 6929.272426395206, 5222.477752224747, 5246.160614301693, 5252.527272545489, 5268.473152684701, 5306.0, 5318.154787188835, 5335.519803217651, 5341.679499230058, 5355.866103347447, 5418.701971391612, 5856.950067476349, 5876.265466816648, 5895.322037965603, 5903.406080358279, 5942.435468630473, 6705.966470167618, 6751.5611485254285, 6759.324067593299, 6770.661466926733, 6788.558743681645, 1845.5478407789908, 1849.824266694662, 1853.6478069166815, 1853.9536511587319, 1856.8885866848032, 1271.9809202861964, 1276.9680757980939, 1310.8033794930645, 1312.9803052954214, 1326.3898606641053, 6358.491320694333, 6372.0, 6381.202349706286, 6390.392912673288, 6474.0, 6558.114654521674, 6683.398494135551, 6760.18877734675, 6768.784827207037, 6852.794416167523, 6308.779192728232, 6384.297727250092, 6442.9355706443275, 6452.322506136882, 6457.677116144174, 3503.0, 3517.736169787276, 3570.0182449826507, 3592.550931133608, 3611.1513794258326, 7090.787276381717, 7093.964530177419, 7117.6085315308155, 7129.322714342129, 7227.963860180771, 6850.691718872663, 6899.412720229914, 6901.206361268519, 6976.720931162697, 7026.683799229047, 6908.620025898624, 6978.685959131852, 7036.8630899444715, 7048.577085374894, 7130.3939165170505, 6499.415052645285, 6629.502787291069, 6865.828354291183, 6870.416014638811, 6874.9375187442565, 6800.591964482147, 6806.366472046772, 6832.385085342343, 6835.0, 6872.828179295558, 7184.425245980414, 7235.3488186063505, 7236.20401755817, 7241.5293005954445, 7252.746153884589, 5144.511271429208, 5241.68549887008, 5247.737613119405, 5293.814716484904, 5293.855988324734, 6642.4021838034805, 6857.348551887762, 6863.313668633096, 6941.271166527442, 6960.686769095504, 6263.404976527223, 6587.374199451045, 6596.439302659328, 6611.0, 6626.602403855784, 6526.412622863965, 6563.474922006132, 6597.0, 6608.0, 6649.340263894481, 6546.149000629887, 6555.672216389257, 6623.602583844985, 6644.60132392058, 6685.064091027163, 6585.440237579668, 6600.910849709936, 6656.472069803012, 6686.297938716365, 6742.831429214113, 6448.355164483514, 6529.216494020748, 6531.314212007861, 6567.868642627216, 6568.540202185801], "value": 5246.353516316138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [988.5600907596123, 1012.9949350253247, 1027.8972102789717, 1029.4389557691059, 1041.5573381312943, 18977.525561860944, 19519.316823911166, 19544.90227548862, 19547.902260488678, 19617.11722972466, 17281.222344994472, 17408.564785880328, 17504.21231044603, 18495.907520462413, 18660.0, 1071.6410002649122, 1096.3750662122593, 1096.7587130831205, 1096.9122470202406, 1096.950637221323, 1060.5863713151878, 1089.4607169451094, 1097.253867370188, 1097.6706987903638, 1105.6351404036648, 1179.204037274836, 1182.6924999500106, 1183.0240051957128, 1183.6449065280424, 1183.9112066594996, 1159.9362035088068, 1165.8600967883865, 1172.0389280789757, 1172.197045024157, 1173.1084375874311, 863.1109956744563, 863.6890719341033, 864.3992425264444, 865.7446053414258, 866.1598249697784, 19686.80313196864, 20379.694304585442, 20452.693209601868, 20509.589808203902, 20585.58828823415, 23683.644745328835, 23969.880150599136, 24162.395940101636, 24167.2749817504, 24206.51586968251, 17184.398546050827, 17384.130793460277, 17605.0, 17635.206415711196, 17739.201735921913, 3783.5459744830523, 3795.772253664789, 3818.102745854722, 3818.732688711791, 3835.9808200959096, 156772.21613891973, 161142.0, 162508.9999999988, 162900.0, 167034.0, 17094.0, 17633.7354939676, 17676.91161544184, 17684.646307074043, 17693.55766105832, 32895.342093158004, 35393.64606353955, 35465.82267088648, 35556.28887422237, 35595.64404355923, 9627.229821614254, 9634.325597208128, 9642.373245739005, 9719.951400242953, 9749.512524373753, 4677.64917631179, 4746.07451546952, 4766.809327626856, 4767.118083154558, 4782.378290822171, 5636.098224284095, 5659.320881494247, 5681.77272909079, 5743.8564035899435, 5753.108268218432, 1157.7915975124558, 1162.3490845126587, 1183.633073747124, 1184.9170558060853, 1186.2526608236756, 769.0540635018958, 777.5684495105157, 786.6853258696567, 787.220651554968, 797.1948332184535, 12449.688757781129, 12855.550055748005, 13322.933385333012, 13760.380782864795, 14146.575602731935, 776.7786180938406, 782.2060608482395, 785.795693119793, 798.0981490915344, 800.87986801979, 6119.949816811329, 6212.844678882973, 6291.087792270096, 6296.087067375205, 6408.583442076343, 152850.0, 153568.0, 154731.22634386757, 155406.22296888442, 162476.18761906115, 132631.33684331708, 133294.33352833366, 137620.31189843986, 138541.3072934629, 139649.0, 111950.44024779987, 114009.0, 115945.42027289978, 117526.41236793932, 119966.99999999825, 12465.5013799447, 12657.810132848199, 12679.80980285278, 12941.352932353533, 12986.285754283605, 54641.63395915134, 55514.0, 55657.72171139118, 55747.721261395054, 57291.0, 72089.27910720826, 72364.27635723575, 72714.18214544679, 74170.0, 75410.0, 21070.894645526674, 21360.252391166236, 21539.138434462446, 21621.675674864575, 21681.0, 21755.891220543795, 22512.32463026112, 22555.210567630053, 22763.430914227276, 22820.543589128458, 22057.77942220557, 22197.778022220216, 22230.110795567995, 22553.097876084772, 22578.20976265823, 20325.288614898407, 20393.49016274605, 20708.68936965977, 20800.791992079885, 20918.895405522875, 21976.670349945085, 22392.888035559718, 22466.77533224712, 22489.32532024042, 22600.0, 14222.786658200343, 14410.063345882483, 14515.129092254498, 14542.781858272347, 14668.70662586721, 13886.0, 13907.860921391062, 13973.301334933416, 14020.228887411291, 14107.224102674041], "value": 10343.085218076756, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1351.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 104.0, 104.0, 105.0, 104.0, 108.0, 104.0, 105.0, 106.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 111.0, 114.0, 110.0, 110.0, 110.0, 107.0, 141.0, 112.0, 119.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 73.0, 72.0, 73.0, 79.0, 73.0, 74.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 77.0, 78.0, 76.0, 77.0, 79.0, 77.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 113.0, 113.0, 114.0, 114.0, 110.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 147.0, 150.0, 150.0, 149.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 93.0, 99.0, 93.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 43.0, 44.0, 47.0, 44.0, 45.0, 43.0, 44.0, 43.0], "value": 44.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 35.0, 36.0, 35.0, 36.0, 39.0, 36.0, 36.0, 35.0], "value": 36.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 70.0, 71.0, 70.0, 69.0, 69.0, 69.0, 69.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 102.0, 101.0, 101.0, 110.0, 99.0, 107.0, 103.0, 106.0, 102.0], "value": 103.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 146.0, 158.0, 146.0, 149.0, 150.0, 147.0, 146.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 62.0, 60.0, 58.0, 58.0, 58.0, 58.0, 62.0], "value": 58.7, "unit": "score"}]}]} 08:19:48 INFO - Return code: 0 08:19:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:48 INFO - # TBPL SUCCESS # 08:19:48 INFO - Running post-action listener: _package_coverage_data 08:19:48 INFO - Running post-action listener: _resource_record_post_action 08:19:48 INFO - [mozharness: 2017-09-19 15:19:48.730912Z] Finished run-tests step (success) 08:19:48 INFO - Running post-run listener: _resource_record_post_run 08:19:48 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290639872; Read time: 16; Write time: 147732 08:19:48 INFO - TinderboxPrint: CPU usage
13.0% 08:19:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:19:48 INFO - TinderboxPrint: I/O write bytes / time
290,639,872 / 147,732 08:19:48 INFO - TinderboxPrint: CPU idle
8,188.4 (87.0%) 08:19:48 INFO - TinderboxPrint: CPU user
1,177.2 (12.5%) 08:19:48 INFO - TinderboxPrint: Swap in / out
0 / 0 08:19:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8904704; Read time: 0; Write time: 728 08:19:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:19:48 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281243648; Read time: 16; Write time: 146972 08:19:49 INFO - Running post-run listener: _upload_blobber_files 08:19:49 INFO - Blob upload gear active. 08:19:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:49 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 08:19:49 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'] 08:19:49 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 08:19:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:50 INFO - (blobuploader) - INFO - Done attempting. 08:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:51 INFO - (blobuploader) - INFO - Done attempting. 08:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:52 INFO - (blobuploader) - INFO - Done attempting. 08:19:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:00 INFO - (blobuploader) - INFO - Done attempting. 08:20:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:00 INFO - Return code: 0 08:20:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e4a8d3b87a038d5ab9d2fab47f044cab5010e1a68204865da5fb5d4e739e2b9207f345db4e833eab36efbed0ef55f616a936fdde58d12d2f17be61f8dc34aec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/510e9cd34e9bf950665262def08e59638cb735fc0f7d2f510e50d2b269bd8c422ac2c3bcdb2cf668e7b7778338005cd6d9394fe4fec666134f147feea2f994f7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c92bba4d79c7b277e996bfbe6b6cf9ef1ab1e911db2a27a86fa0752d3d52af2e3b862c385a419c7ba5142cb5c06bc79db00f45ffd6bce1115ff28b4a97deb27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a2afd8ac963b804cefb88ffdd9c70d979a484a208979dc2ac0b75adc0f391ff498be08e47841d044ef9debc15cec1674aeceff313edfdb6715345bc575ebd7cd"} 08:20:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:00 INFO - Contents: 08:20:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e4a8d3b87a038d5ab9d2fab47f044cab5010e1a68204865da5fb5d4e739e2b9207f345db4e833eab36efbed0ef55f616a936fdde58d12d2f17be61f8dc34aec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/510e9cd34e9bf950665262def08e59638cb735fc0f7d2f510e50d2b269bd8c422ac2c3bcdb2cf668e7b7778338005cd6d9394fe4fec666134f147feea2f994f7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c92bba4d79c7b277e996bfbe6b6cf9ef1ab1e911db2a27a86fa0752d3d52af2e3b862c385a419c7ba5142cb5c06bc79db00f45ffd6bce1115ff28b4a97deb27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a2afd8ac963b804cefb88ffdd9c70d979a484a208979dc2ac0b75adc0f391ff498be08e47841d044ef9debc15cec1674aeceff313edfdb6715345bc575ebd7cd"} 08:20:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:00 INFO - Copying logs to upload dir... 08:20:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.172262 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-19 08:20:00.194034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 08:20:00.201836) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e4a8d3b87a038d5ab9d2fab47f044cab5010e1a68204865da5fb5d4e739e2b9207f345db4e833eab36efbed0ef55f616a936fdde58d12d2f17be61f8dc34aec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/510e9cd34e9bf950665262def08e59638cb735fc0f7d2f510e50d2b269bd8c422ac2c3bcdb2cf668e7b7778338005cd6d9394fe4fec666134f147feea2f994f7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c92bba4d79c7b277e996bfbe6b6cf9ef1ab1e911db2a27a86fa0752d3d52af2e3b862c385a419c7ba5142cb5c06bc79db00f45ffd6bce1115ff28b4a97deb27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a2afd8ac963b804cefb88ffdd9c70d979a484a208979dc2ac0b75adc0f391ff498be08e47841d044ef9debc15cec1674aeceff313edfdb6715345bc575ebd7cd"} build_url:https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/S7rsSIHMSlWKc6HsIfSCSA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e4a8d3b87a038d5ab9d2fab47f044cab5010e1a68204865da5fb5d4e739e2b9207f345db4e833eab36efbed0ef55f616a936fdde58d12d2f17be61f8dc34aec", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/510e9cd34e9bf950665262def08e59638cb735fc0f7d2f510e50d2b269bd8c422ac2c3bcdb2cf668e7b7778338005cd6d9394fe4fec666134f147feea2f994f7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5c92bba4d79c7b277e996bfbe6b6cf9ef1ab1e911db2a27a86fa0752d3d52af2e3b862c385a419c7ba5142cb5c06bc79db00f45ffd6bce1115ff28b4a97deb27", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a2afd8ac963b804cefb88ffdd9c70d979a484a208979dc2ac0b75adc0f391ff498be08e47841d044ef9debc15cec1674aeceff313edfdb6715345bc575ebd7cd"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 08:20:00.360926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 08:20:00.361347) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505832704.786735-43320051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 08:20:00.381279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 08:20:00.384755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 08:20:00.385457) ========= ========= Total master_lag: 0.58 =========