builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1498651864.54 results: success (0) revision: 6190181ff4093756d3f8df754109ed16d132d215 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.544852) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.545228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.545485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.587122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.587374) ========= 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=8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-28 05:11:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-06-28 05:11:05 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147164 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.765883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.766166) ========= 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=8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012950 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.817950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:04.818236) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6190181ff4093756d3f8df754109ed16d132d215 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 6190181ff4093756d3f8df754109ed16d132d215 --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=8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-28 05:11:05,167 truncating revision to first 12 chars 2017-06-28 05:11:05,167 Setting DEBUG logging. 2017-06-28 05:11:05,167 attempt 1/10 2017-06-28 05:11:05,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6190181ff409?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-28 05:11:05,594 unpacking tar archive at: mozilla-central-6190181ff409/testing/mozharness/ program finished with exit code 0 elapsedTime=0.765319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:05.601233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:05.601542) ========= script_repo_revision: 6190181ff4093756d3f8df754109ed16d132d215 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:05.601985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:05.602244) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-28 05:11:05.619328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-06-28 05:11:05.619634) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:06 INFO - MultiFileLogger online at 20170628 05:11:06 in /builds/slave/test 05:11:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:11:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:06 INFO - {'append_to_log': False, 05:11:06 INFO - 'base_work_dir': '/builds/slave/test', 05:11:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:11:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:06 INFO - 'branch': 'Firefox-Non-PGO', 05:11:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:06 INFO - 'config_files': ('talos/linux_config.py',), 05:11:06 INFO - 'default_actions': ('clobber', 05:11:06 INFO - 'read-buildbot-config', 05:11:06 INFO - 'download-and-extract', 05:11:06 INFO - 'populate-webroot', 05:11:06 INFO - 'create-virtualenv', 05:11:06 INFO - 'install', 05:11:06 INFO - 'setup-mitmproxy', 05:11:06 INFO - 'run-tests'), 05:11:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:06 INFO - 'download_minidump_stackwalk': True, 05:11:06 INFO - 'download_symbols': 'ondemand', 05:11:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:06 INFO - 'gecko_profile': False, 05:11:06 INFO - 'gecko_profile_interval': 0, 05:11:06 INFO - 'installer_path': 'installer.exe', 05:11:06 INFO - 'log_level': 'info', 05:11:06 INFO - 'log_name': 'talos', 05:11:06 INFO - 'log_to_console': True, 05:11:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:06 INFO - 'opt_config_files': (), 05:11:06 INFO - 'pip_index': False, 05:11:06 INFO - 'suite': 'dromaeojs-e10s', 05:11:06 INFO - 'system_bits': '32', 05:11:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:06 INFO - 'title': 'talos-linux64-ix-038', 05:11:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:06 INFO - 'use_talos_json': True, 05:11:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:06 INFO - 'work_dir': 'build'} 05:11:06 INFO - [mozharness: 2017-06-28 12:11:06.173433Z] Running clobber step. 05:11:06 INFO - Running pre-action listener: _resource_record_pre_action 05:11:06 INFO - Running main action method: clobber 05:11:06 INFO - rmtree: /builds/slave/test/build 05:11:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:07 INFO - Running post-action listener: _resource_record_post_action 05:11:07 INFO - [mozharness: 2017-06-28 12:11:07.154991Z] Finished clobber step (success) 05:11:07 INFO - [mozharness: 2017-06-28 12:11:07.155090Z] Running read-buildbot-config step. 05:11:07 INFO - Running pre-action listener: _resource_record_pre_action 05:11:07 INFO - Running main action method: read_buildbot_config 05:11:07 INFO - Using buildbot properties: 05:11:07 INFO - { 05:11:07 INFO - "project": "", 05:11:07 INFO - "product": "firefox", 05:11:07 INFO - "who": "cbook@mozilla.com", 05:11:07 INFO - "installer_path": "public/build/target.tar.bz2", 05:11:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:11:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:11:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:11:07 INFO - "stage_platform": "linux64", 05:11:07 INFO - "basedir": "/builds/slave/test", 05:11:07 INFO - "buildnumber": 687, 05:11:07 INFO - "platform": "ubuntu64_hw", 05:11:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:11:07 INFO - "slavebuilddir": "test", 05:11:07 INFO - "taskId": "Dl01W0c6Qq6TVHugD0qUqQ", 05:11:07 INFO - "branch": "mozilla-central", 05:11:07 INFO - "script_repo_revision": "production", 05:11:07 INFO - "revision": "6190181ff4093756d3f8df754109ed16d132d215", 05:11:07 INFO - "slavename": "talos-linux64-ix-038", 05:11:07 INFO - "repo_path": "mozilla-central" 05:11:07 INFO - } 05:11:07 INFO - Finding installer, test and symbols from parent task. 05:11:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dl01W0c6Qq6TVHugD0qUqQ'}, attempt #1 05:11:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dl01W0c6Qq6TVHugD0qUqQ'}, attempt #1 05:11:08 INFO - Task dependencies: ZhqIuEZ8TJWME0-iPOMIzg 05:11:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg'}, attempt #1 05:11:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2 05:11:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/test_packages.json 05:11:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.crashreporter-symbols.zip 05:11:08 INFO - Running post-action listener: _resource_record_post_action 05:11:08 INFO - [mozharness: 2017-06-28 12:11:08.502572Z] Finished read-buildbot-config step (success) 05:11:08 INFO - [mozharness: 2017-06-28 12:11:08.502788Z] Running download-and-extract step. 05:11:08 INFO - Running pre-action listener: _resource_record_pre_action 05:11:08 INFO - Running main action method: download_and_extract 05:11:08 INFO - mkdir: /builds/slave/test/build/tests 05:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:08 INFO - trying https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.test_packages.json 05:11:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:11:09 INFO - Downloaded 989 bytes. 05:11:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:11:09 INFO - Using the following test package requirements: 05:11:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:11:09 INFO - u'common': [u'target.common.tests.zip'], 05:11:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:11:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:11:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:11:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:11:09 INFO - u'mozbase': [u'target.common.tests.zip'], 05:11:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:11:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:11:09 INFO - u'web-platform': [u'target.common.tests.zip', 05:11:09 INFO - u'target.web-platform.tests.tar.gz'], 05:11:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:11:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:11:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.common.tests.zip 05:11:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:11:09 INFO - Fetch https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.common.tests.zip into memory 05:11:10 INFO - Content-Length response header: 67751490 05:11:10 INFO - Bytes received: 67751490 05:11:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:11:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.common.tests.zip 05:11:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:11:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.common.tests.zip into memory 05:11:25 INFO - Content-Length response header: 67751490 05:11:25 INFO - Bytes received: 67751490 05:11:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.talos.tests.zip 05:11:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:11:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.talos.tests.zip into memory 05:11:39 INFO - Content-Length response header: 14442527 05:11:39 INFO - Bytes received: 14442527 05:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:39 INFO - trying https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2 05:11:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:11:41 INFO - Downloaded 61730373 bytes. 05:11:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2 05:11:41 INFO - mkdir: /builds/slave/test/properties 05:11:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:41 INFO - Contents: 05:11:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2 05:11:41 INFO - Running post-action listener: _resource_record_post_action 05:11:41 INFO - Running post-action listener: set_extra_try_arguments 05:11:41 INFO - [mozharness: 2017-06-28 12:11:41.123720Z] Finished download-and-extract step (success) 05:11:41 INFO - [mozharness: 2017-06-28 12:11:41.123816Z] Running populate-webroot step. 05:11:41 INFO - Running pre-action listener: _resource_record_pre_action 05:11:41 INFO - Running main action method: populate_webroot 05:11:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:41 INFO - '--tppagecycles', 05:11:41 INFO - '7'], 05:11:41 INFO - 'tests': ['tsvgm']}}, 05:11:41 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['damp', 'tps']}, 05:11:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'tests': ['damp', 'tps']}, 05:11:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['dromaeo_dom']}, 05:11:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:11:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:11:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:11:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['a11yr', 05:11:41 INFO - 'ts_paint', 05:11:41 INFO - 'tpaint', 05:11:41 INFO - 'sessionrestore', 05:11:41 INFO - 'sessionrestore_no_auto_restore', 05:11:41 INFO - 'tabpaint']}, 05:11:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:41 INFO - 'ts_paint', 05:11:41 INFO - 'tpaint', 05:11:41 INFO - 'sessionrestore', 05:11:41 INFO - 'sessionrestore_no_auto_restore', 05:11:41 INFO - 'tabpaint']}, 05:11:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:41 INFO - 'ts_paint', 05:11:41 INFO - 'tpaint', 05:11:41 INFO - 'sessionrestore', 05:11:41 INFO - 'sessionrestore_no_auto_restore', 05:11:41 INFO - 'tabpaint']}, 05:11:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:41 INFO - 'ts_paint', 05:11:41 INFO - 'tpaint', 05:11:41 INFO - 'sessionrestore', 05:11:41 INFO - 'sessionrestore_no_auto_restore', 05:11:41 INFO - 'tabpaint']}, 05:11:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['a11yr', 05:11:41 INFO - 'ts_paint', 05:11:41 INFO - 'tpaint', 05:11:41 INFO - 'sessionrestore', 05:11:41 INFO - 'sessionrestore_no_auto_restore', 05:11:41 INFO - 'tabpaint']}, 05:11:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['a11yr', 05:11:41 INFO - 'ts_paint', 05:11:41 INFO - 'tpaint', 05:11:41 INFO - 'sessionrestore', 05:11:41 INFO - 'sessionrestore_no_auto_restore', 05:11:41 INFO - 'tabpaint']}, 05:11:41 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:11:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:11:41 INFO - 'bloom_basic_ref']}, 05:11:41 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:11:41 INFO - 'talos_options': ['--mitmproxy', 05:11:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:11:41 INFO - '--firstNonBlankPaint'], 05:11:41 INFO - 'tests': ['quantum_pageload_google', 05:11:41 INFO - 'quantum_pageload_youtube', 05:11:41 INFO - 'quantum_pageload_amazon', 05:11:41 INFO - 'quantum_pageload_facebook']}, 05:11:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['tsvgx', 05:11:41 INFO - 'tsvgr_opacity', 05:11:41 INFO - 'tart', 05:11:41 INFO - 'tscrollx', 05:11:41 INFO - 'cart', 05:11:41 INFO - 'tsvg_static']}, 05:11:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:41 INFO - 'tsvgr_opacity', 05:11:41 INFO - 'tart', 05:11:41 INFO - 'tscrollx', 05:11:41 INFO - 'cart', 05:11:41 INFO - 'tsvg_static']}, 05:11:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'talos_options': ['--disable-e10s'], 05:11:41 INFO - 'tests': ['tp5o']}, 05:11:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:11:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'talos_options': ['--disable-e10s', 05:11:41 INFO - '--xperf_path', 05:11:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:41 INFO - 'tests': ['tp5n']}, 05:11:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:11:41 INFO - 'talos_options': ['--xperf_path', 05:11:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:41 INFO - 'tests': ['tp5n']}}, 05:11:41 INFO - 'talos.zip': {'path': '', 05:11:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:41 INFO - Running post-action listener: _resource_record_post_action 05:11:41 INFO - [mozharness: 2017-06-28 12:11:41.138588Z] Finished populate-webroot step (success) 05:11:41 INFO - [mozharness: 2017-06-28 12:11:41.138677Z] Running create-virtualenv step. 05:11:41 INFO - Running pre-action listener: _resource_record_pre_action 05:11:41 INFO - Running main action method: create_virtualenv 05:11:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:11:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:11:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:41 INFO - Using real prefix '/usr' 05:11:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:43 INFO - Installing pip.................done. 05:11:43 INFO - Return code: 0 05:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:44 INFO - Reading from file tmpfile_stdout 05:11:44 INFO - Output received: 05:11:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:11:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11: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')]} 05:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:44 INFO - Using env: {'DISPLAY': ':0', 05:11:44 INFO - 'HOME': '/home/cltbld', 05:11:44 INFO - 'LANG': 'en_US.UTF-8', 05:11:44 INFO - 'LANGUAGE': 'en_US:en', 05:11:44 INFO - 'LOGNAME': 'cltbld', 05:11:44 INFO - 'MAIL': '/var/mail/cltbld', 05:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:44 INFO - 'MOZ_NO_REMOTE': '1', 05:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:44 INFO - 'NO_EM_RESTART': '1', 05:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:44 INFO - 'PWD': '/builds/slave/test', 05:11:44 INFO - 'SHELL': '/bin/bash', 05:11:44 INFO - 'SHLVL': '1', 05:11:44 INFO - 'TERM': 'linux', 05:11:44 INFO - 'TMOUT': '86400', 05:11:44 INFO - 'USER': 'cltbld', 05:11:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:44 INFO - '_': '/tools/buildbot/bin/python'} 05:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:11:44 INFO - Cleaning up... 05:11:44 INFO - Return code: 0 05:11:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11: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')]} 05:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:11:44 INFO - Using env: {'DISPLAY': ':0', 05:11:44 INFO - 'HOME': '/home/cltbld', 05:11:44 INFO - 'LANG': 'en_US.UTF-8', 05:11:44 INFO - 'LANGUAGE': 'en_US:en', 05:11:44 INFO - 'LOGNAME': 'cltbld', 05:11:44 INFO - 'MAIL': '/var/mail/cltbld', 05:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:44 INFO - 'MOZ_NO_REMOTE': '1', 05:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:44 INFO - 'NO_EM_RESTART': '1', 05:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:44 INFO - 'PWD': '/builds/slave/test', 05:11:44 INFO - 'SHELL': '/bin/bash', 05:11:44 INFO - 'SHLVL': '1', 05:11:44 INFO - 'TERM': 'linux', 05:11:44 INFO - 'TMOUT': '86400', 05:11:44 INFO - 'USER': 'cltbld', 05:11:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:44 INFO - '_': '/tools/buildbot/bin/python'} 05:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:44 INFO - Downloading/unpacking psutil>=3.1.1 05:11:44 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 05:11:44 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 05:11:44 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 05:11:44 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 05:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:45 INFO - Installing collected packages: psutil 05:11:45 INFO - Running setup.py install for psutil 05:11:46 INFO - building 'psutil._psutil_linux' extension 05:11:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:11:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:11:47 INFO - building 'psutil._psutil_posix' extension 05:11:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:11:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:11:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:47 INFO - Successfully installed psutil 05:11:47 INFO - Cleaning up... 05:11:47 INFO - Return code: 0 05:11:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:11:47 INFO - Using env: {'DISPLAY': ':0', 05:11:47 INFO - 'HOME': '/home/cltbld', 05:11:47 INFO - 'LANG': 'en_US.UTF-8', 05:11:47 INFO - 'LANGUAGE': 'en_US:en', 05:11:47 INFO - 'LOGNAME': 'cltbld', 05:11:47 INFO - 'MAIL': '/var/mail/cltbld', 05:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:47 INFO - 'MOZ_NO_REMOTE': '1', 05:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:47 INFO - 'NO_EM_RESTART': '1', 05:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:47 INFO - 'PWD': '/builds/slave/test', 05:11:47 INFO - 'SHELL': '/bin/bash', 05:11:47 INFO - 'SHLVL': '1', 05:11:47 INFO - 'TERM': 'linux', 05:11:47 INFO - 'TMOUT': '86400', 05:11:47 INFO - 'USER': 'cltbld', 05:11:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:47 INFO - '_': '/tools/buildbot/bin/python'} 05:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:48 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 05:11:48 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 05:11:48 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 05:11:48 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 05:11:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:49 INFO - Installing collected packages: mozsystemmonitor 05:11:49 INFO - Running setup.py install for mozsystemmonitor 05:11:49 INFO - Successfully installed mozsystemmonitor 05:11:49 INFO - Cleaning up... 05:11:49 INFO - Return code: 0 05:11:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11: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')]} 05:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:11:49 INFO - Using env: {'DISPLAY': ':0', 05:11:49 INFO - 'HOME': '/home/cltbld', 05:11:49 INFO - 'LANG': 'en_US.UTF-8', 05:11:49 INFO - 'LANGUAGE': 'en_US:en', 05:11:49 INFO - 'LOGNAME': 'cltbld', 05:11:49 INFO - 'MAIL': '/var/mail/cltbld', 05:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:49 INFO - 'MOZ_NO_REMOTE': '1', 05:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:49 INFO - 'NO_EM_RESTART': '1', 05:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:49 INFO - 'PWD': '/builds/slave/test', 05:11:49 INFO - 'SHELL': '/bin/bash', 05:11:49 INFO - 'SHLVL': '1', 05:11:49 INFO - 'TERM': 'linux', 05:11:49 INFO - 'TMOUT': '86400', 05:11:49 INFO - 'USER': 'cltbld', 05:11:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:49 INFO - '_': '/tools/buildbot/bin/python'} 05:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:49 INFO - Downloading/unpacking jsonschema==2.5.1 05:11: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 05:11: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 05:11: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 05:11: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 05:11:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:50 INFO - warning: no files found matching '*.txt' 05:11:50 INFO - no previously-included directories found matching 'build' 05:11:50 INFO - no previously-included directories found matching 'dist' 05:11:50 INFO - no previously-included directories found matching '.git*' 05:11:50 INFO - Installing collected packages: jsonschema, functools32 05:11:50 INFO - Running setup.py install for functools32 05:11:50 INFO - warning: no files found matching '*.txt' 05:11:50 INFO - no previously-included directories found matching 'build' 05:11:50 INFO - no previously-included directories found matching 'dist' 05:11:50 INFO - no previously-included directories found matching '.git*' 05:11:50 INFO - Successfully installed jsonschema functools32 05:11:50 INFO - Cleaning up... 05:11:50 INFO - Return code: 0 05:11:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:11:50 INFO - Using env: {'DISPLAY': ':0', 05:11:50 INFO - 'HOME': '/home/cltbld', 05:11:50 INFO - 'LANG': 'en_US.UTF-8', 05:11:50 INFO - 'LANGUAGE': 'en_US:en', 05:11:50 INFO - 'LOGNAME': 'cltbld', 05:11:50 INFO - 'MAIL': '/var/mail/cltbld', 05:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:50 INFO - 'MOZ_NO_REMOTE': '1', 05:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:50 INFO - 'NO_EM_RESTART': '1', 05:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:50 INFO - 'PWD': '/builds/slave/test', 05:11:50 INFO - 'SHELL': '/bin/bash', 05:11:50 INFO - 'SHLVL': '1', 05:11:50 INFO - 'TERM': 'linux', 05:11:50 INFO - 'TMOUT': '86400', 05:11:50 INFO - 'USER': 'cltbld', 05:11:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:50 INFO - '_': '/tools/buildbot/bin/python'} 05:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:11:51 INFO - Cleaning up... 05:11:51 INFO - Return code: 0 05:11:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11: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')]} 05:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:51 INFO - Using env: {'DISPLAY': ':0', 05:11:51 INFO - 'HOME': '/home/cltbld', 05:11:51 INFO - 'LANG': 'en_US.UTF-8', 05:11:51 INFO - 'LANGUAGE': 'en_US:en', 05:11:51 INFO - 'LOGNAME': 'cltbld', 05:11:51 INFO - 'MAIL': '/var/mail/cltbld', 05:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:51 INFO - 'MOZ_NO_REMOTE': '1', 05:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:51 INFO - 'NO_EM_RESTART': '1', 05:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:51 INFO - 'PWD': '/builds/slave/test', 05:11:51 INFO - 'SHELL': '/bin/bash', 05:11:51 INFO - 'SHLVL': '1', 05:11:51 INFO - 'TERM': 'linux', 05:11:51 INFO - 'TMOUT': '86400', 05:11:51 INFO - 'USER': 'cltbld', 05:11:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:51 INFO - '_': '/tools/buildbot/bin/python'} 05:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:11: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 05:11: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 05:11: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 05:11: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 05:11:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:53 INFO - Downloading docopt-0.6.1.tar.gz 05:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:53 INFO - Running setup.py install for blobuploader 05:11:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:53 INFO - Running setup.py install for requests 05:11:53 INFO - Running setup.py install for docopt 05:11:53 INFO - Successfully installed blobuploader requests docopt 05:11:53 INFO - Cleaning up... 05:11:53 INFO - Return code: 0 05:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11: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')]} 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:53 INFO - Using env: {'DISPLAY': ':0', 05:11:53 INFO - 'HOME': '/home/cltbld', 05:11:53 INFO - 'LANG': 'en_US.UTF-8', 05:11:53 INFO - 'LANGUAGE': 'en_US:en', 05:11:53 INFO - 'LOGNAME': 'cltbld', 05:11:53 INFO - 'MAIL': '/var/mail/cltbld', 05:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:53 INFO - 'MOZ_NO_REMOTE': '1', 05:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:53 INFO - 'NO_EM_RESTART': '1', 05:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:53 INFO - 'PWD': '/builds/slave/test', 05:11:53 INFO - 'SHELL': '/bin/bash', 05:11:53 INFO - 'SHLVL': '1', 05:11:53 INFO - 'TERM': 'linux', 05:11:53 INFO - 'TMOUT': '86400', 05:11:53 INFO - 'USER': 'cltbld', 05:11:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:53 INFO - '_': '/tools/buildbot/bin/python'} 05:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:53 INFO - Running setup.py (path:/tmp/pip-cw9BFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:53 INFO - Running setup.py (path:/tmp/pip-iXVp8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:54 INFO - Running setup.py (path:/tmp/pip-NKaZu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:54 INFO - Running setup.py (path:/tmp/pip-_wuL5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:54 INFO - Running setup.py (path:/tmp/pip-6pJkpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:54 INFO - Running setup.py (path:/tmp/pip-A016Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:54 INFO - Running setup.py (path:/tmp/pip-zoN67e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:54 INFO - Running setup.py (path:/tmp/pip-BuLXNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:54 INFO - Running setup.py (path:/tmp/pip-lYZSgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:54 INFO - Running setup.py (path:/tmp/pip-6K8FJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:54 INFO - Running setup.py (path:/tmp/pip-DFzBhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:54 INFO - Running setup.py (path:/tmp/pip-oNgR6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:54 INFO - Running setup.py (path:/tmp/pip-ugiV3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:54 INFO - Running setup.py (path:/tmp/pip-taa0Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:54 INFO - Running setup.py (path:/tmp/pip-QEmnTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:54 INFO - Running setup.py (path:/tmp/pip-TVPo7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:55 INFO - Running setup.py (path:/tmp/pip-BdJ_s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:55 INFO - Running setup.py install for manifestparser 05:11:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Running setup.py install for mozcrash 05:11:55 INFO - Running setup.py install for mozdebug 05:11:55 INFO - Running setup.py install for mozdevice 05:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Running setup.py install for mozfile 05:11:55 INFO - Running setup.py install for mozhttpd 05:11:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Running setup.py install for mozinfo 05:11:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Running setup.py install for mozInstall 05:11:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:55 INFO - Running setup.py install for mozleak 05:11:56 INFO - Running setup.py install for mozlog 05:11:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Running setup.py install for moznetwork 05:11:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Running setup.py install for mozprocess 05:11:56 INFO - Running setup.py install for mozprofile 05:11:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Running setup.py install for mozrunner 05:11:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Running setup.py install for mozscreenshot 05:11:56 INFO - Running setup.py install for moztest 05:11:56 INFO - Running setup.py install for mozversion 05:11:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:56 INFO - Cleaning up... 05:11:56 INFO - Return code: 0 05:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:56 INFO - Using env: {'DISPLAY': ':0', 05:11:56 INFO - 'HOME': '/home/cltbld', 05:11:56 INFO - 'LANG': 'en_US.UTF-8', 05:11:56 INFO - 'LANGUAGE': 'en_US:en', 05:11:56 INFO - 'LOGNAME': 'cltbld', 05:11:56 INFO - 'MAIL': '/var/mail/cltbld', 05:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:56 INFO - 'MOZ_NO_REMOTE': '1', 05:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:56 INFO - 'NO_EM_RESTART': '1', 05:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:56 INFO - 'PWD': '/builds/slave/test', 05:11:56 INFO - 'SHELL': '/bin/bash', 05:11:56 INFO - 'SHLVL': '1', 05:11:56 INFO - 'TERM': 'linux', 05:11:56 INFO - 'TMOUT': '86400', 05:11:56 INFO - 'USER': 'cltbld', 05:11:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:56 INFO - '_': '/tools/buildbot/bin/python'} 05:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:57 INFO - Running setup.py (path:/tmp/pip-L7ZQcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:57 INFO - Running setup.py (path:/tmp/pip-ZWDFRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:57 INFO - Running setup.py (path:/tmp/pip-X1X26e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:57 INFO - Running setup.py (path:/tmp/pip-g7_Q05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:57 INFO - Running setup.py (path:/tmp/pip-SGMzDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:57 INFO - Running setup.py (path:/tmp/pip-Njbqj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:57 INFO - Running setup.py (path:/tmp/pip-eTmsSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:57 INFO - Running setup.py (path:/tmp/pip-r1g_YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:57 INFO - Running setup.py (path:/tmp/pip-An6l4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:57 INFO - Running setup.py (path:/tmp/pip-xi7IS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:57 INFO - Running setup.py (path:/tmp/pip-_TZJiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:57 INFO - Running setup.py (path:/tmp/pip-0iGXSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:58 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)) 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:58 INFO - Running setup.py (path:/tmp/pip-DAUmQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:58 INFO - Running setup.py (path:/tmp/pip-YsXydB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:58 INFO - Running setup.py (path:/tmp/pip-pOufsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:58 INFO - Running setup.py (path:/tmp/pip-XuigB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:58 INFO - Running setup.py (path:/tmp/pip-QrFYTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:11:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:59 INFO - Downloading blessings-1.6.tar.gz 05:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:59 INFO - Installing collected packages: blessings 05:11:59 INFO - Running setup.py install for blessings 05:11:59 INFO - Successfully installed blessings 05:11:59 INFO - Cleaning up... 05:11:59 INFO - Return code: 0 05:11:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:59 INFO - Reading from file tmpfile_stdout 05:11:59 INFO - Current package versions: 05:11:59 INFO - argparse == 1.2.1 05:11:59 INFO - blessings == 1.6 05:11:59 INFO - blobuploader == 1.2.4 05:11:59 INFO - docopt == 0.6.1 05:11:59 INFO - functools32 == 3.2.3-2 05:11:59 INFO - jsonschema == 2.5.1 05:11:59 INFO - manifestparser == 1.1 05:11:59 INFO - mozInstall == 1.13 05:11:59 INFO - mozcrash == 1.0 05:11:59 INFO - mozdebug == 0.1 05:11:59 INFO - mozdevice == 0.51 05:11:59 INFO - mozfile == 1.2 05:11:59 INFO - mozhttpd == 0.7 05:11:59 INFO - mozinfo == 0.10 05:11:59 INFO - mozleak == 0.1 05:11:59 INFO - mozlog == 3.4 05:11:59 INFO - moznetwork == 0.27 05:11:59 INFO - mozprocess == 0.25 05:11:59 INFO - mozprofile == 0.28 05:11:59 INFO - mozrunner == 6.13 05:11:59 INFO - mozscreenshot == 0.1 05:11:59 INFO - mozsystemmonitor == 0.3 05:11:59 INFO - moztest == 0.8 05:11:59 INFO - mozversion == 1.4 05:11:59 INFO - psutil == 3.1.1 05:11:59 INFO - requests == 1.2.3 05:11:59 INFO - wsgiref == 0.1.2 05:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:59 INFO - Using env: {'DISPLAY': ':0', 05:11:59 INFO - 'HOME': '/home/cltbld', 05:11:59 INFO - 'LANG': 'en_US.UTF-8', 05:11:59 INFO - 'LANGUAGE': 'en_US:en', 05:11:59 INFO - 'LOGNAME': 'cltbld', 05:11:59 INFO - 'MAIL': '/var/mail/cltbld', 05:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:59 INFO - 'MOZ_NO_REMOTE': '1', 05:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:59 INFO - 'NO_EM_RESTART': '1', 05:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:59 INFO - 'PWD': '/builds/slave/test', 05:11:59 INFO - 'SHELL': '/bin/bash', 05:11:59 INFO - 'SHLVL': '1', 05:11:59 INFO - 'TERM': 'linux', 05:11:59 INFO - 'TMOUT': '86400', 05:11:59 INFO - 'USER': 'cltbld', 05:11:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:59 INFO - '_': '/tools/buildbot/bin/python'} 05:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:12:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:01 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:12:01 INFO - Installing collected packages: marionette-driver 05:12:01 INFO - Running setup.py install for marionette-driver 05:12:01 INFO - Successfully installed marionette-driver 05:12:01 INFO - Cleaning up... 05:12:01 INFO - Return code: 0 05:12:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12: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')]} 05:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12: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')]} 05:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, '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': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', '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 05:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:12:01 INFO - Using env: {'DISPLAY': ':0', 05:12:01 INFO - 'HOME': '/home/cltbld', 05:12:01 INFO - 'LANG': 'en_US.UTF-8', 05:12:01 INFO - 'LANGUAGE': 'en_US:en', 05:12:01 INFO - 'LOGNAME': 'cltbld', 05:12:01 INFO - 'MAIL': '/var/mail/cltbld', 05:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:01 INFO - 'MOZ_NO_REMOTE': '1', 05:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:01 INFO - 'NO_EM_RESTART': '1', 05:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:01 INFO - 'PWD': '/builds/slave/test', 05:12:01 INFO - 'SHELL': '/bin/bash', 05:12:01 INFO - 'SHLVL': '1', 05:12:01 INFO - 'TERM': 'linux', 05:12:01 INFO - 'TMOUT': '86400', 05:12:01 INFO - 'USER': 'cltbld', 05:12:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:01 INFO - '_': '/tools/buildbot/bin/python'} 05:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:12:01 INFO - Cleaning up... 05:12:01 INFO - Return code: 0 05:12:01 INFO - Running post-action listener: _resource_record_post_action 05:12:01 INFO - Running post-action listener: _start_resource_monitoring 05:12:01 INFO - Starting resource monitoring. 05:12:01 INFO - [mozharness: 2017-06-28 12:12:01.768744Z] Finished create-virtualenv step (success) 05:12:01 INFO - [mozharness: 2017-06-28 12:12:01.769277Z] Running install step. 05:12:01 INFO - Running pre-action listener: _resource_record_pre_action 05:12:01 INFO - Running main action method: install 05:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:01 INFO - Reading from file tmpfile_stdout 05:12:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:02 INFO - Reading from file tmpfile_stdout 05:12:02 INFO - Output received: 05:12:02 INFO - Usage: mozinstall [options] installer 05:12:02 INFO - Options: 05:12:02 INFO - -h, --help show this help message and exit 05:12:02 INFO - -d DEST, --destination=DEST 05:12:02 INFO - Directory to install application into. [default: 05:12:02 INFO - "/builds/slave/test"] 05:12:02 INFO - --app=APP Application being installed. [default: firefox] 05:12:02 INFO - mkdir: /builds/slave/test/build/application 05:12:02 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'] 05:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:12:20 INFO - Reading from file tmpfile_stdout 05:12:20 INFO - Output received: 05:12:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:20 INFO - Running post-action listener: _resource_record_post_action 05:12:20 INFO - [mozharness: 2017-06-28 12:12:20.027345Z] Finished install step (success) 05:12:20 INFO - [mozharness: 2017-06-28 12:12:20.027492Z] Running setup-mitmproxy step. 05:12:20 INFO - Running pre-action listener: _resource_record_pre_action 05:12:20 INFO - Running main action method: setup_mitmproxy 05:12:20 INFO - Skipping: mitmproxy is not required 05:12:20 INFO - Running post-action listener: _resource_record_post_action 05:12:20 INFO - [mozharness: 2017-06-28 12:12:20.028026Z] Finished setup-mitmproxy step (success) 05:12:20 INFO - [mozharness: 2017-06-28 12:12:20.028156Z] Running run-tests step. 05:12:20 INFO - Running pre-action listener: _resource_record_pre_action 05:12:20 INFO - Running main action method: run_tests 05:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:20 INFO - Python 2.7.3 05:12:20 INFO - Return code: 0 05:12:20 INFO - grabbing minidump binary from tooltool 05:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:12:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1745140>, '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 0x1745a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1745ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:12:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:12:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:12:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:20 INFO - Return code: 0 05:12:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:20 INFO - ENV: RUST_BACKTRACE is now 1 05:12:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 05:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 05:12:20 INFO - Using env: {'DISPLAY': ':0', 05:12:20 INFO - 'HOME': '/home/cltbld', 05:12:20 INFO - 'LANG': 'en_US.UTF-8', 05:12:20 INFO - 'LANGUAGE': 'en_US:en', 05:12:20 INFO - 'LOGNAME': 'cltbld', 05:12:20 INFO - 'MAIL': '/var/mail/cltbld', 05:12:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:20 INFO - 'MOZ_NO_REMOTE': '1', 05:12:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:20 INFO - 'NO_EM_RESTART': '1', 05:12:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:20 INFO - 'PWD': '/builds/slave/test', 05:12:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:20 INFO - 'RUST_BACKTRACE': '1', 05:12:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:12:20 INFO - 'SHELL': '/bin/bash', 05:12:20 INFO - 'SHLVL': '1', 05:12:20 INFO - 'TERM': 'linux', 05:12:20 INFO - 'TMOUT': '86400', 05:12:20 INFO - 'USER': 'cltbld', 05:12:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709', 05:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:20 INFO - '_': '/tools/buildbot/bin/python'} 05:12:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 05:12:23 INFO - mozversion application_buildid: 20170628112051 05:12:23 INFO - mozversion application_changeset: 6190181ff4093756d3f8df754109ed16d132d215 05:12:23 INFO - mozversion application_display_name: Nightly 05:12:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:23 INFO - mozversion application_name: Firefox 05:12:23 INFO - mozversion application_remotingname: firefox 05:12:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:12:23 INFO - mozversion application_vendor: Mozilla 05:12:23 INFO - mozversion application_version: 56.0a1 05:12:23 INFO - mozversion platform_buildid: 20170628112051 05:12:23 INFO - mozversion platform_changeset: 6190181ff4093756d3f8df754109ed16d132d215 05:12:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:12:23 INFO - mozversion platform_version: 56.0a1 05:12:23 INFO - using testdate: 1498651943 05:12:23 INFO - actual date: 1498651943 05:12:23 INFO - starting webserver on 'localhost:35566' 05:12:23 INFO - SUITE-START | Running 2 tests 05:12:23 INFO - TEST-START | dromaeo_css 05:12:23 INFO - operating with platform_type : linux_ 05:12:23 INFO - Initialising browser for dromaeo_css test... 05:12:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35566/getInfo.html -profile /tmp/tmpk8e1wN/profile 05:12:23 INFO - TEST-INFO | started process 3411 (/builds/slave/test/build/application/firefox/firefox http://localhost:35566/getInfo.html) 05:12:33 INFO - TEST-INFO | 3411: exit 0 05:12:33 INFO - Browser initialized. 05:12:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:33 INFO - TEST-INFO | started process 3619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk8e1wN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:44 INFO - PID 3619 | RSS: Main: 168157184 05:12:44 INFO - PID 3619 | 05:15:49 INFO - PID 3619 | Cycle 1(1): loaded http://localhost:35566/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35566/tests/dromaeo/cssquery-ext.html) 05:15:51 INFO - PID 3619 | RSS: Main: 175517696 05:15:51 INFO - PID 3619 | 05:18:52 INFO - PID 3619 | Cycle 1(1): loaded http://localhost:35566/tests/dromaeo/cssquery-ext.html (next: http://localhost:35566/tests/dromaeo/cssquery-jquery.html) 05:18:53 INFO - PID 3619 | RSS: Main: 172990464 05:18:53 INFO - PID 3619 | 05:21:54 INFO - PID 3619 | Cycle 1(1): loaded http://localhost:35566/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35566/tests/dromaeo/cssquery-mootools.html) 05:21:55 INFO - PID 3619 | RSS: Main: 176394240 05:21:55 INFO - PID 3619 | 05:24:57 INFO - PID 3619 | Cycle 1(1): loaded http://localhost:35566/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35566/tests/dromaeo/cssquery-prototype.html) 05:24:57 INFO - PID 3619 | RSS: Main: 175554560 05:24:57 INFO - PID 3619 | 05:28:00 INFO - PID 3619 | Cycle 1(1): loaded http://localhost:35566/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35566/tests/dromaeo/cssquery-yui.html) 05:28:01 INFO - PID 3619 | RSS: Main: 174161920 05:28:01 INFO - PID 3619 | 05:31:02 INFO - PID 3619 | Cycle 1(1): loaded http://localhost:35566/tests/dromaeo/cssquery-yui.html (next: http://localhost:35566/tests/dromaeo/cssquery-dojo.html) 05:31:03 INFO - PID 3619 | RSS: Main: 177242112 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | __start_tp_report 05:31:03 INFO - PID 3619 | _x_x_mozilla_page_load 05:31:03 INFO - PID 3619 | _x_x_mozilla_page_load_details 05:31:03 INFO - PID 3619 | |i|pagename|runs| 05:31:03 INFO - PID 3619 | |0;dojo.html;3057.4955132403156;3067.355855270393;3084.583581216536;3092.118746157345;3104.8758049678013;6014.699265036747;6019.638821670703;6036.0644100164545;6095.847603809907;6161.16824228729;6124.869201255664;6129.297663865963;6133.969330153354;6150.261968563767;6156.569040167179;5630.324361076677;5643.830685079454;5703.287089113861;5708.1152421374545;5758.9424105759035;5686.004949133885;5737.540996720273;5767.480926716595;5767.711614419283;5773.740181691834;5558.86102847428;5647.632903861236;5673.092305231185;5690.829275121753;5701.942980570183;5557.499825015768;5604.131359639263;5639;5645.294338207724;5667.093265077609;5643.294588176478;5655.745491452894;5674.205611214434;5694.886102277973;5700.657960522382;5957.821265362046;6091.634501929854;6092.817215483543;6112.052631842072;6119.265688117454;6559.6064236145985;6577.845147393182;6613.966930165367;6630.9005364919085;6631.204255489324;6486.383793539606;6587.604743715345;6630.6684665767;6631.900521492182;6688.565243259172;6139.2325959255095;6143.082036032849;6155.72299246535;6162.568620196633;6176.042713379434;6581.177352830896;6735.562188457735;6762.154730658668;6808.046873437723;6815.625140617313;6429.421352078241;6447.806565803034;6449.96775016122;6455;6464.741410343628;6515.446187074057;6562.671866406756;6584.242812076577;6594.109795177686;6607.735690572419;6525.836854078686;6536.24833144185;6538.673066346663;6550.0829883816305;6561.606303621798;6459.547831651833;6531.6081035137095;6561.540692151503;6573;6573.441257493071;5283.392409872914;5299.814506492255;5314.468553144655;5353.812616558402;5354.518093371537;4520.660950428731;4538.636909047268;4560;4602.907941841211;4615.399998000238;5686.118651609007;5747.712614369265;5761.798337058183;5762.1068734346245;5775.306963164363;6575.934240657628;6606.438452731475;6612.933870661328;6633.7346506140175;6639.701213445406;5639.689817060101;5758.971205144031;5785.276471380347;5808.506276966421;5843.3864444233595;5702.2301989231755;5738.053221218453;5778.855528611818;5795.391483894215;5796.159556864315;6421.454176395058;6469.967650161719;6484.1894763154605;6486.286508483969;6502.60984340941;6663.833404164935;6671.866562668816;6679.799606011828;6691.029800678777;6707.262201157966;6243.843903902439;6498.480121590167;6515.511336649675;6516.543841931019;6527.5757075789925;6389.201349831271;6393.680315984089;6406.327335629691;6490.448311893542;6495.512836537184;6631.502637302126;6693.431058360094;6705.195376554844;6710.597364158166;6728.8654226914205;6460.709268083042;6470.708818103102;6476.902846457401;6479.222493300834;6483.870322593616;6474.611523308617;6475.384838440341;6481.222253329631;6490;6495.480361570969;6181.443670069715;6291.150694656163;6310.1796766420075;6310.968445157745;6315.5894866833505;6335.429811317003;6357.777477788441;6431.774887878902;6447.806565803034;6450.129232553545;6209.5032397409;6213.813585592439;6218.751249950133;6227.878981783141;6280.026595877646 05:31:03 INFO - PID 3619 | |1;ext.html;738.8226825561864;790.1940021178402;822.2312138150828;839.626366267011;843.582426698784;42028.94927626811;43230;43374;43454.34818477721;43491.34762978554;38908.61091389085;38950.4157437638;39026;39081;39377.60622393775;6888.448924086074;7025.508214424993;7040.084788977451;7064.823379415504;7066.116735408048;6863.897041544381;6944.270851560589;6975.686094125751;6975.755848545302;7004.929950700504;6962.825929351781;6965;6975.197852247005;6978.406835418996;6979.790606281819;6925.342092501204;6926.826829329257;6943.826404339907;6948.27043160471;6975.686094125776;6194;6194.473469755077;6214.161088253073;6253.030780229072;6256.343083976208;34149.658503414896;34295.14262143442;34328.65671343279;34491.65508344935;34611.82694086513;3385.1367901185286;3425.0581090200144;3427.0575591712477;3560.181158333598;3621.2214373909474;31189.220269493446;31254.37491250185;31256.21859453509;31320;31339.529907051412;3759.2105657811894;3782.8865134045745;3792.27946690128;3804.0489877530617;3827.8660246891227;174325;175428;175991;179299;181302;42095.7895210522;50150.247746283836;50172.74913625408;50537.494625054016;50752.746236268584;52636.73681631644;52667.209991850155;52923.47076529262;53040.73479632654;53187;15730.606734831721;15885.920570397306;15926.28331725075;15926.442574510069;15944.521664350088;12959.935200323938;12973.740525189443;13010.089293749535;13013.089083764235;13014.739705205842;14954.177520236492;14984.400623975136;15005.24973751308;15098.169600671848;15208.08751474915;5704.572157088235;5808.419158084243;5863.560232982543;5954.642721436728;5966.224390829165;950.705281362766;988.8566157907063;1013.9340942838692;1017.1303535477208;1021.4983973558857;22707.88646056759;23029.309120726404;23035.07859685594;23078.884605576866;23134.8843255786;1048.3866937841296;1089.6186334782922;1100.7523307255804;1101.6034227678028;1119.2651390344934;11810.350430726392;12061.638150855488;12367.567135150226;12448.75102497945;12553.309567973667;223272.76727232843;224950;225097;225792;225950;55445.44554554483;56226;56235.43764562302;56255.43744562502;56656.15015774767;1405.9226742529258;1456.6358410397402;1458.1688437590471;1474.336548553134;1479.8002269693454;21853.344399668036;22426.66360004634;22461.550768984856;22653.093876244766;22716.65925011093;38807.41788873113;38882.6111738879;38938.4159237606;39179;39183.608163918;195400;196157;196807;197318;198576;31797.20506987344;31805.36389272248;32154.67845321517;32300.83849580737;35155.472667910515;40161.59838401696;40249;42158.36762448504;42179.57820421756;44458.777706111265;31565.368692626478;32528.34943301168;32636.347273054882;32767;32799.344013120084;31202.531962020134;32075.35849283048;32156.51765223477;32251.677483225805;32270.677293226767;33145.50281745824;35339.46990795191;35427;35462.113447164025;35479.46780798342;30524.389512210077;31081.53377699291;31086.68913310838;31408.685913140576;31437.68562314439;21455;22370.440738981655;22447.77552224457;22545.8872705642;22688.773112269326 05:31:03 INFO - PID 3619 | |2;jquery.html;565.7821738630626;572.9656220626761;575.516566084489;578.5053779018939;593.8841925824464;21771;21776.782232177673;22736.06743426811;23067.42331441715;23070.423239419;23761.40596485089;24003.279901602935;24176.395590110213;24192.27423177303;24324.39189020271;6337.683115844213;6492.285848556655;6517.055027021079;6521.282658907517;6525.8042258732075;6408.263049749268;6465.8706825863455;6480.675966201671;6484.675766211694;6487.156669632941;6097.115918191859;6114.633122012693;6314.305426403092;6382.106505089291;6398;6311.116443697886;6349.936500635027;6363.077353783722;6371.87256254877;6376.330485299047;5879.029960056586;5910.763569457216;5915.822525324247;5936.198613187207;5954.970225148846;26722.465550688878;28226.576601350996;28528.857355713295;28584.28539286514;28760.137195884156;1933.2750218668;1975.940721778349;1978.6933025381088;1987.5925435285876;1992.471994921347;18153.364632237808;18495.612829037742;18646.62706745871;18682.439526814218;18682.532936676555;2231.419830843976;2277.5103352779233;2294.644330128816;2297.1959814065112;2398.5322862041908;120067.39966300112;123434;124243;124944;125096.37451812773;14340.354684039243;14490.203038832966;14852.405903763945;14883.33025013877;15167.620809479631;23206.7679323208;23298.65052024221;23331.416714582272;23409.531809363718;23515.7648423517;9470.715878523655;9791.951040244754;9840.507974601385;9973.401595904124;9974.501274936225;8868.8669669955;8957.283417326598;9025.187733104052;9120.45277283365;9131.360804743605;8575.871361929576;8802.515861627544;8841.955790221007;9042.412243204302;9152.63389464414;2580.832245904048;2646.8808903599383;2687.2341382705836;2690.838549687025;2752.0918097027934;949.2595775295281;957.2389949989774;958.9760255993656;981.3425005246502;996.6661168508631;19022.239110435705;19298.614027719366;19401.2239510418;19489.707654385194;19697.901510492644;1001.8797744270735;1013.3869009249298;1029.3016522737544;1030.896910308963;1037.4242295526055;10561.313514621525;10798.622048228432;10897.891021089847;10937.726556835984;11079.50142243601;434555;443928;453474;460645;461412;97202;97628.51185744026;99027.50486247666;99773.50113249387;100044.49977750065;1142.6349401013933;1167.5580657887333;1177.776222517719;1190.7797057544383;1192.1654841610907;16218.270177842262;16777.245023973708;17197.914010429868;17244.741328879827;17299.7405038922;45516.54483455256;47389.526104738514;48164.5183548174;48597;51104.48895511146;60788.08817867824;61039.389606103374;61507.69246153741;61679.38320616737;61829.69085154725;12239.75520489603;12829.422675979416;12835.35823208817;13153.342332883509;13172.209667419986;18714.719279211095;18825.623487529898;18957.241710331433;19045.523861903563;19198.520036999187;15394.461193858162;15562.688746225238;15624.453144139901;15644.608884777515;15801.762973555176;13363.331833408096;13857.861421385656;13901.930490347484;14371.85628143747;14437.711245775236;15814.9209253953;15865.127417992122;15928.123953182687;16056.67886642284;16059.518214453585;13022.739545209231;13080;13100.60698179056;13125.343732813511;13154.539591114266;15609.375624974873;15614.843851561793;15729.528114156594;15732.842671573138;15789.289481973108 05:31:03 INFO - PID 3619 | |3;mootools.html;1370.5271681269962;1416.8512306207847;1419.1768774111017;1425.809449109993;1434.7847822826577;12991.935040324797;13513.797293040612;13568.525101621433;13579.388927498274;13628.454861805541;13115.21308721475;13509.392077356519;13512.05415620907;13558.457661693521;13663.385147668354;2575.317540851676;2627.8948842046293;2627.934301642455;2628.6714160729907;2636.288202185409;2376.9049238030457;2451.534208500379;2455.5211733711935;2455.6439316299125;2458.5820410530164;2376.263358358914;2401.711794584652;2410.337157281744;2418.8790560471994;2422.970237648992;2287.5882341178663;2332.242021343062;2344.7069116360453;2370.5140446208484;2438.634204869266;2390.940226494334;2410.2287268074224;2420.697412823397;2422.321749910028;2430.1008626808193;13006.934965325112;13253.204807711472;13263.403146858414;13275.535356262484;13322.800157997637;6891.104156459678;7120.28797120289;7127.10911136108;7132.215456299803;7176.712931482734;4061.1471590965934;4230.978845105755;4328.826846926119;4340.8480703175555;4350.847720329805;1589.9841001589953;1594.920253987296;1611.3071379306894;1627.2839950421776;1656.8508834204858;19756.50608734779;20417.081231344626;20956.79043209579;21290.25484108049;21351.786482135292;5549.250851135126;5672.14917762339;6100.572959892765;6344.111824344595;6367.94928836746;14596.12423254608;14710.264486775832;14719.411223551153;14720.705585888223;14728.852711472962;7122;7235;7259.237780033126;7287.963560182166;7330.926690733131;6765.221999470025;6860.0738900248825;6866.073080134218;6888;6943.201531823804;4795.112904112751;4869.780859861315;4886.902261954741;5023.2214006829;5024.547790698854;1433.426629348269;1450.6083357493417;1454.316471258507;1456.9635759105895;1466.003117879852;895.4090300401704;895.6372669069037;909.6543313540944;915.6108653822099;923.8013827027221;6987.965060174666;7014.859702805916;7106;7110.537815042006;7149.249328820399;726.9963650181716;727.2291371146601;739.5525706947219;744.1107876088131;745.5973774162001;4173.937390939138;4573.794179261875;4975.577075948585;5073.162928116893;5240.34495688039;17035.91482042582;17683.292668293383;17756.55608609769;17800.643987120184;17856.46430607084;15942.920285398499;17716.734248986275;17852.642947141245;17872.374466893856;17921.820781792016;9355.4386736796;10042.799144017079;10080.495975201356;10097.697069087939;10271.537780799881;7296.160941491797;7454.105507339154;7567.508111972704;7648.65581048843;7779.066512018594;14484.203368814817;14704.264786760405;14876;14891;14952.177630230442;15029.473968411054;15189.16459594733;15369;15403;15728.134952577719;9771.755706107404;9954.900450995687;9963.003699629979;9968.850467243143;9970.451625160686;12778.680532986378;13387.799183012457;13424.530141445002;13434.328283585977;13467.528636497676;10112.84830727525;10416.895831041593;10612.8938710615;10863.076638485501;10869.945650271698;9376.156145946898;9885.258605604464;9920.702378928643;9940.751481212737;10243;8858.689945851864;9009.099090090938;9030.864537032081;9037.68368107113;9043.140901614335;6670.366315200048;6997.895031574429;7022.473314501331;7022.964885175541;7028.367446929801;6936.2976131751875;7097.361237488651;7207.9639601801655;7221.927780722336;7253.782386528413 05:31:03 INFO - PID 3619 | |4;prototype.html;478.15128147538115;481.90602832447667;483.181008191116;509.8444974282842;511.0698528677806;6271.560990730645;6299.905501417476;6331.493480521559;6341.80974570763;6357.078223657579;6007.987324246372;6155.353687862777;6176.84557886052;6192.81421557354;6199.783007594735;4963.35476388069;4971.279164521142;4972.751362431882;5011.248312753098;5019.347484826967;4946.826861059863;4948.15881300178;4959.950400495985;4965.28003439501;4993;4938.456769755324;4943.703377797344;4953.182724850395;4958.67768595042;4967.354243948282;4724.692894961817;4901.926471102936;4937.876553086202;4969.254611808222;4981;4414.889627759299;4425.36261583213;4425.889352766175;4441.400410944513;4452.510223875371;6017.879642407127;6046.516278697693;6053.4551890330085;6068.937935861207;6129.478994285491;5619.157126431027;5624.521915637176;5632.9436705632825;5642.717864106819;5643.971780141114;6576.375244351779;6598.746238214771;6606.834829129262;6608.605277490463;6619.735210591571;4819.614430845524;4825.9034819303415;4828.46886842447;4836.274558816171;4843.346148269974;6892.758753443605;6895.103636527269;6904.4131248843905;6919.238883722786;6968.930310696929;4968.478309777422;5001.349824522788;5001.8499445016705;5008.84973450797;5012.992204677237;5044.9495505045215;5078.263651770547;5087.440381558025;5089.211172268304;5093.923591146136;5675.474413885781;5682.374938756733;5683.801066962719;5684.687342196219;5695.145728140812;6668.66626674667;6674.965380366051;6675.833104172434;6677.833054173684;6684.231313398924;1643.2112585958807;1754.6402987387555;1775.0858307971405;1780.2256018631936;1783.4382169616529;1205.6503613951857;1221.3343727668441;1231.96920076997;1237.0845574274972;1241;5829.88340233193;5866.23738913947;5873.914760260046;5896.786251492947;5903.3801450847905;6568.573042752301;6662.400383965466;6702.564333318319;6714.630695311805;6788.2193547742645;5819.679917604572;5841.707914604252;5842.532597392198;5844.824655260349;5859.912101318484;3588.3540962626457;3620.837062332201;3624.7462677612843;3629.1471504196493;3640.6177351378255;6496.707648155844;6553.868922621617;6563.212414510289;6587.967060164764;6596.670166491656;6858.177018757781;6931.792046238621;6942.132233470817;6951.3396227359335;6976.302369763084;6538.934610653832;6579.30917253691;6593.175853018372;6646.734130634817;6662.367075127855;6751.831204219934;6752.594844309161;6784.321567843176;6790.287019863041;6794.150731158606;6651.33486651331;6695.933040669531;6713.932860671331;6760.932390676227;6761.864762704817;6646.9002964956535;6652.434543063894;6657.241486114379;6664.600123992576;6679.799606011828;4803.567678908915;4924.285978533021;4926.211806111005;4935.8025678972435;4988.301637770787;6612.371824676648;6771.559848609824;6795.286494917962;6806.549642128731;6819.863602728017;6604.438622717123;6608.43828274602;6621.437177839937;6624.436922861418;6627.304133065959;6502.252240992158;6545.738170473128;6593.703283352164;6616.801495955129;6626.867462650624;6531.183602049744;6533.444657204001;6537.673116344069;6552.57408268461;6564.179477565304;6652.910523449662;6654.933450665431;6657.633830139195;6666.966665166643;6671.966640166768;6425.742970281136;6450.903236451551;6456.903146452713;6466.418022378009;6484.546081774419 05:31:03 INFO - PID 3619 | |5;yui.html;849.193266396923;863.4646519158123;864.6238886084552;867.2151702709051;876.62743334083;16410.507684769447;16911.661766764657;17422.82577174228;17482.038487883176;17565.20956556955;17255;20214.999999999964;20329.695054574193;20352.389428317176;20460.07929643166;1031.6440827914375;1057.735566108473;1059.9947000264988;1061.6337363609543;1062.7290041039523;1055.9102476289524;1056.3345092591655;1057.6139709006234;1057.8360354145082;1058.4231593781408;1026.8408396698487;1066.8506409102731;1071.6677829872726;1106.5131342209402;1111.1222134513725;1063.7766069125494;1064.2018486135398;1068.6526878764355;1069.1393428290223;1069.9465026748671;783.3459061683501;785.5404588315843;786.3473317146754;789.2423273657296;790.9406794490378;16960.406385776438;17015.31938722462;17031.744523832152;17147.74278385825;18122.09389530518;18968.5257868553;19217.423477295702;19247.711284330748;19290.71063934042;19401.611967760567;15903.920480397639;15910.124943128123;15916.283767230503;15927.044377337397;15985.040897546069;3496.7901925884275;3619.330423871566;3620.25784714133;3643.0163855758797;3652.397354436515;97038;99040;101450.49274753653;101653;103296.48351758193;15410.537683869501;15465;15483.922580387027;15645.687086258438;15684.137372444397;27336;27837.860810695816;27927.441451171268;28024.8598757009;28062.579061314096;7588.354989825927;7769.650365733555;7769.922300777033;7799.493032952953;7825.413094017971;3887.8056097195026;3891.8248678809523;3935.1932853765484;3941.467901833273;3951.545572259227;4738.431388233434;4781.904361912742;4784.2823576463115;4879.2925025871045;4908.8772780680765;878.5563290538237;887.5473508510706;890.6481939633809;893.41927746965;933.2580598424133;621.8880601491685;681.7443458702986;687.9174499060044;712.8966299886488;721.4336745654635;12780.948002758203;12864.48542058326;12979.675508112372;13241.867581324255;13536.59390218295;660.6498555765452;694.2467422846167;698.0332239847847;700.7687463137255;728.9161746399232;5463.580293155605;5483.862903427446;5539.806106786243;5561.193626924073;5675.829725108253;95038.5248073769;95307.04865936452;97019.51490242504;98524;99690;83924.58037709894;86986.56506717553;87208;88535;88989.55505222433;71836;75989.62005189939;76233;76793.2320676786;78207;10736.355818650905;10806.35161890289;10807.35155890649;11007.449627518752;11222.989930906258;32628.34743305073;33382.33235335328;33752;34286.31427371489;35369.64630353663;41157.382639261035;43583.34624980565;44312;44889.551104488535;45285;15552.377904883679;17096.40162594353;17257;18159.636807264043;18451.44645660632;19832.801671983674;20433.79566204319;20473.181072756925;20662.17351305991;21108.683369749775;16129.596760081093;16361.873925730617;16372.508824735278;16811.91594042022;18967.525811854262;17377.82622173762;17516.562085947953;17710.91144544269;17732.645347092726;18620.534486637942;16962.575935601708;18154.455366339032;18238.817611824245;18251.269949201884;18309.54226144357;12429.378531073591;13026.674333141747;13172;13320.600381988555;13383.263920484078;12095;12585.496580136693;12650.810237846255;12682.873171268538;13389.598312050653 05:31:03 INFO - PID 3619 | __end_tp_report 05:31:03 INFO - PID 3619 | __start_cc_report 05:31:03 INFO - PID 3619 | _x_x_mozilla_cycle_collect,351 05:31:03 INFO - PID 3619 | __end_cc_report 05:31:03 INFO - PID 3619 | __startTimestamp1498653063075__endTimestamp 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | ------- Summary: start ------- 05:31:03 INFO - PID 3619 | Number of tests: 6 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | [#0] dojo.html Cycles:165 Average:6071.28 Median:6291.15 stddev:715.28 (11.4%) stddev-sans-first:677.28 05:31:03 INFO - PID 3619 | Values: 3057.5 3067.4 3084.6 3092.1 3104.9 6014.7 6019.6 6036.1 6095.8 6161.2 6124.9 6129.3 6134.0 6150.3 6156.6 5630.3 5643.8 5703.3 5708.1 5758.9 5686.0 5737.5 5767.5 5767.7 5773.7 5558.9 5647.6 5673.1 5690.8 5701.9 5557.5 5604.1 5639.0 5645.3 5667.1 5643.3 5655.7 5674.2 5694.9 5700.7 5957.8 6091.6 6092.8 6112.1 6119.3 6559.6 6577.8 6614.0 6630.9 6631.2 6486.4 6587.6 6630.7 6631.9 6688.6 6139.2 6143.1 6155.7 6162.6 6176.0 6581.2 6735.6 6762.2 6808.0 6815.6 6429.4 6447.8 6450.0 6455.0 6464.7 6515.4 6562.7 6584.2 6594.1 6607.7 6525.8 6536.2 6538.7 6550.1 6561.6 6459.5 6531.6 6561.5 6573.0 6573.4 5283.4 5299.8 5314.5 5353.8 5354.5 4520.7 4538.6 4560.0 4602.9 4615.4 5686.1 5747.7 5761.8 5762.1 5775.3 6575.9 6606.4 6612.9 6633.7 6639.7 5639.7 5759.0 5785.3 5808.5 5843.4 5702.2 5738.1 5778.9 5795.4 5796.2 6421.5 6470.0 6484.2 6486.3 6502.6 6663.8 6671.9 6679.8 6691.0 6707.3 6243.8 6498.5 6515.5 6516.5 6527.6 6389.2 6393.7 6406.3 6490.4 6495.5 6631.5 6693.4 6705.2 6710.6 6728.9 6460.7 6470.7 6476.9 6479.2 6483.9 6474.6 6475.4 6481.2 6490.0 6495.5 6181.4 6291.2 6310.2 6311.0 6315.6 6335.4 6357.8 6431.8 6447.8 6450.1 6209.5 6213.8 6218.8 6227.9 6280.0 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | [#1] ext.html Cycles:180 Average:36785.18 Median:3426.06 stddev:52112.18 (1521.1%) stddev-sans-first:52188.08 05:31:03 INFO - PID 3619 | Values: 738.8 790.2 822.2 839.6 843.6 42028.9 43230.0 43374.0 43454.3 43491.3 38908.6 38950.4 39026.0 39081.0 39377.6 6888.4 7025.5 7040.1 7064.8 7066.1 6863.9 6944.3 6975.7 6975.8 7004.9 6962.8 6965.0 6975.2 6978.4 6979.8 6925.3 6926.8 6943.8 6948.3 6975.7 6194.0 6194.5 6214.2 6253.0 6256.3 34149.7 34295.1 34328.7 34491.7 34611.8 3385.1 3425.1 3427.1 3560.2 3621.2 31189.2 31254.4 31256.2 31320.0 31339.5 3759.2 3782.9 3792.3 3804.0 3827.9 174325.0 175428.0 175991.0 179299.0 181302.0 42095.8 50150.2 50172.7 50537.5 50752.7 52636.7 52667.2 52923.5 53040.7 53187.0 15730.6 15885.9 15926.3 15926.4 15944.5 12959.9 12973.7 13010.1 13013.1 13014.7 14954.2 14984.4 15005.2 15098.2 15208.1 5704.6 5808.4 5863.6 5954.6 5966.2 950.7 988.9 1013.9 1017.1 1021.5 22707.9 23029.3 23035.1 23078.9 23134.9 1048.4 1089.6 1100.8 1101.6 1119.3 11810.4 12061.6 12367.6 12448.8 12553.3 223272.8 224950.0 225097.0 225792.0 225950.0 55445.4 56226.0 56235.4 56255.4 56656.2 1405.9 1456.6 1458.2 1474.3 1479.8 21853.3 22426.7 22461.6 22653.1 22716.7 38807.4 38882.6 38938.4 39179.0 39183.6 195400.0 196157.0 196807.0 197318.0 198576.0 31797.2 31805.4 32154.7 32300.8 35155.5 40161.6 40249.0 42158.4 42179.6 44458.8 31565.4 32528.3 32636.3 32767.0 32799.3 31202.5 32075.4 32156.5 32251.7 32270.7 33145.5 35339.5 35427.0 35462.1 35479.5 30524.4 31081.5 31086.7 31408.7 31437.7 21455.0 22370.4 22447.8 22545.9 22688.8 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | [#2] jquery.html Cycles:180 Average:31588.29 Median:23252.71 stddev:75560.00 (325.0%) stddev-sans-first:75736.06 05:31:03 INFO - PID 3619 | Values: 565.8 573.0 575.5 578.5 593.9 21771.0 21776.8 22736.1 23067.4 23070.4 23761.4 24003.3 24176.4 24192.3 24324.4 6337.7 6492.3 6517.1 6521.3 6525.8 6408.3 6465.9 6480.7 6484.7 6487.2 6097.1 6114.6 6314.3 6382.1 6398.0 6311.1 6349.9 6363.1 6371.9 6376.3 5879.0 5910.8 5915.8 5936.2 5955.0 26722.5 28226.6 28528.9 28584.3 28760.1 1933.3 1975.9 1978.7 1987.6 1992.5 18153.4 18495.6 18646.6 18682.4 18682.5 2231.4 2277.5 2294.6 2297.2 2398.5 120067.4 123434.0 124243.0 124944.0 125096.4 14340.4 14490.2 14852.4 14883.3 15167.6 23206.8 23298.7 23331.4 23409.5 23515.8 9470.7 9792.0 9840.5 9973.4 9974.5 8868.9 8957.3 9025.2 9120.5 9131.4 8575.9 8802.5 8842.0 9042.4 9152.6 2580.8 2646.9 2687.2 2690.8 2752.1 949.3 957.2 959.0 981.3 996.7 19022.2 19298.6 19401.2 19489.7 19697.9 1001.9 1013.4 1029.3 1030.9 1037.4 10561.3 10798.6 10897.9 10937.7 11079.5 434555.0 443928.0 453474.0 460645.0 461412.0 97202.0 97628.5 99027.5 99773.5 100044.5 1142.6 1167.6 1177.8 1190.8 1192.2 16218.3 16777.2 17197.9 17244.7 17299.7 45516.5 47389.5 48164.5 48597.0 51104.5 60788.1 61039.4 61507.7 61679.4 61829.7 12239.8 12829.4 12835.4 13153.3 13172.2 18714.7 18825.6 18957.2 19045.5 19198.5 15394.5 15562.7 15624.5 15644.6 15801.8 13363.3 13857.9 13901.9 14371.9 14437.7 15814.9 15865.1 15928.1 16056.7 16059.5 13022.7 13080.0 13100.6 13125.3 13154.5 15609.4 15614.8 15729.5 15732.8 15789.3 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | [#3] mootools.html Cycles:180 Average:8103.52 Median:2445.08 stddev:5421.99 (221.8%) stddev-sans-first:5413.60 05:31:03 INFO - PID 3619 | Values: 1370.5 1416.9 1419.2 1425.8 1434.8 12991.9 13513.8 13568.5 13579.4 13628.5 13115.2 13509.4 13512.1 13558.5 13663.4 2575.3 2627.9 2627.9 2628.7 2636.3 2376.9 2451.5 2455.5 2455.6 2458.6 2376.3 2401.7 2410.3 2418.9 2423.0 2287.6 2332.2 2344.7 2370.5 2438.6 2390.9 2410.2 2420.7 2422.3 2430.1 13006.9 13253.2 13263.4 13275.5 13322.8 6891.1 7120.3 7127.1 7132.2 7176.7 4061.1 4231.0 4328.8 4340.8 4350.8 1590.0 1594.9 1611.3 1627.3 1656.9 19756.5 20417.1 20956.8 21290.3 21351.8 5549.3 5672.1 6100.6 6344.1 6367.9 14596.1 14710.3 14719.4 14720.7 14728.9 7122.0 7235.0 7259.2 7288.0 7330.9 6765.2 6860.1 6866.1 6888.0 6943.2 4795.1 4869.8 4886.9 5023.2 5024.5 1433.4 1450.6 1454.3 1457.0 1466.0 895.4 895.6 909.7 915.6 923.8 6988.0 7014.9 7106.0 7110.5 7149.2 727.0 727.2 739.6 744.1 745.6 4173.9 4573.8 4975.6 5073.2 5240.3 17035.9 17683.3 17756.6 17800.6 17856.5 15942.9 17716.7 17852.6 17872.4 17921.8 9355.4 10042.8 10080.5 10097.7 10271.5 7296.2 7454.1 7567.5 7648.7 7779.1 14484.2 14704.3 14876.0 14891.0 14952.2 15029.5 15189.2 15369.0 15403.0 15728.1 9771.8 9954.9 9963.0 9968.9 9970.5 12778.7 13387.8 13424.5 13434.3 13467.5 10112.8 10416.9 10612.9 10863.1 10869.9 9376.2 9885.3 9920.7 9940.8 10243.0 8858.7 9009.1 9030.9 9037.7 9043.1 6670.4 6997.9 7022.5 7023.0 7028.4 6936.3 7097.4 7208.0 7221.9 7253.8 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | [#4] prototype.html Cycles:180 Average:5540.52 Median:6142.42 stddev:1571.58 (25.6%) stddev-sans-first:1529.37 05:31:03 INFO - PID 3619 | Values: 478.2 481.9 483.2 509.8 511.1 6271.6 6299.9 6331.5 6341.8 6357.1 6008.0 6155.4 6176.8 6192.8 6199.8 4963.4 4971.3 4972.8 5011.2 5019.3 4946.8 4948.2 4960.0 4965.3 4993.0 4938.5 4943.7 4953.2 4958.7 4967.4 4724.7 4901.9 4937.9 4969.3 4981.0 4414.9 4425.4 4425.9 4441.4 4452.5 6017.9 6046.5 6053.5 6068.9 6129.5 5619.2 5624.5 5632.9 5642.7 5644.0 6576.4 6598.7 6606.8 6608.6 6619.7 4819.6 4825.9 4828.5 4836.3 4843.3 6892.8 6895.1 6904.4 6919.2 6968.9 4968.5 5001.3 5001.8 5008.8 5013.0 5044.9 5078.3 5087.4 5089.2 5093.9 5675.5 5682.4 5683.8 5684.7 5695.1 6668.7 6675.0 6675.8 6677.8 6684.2 1643.2 1754.6 1775.1 1780.2 1783.4 1205.7 1221.3 1232.0 1237.1 1241.0 5829.9 5866.2 5873.9 5896.8 5903.4 6568.6 6662.4 6702.6 6714.6 6788.2 5819.7 5841.7 5842.5 5844.8 5859.9 3588.4 3620.8 3624.7 3629.1 3640.6 6496.7 6553.9 6563.2 6588.0 6596.7 6858.2 6931.8 6942.1 6951.3 6976.3 6538.9 6579.3 6593.2 6646.7 6662.4 6751.8 6752.6 6784.3 6790.3 6794.2 6651.3 6695.9 6713.9 6760.9 6761.9 6646.9 6652.4 6657.2 6664.6 6679.8 4803.6 4924.3 4926.2 4935.8 4988.3 6612.4 6771.6 6795.3 6806.5 6819.9 6604.4 6608.4 6621.4 6624.4 6627.3 6502.3 6545.7 6593.7 6616.8 6626.9 6531.2 6533.4 6537.7 6552.6 6564.2 6652.9 6654.9 6657.6 6667.0 6672.0 6425.7 6450.9 6456.9 6466.4 6484.5 05:31:03 INFO - PID 3619 | 05:31:03 INFO - PID 3619 | [#5] yui.html Cycles:180 Average:20695.20 Median:20272.35 stddev:26733.02 (131.9%) stddev-sans-first:26766.47 05:31:03 INFO - PID 3619 | Values: 849.2 863.5 864.6 867.2 876.6 16410.5 16911.7 17422.8 17482.0 17565.2 17255.0 20215.0 20329.7 20352.4 20460.1 1031.6 1057.7 1060.0 1061.6 1062.7 1055.9 1056.3 1057.6 1057.8 1058.4 1026.8 1066.9 1071.7 1106.5 1111.1 1063.8 1064.2 1068.7 1069.1 1069.9 783.3 785.5 786.3 789.2 790.9 16960.4 17015.3 17031.7 17147.7 18122.1 18968.5 19217.4 19247.7 19290.7 19401.6 15903.9 15910.1 15916.3 15927.0 15985.0 3496.8 3619.3 3620.3 3643.0 3652.4 97038.0 99040.0 101450.5 101653.0 103296.5 15410.5 15465.0 15483.9 15645.7 15684.1 27336.0 27837.9 27927.4 28024.9 28062.6 7588.4 7769.7 7769.9 7799.5 7825.4 3887.8 3891.8 3935.2 3941.5 3951.5 4738.4 4781.9 4784.3 4879.3 4908.9 878.6 887.5 890.6 893.4 933.3 621.9 681.7 687.9 712.9 721.4 12780.9 12864.5 12979.7 13241.9 13536.6 660.6 694.2 698.0 700.8 728.9 5463.6 5483.9 5539.8 5561.2 5675.8 95038.5 95307.0 97019.5 98524.0 99690.0 83924.6 86986.6 87208.0 88535.0 88989.6 71836.0 75989.6 76233.0 76793.2 78207.0 10736.4 10806.4 10807.4 11007.4 11223.0 32628.3 33382.3 33752.0 34286.3 35369.6 41157.4 43583.3 44312.0 44889.6 45285.0 15552.4 17096.4 17257.0 18159.6 18451.4 19832.8 20433.8 20473.2 20662.2 21108.7 16129.6 16361.9 16372.5 16811.9 18967.5 17377.8 17516.6 17710.9 17732.6 18620.5 16962.6 18154.5 18238.8 18251.3 18309.5 12429.4 13026.7 13172.0 13320.6 13383.3 12095.0 12585.5 12650.8 12682.9 13389.6 05:31:03 INFO - PID 3619 | -------- Summary: end -------- 05:31:03 INFO - PID 3619 | 05:31:03 INFO - TEST-INFO | 3619: exit 0 05:31:03 INFO - TEST-OK | dromaeo_css | took 1120426ms 05:31:03 INFO - TEST-START | kraken 05:31:03 INFO - operating with platform_type : linux_ 05:31:03 INFO - Initialising browser for kraken test... 05:31:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35566/getInfo.html -profile /tmp/tmpgIYLvq/profile 05:31:03 INFO - TEST-INFO | started process 4024 (/builds/slave/test/build/application/firefox/firefox http://localhost:35566/getInfo.html) 05:31:10 INFO - TEST-INFO | 4024: exit 0 05:31:10 INFO - Browser initialized. 05:31:10 INFO - Running cycle 1/1 for kraken test... 05:31:10 INFO - TEST-INFO | started process 4226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgIYLvq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:21 INFO - PID 4226 | RSS: Main: 169025536 05:31:21 INFO - PID 4226 | 05:31:24 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35566/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:24 INFO - PID 4226 | RSS: Main: 173989888 05:31:24 INFO - PID 4226 | 05:31:27 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35566/tests/kraken/driver.html?testName=audio-dft) 05:31:28 INFO - PID 4226 | RSS: Main: 174477312 05:31:28 INFO - PID 4226 | 05:31:31 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35566/tests/kraken/driver.html?testName=audio-fft) 05:31:31 INFO - PID 4226 | RSS: Main: 169013248 05:31:31 INFO - PID 4226 | 05:31:33 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35566/tests/kraken/driver.html?testName=audio-oscillator) 05:31:34 INFO - PID 4226 | RSS: Main: 169668608 05:31:34 INFO - PID 4226 | 05:31:36 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35566/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:37 INFO - PID 4226 | RSS: Main: 169734144 05:31:37 INFO - PID 4226 | 05:31:40 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35566/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:40 INFO - PID 4226 | RSS: Main: 173330432 05:31:40 INFO - PID 4226 | 05:31:44 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35566/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:44 INFO - PID 4226 | RSS: Main: 174616576 05:31:44 INFO - PID 4226 | 05:31:47 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35566/tests/kraken/driver.html?testName=json-parse-financial) 05:31:48 INFO - PID 4226 | RSS: Main: 173486080 05:31:48 INFO - PID 4226 | 05:31:49 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35566/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:50 INFO - PID 4226 | RSS: Main: 173223936 05:31:50 INFO - PID 4226 | 05:31:52 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:52 INFO - PID 4226 | RSS: Main: 173703168 05:31:52 INFO - PID 4226 | 05:31:55 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:55 INFO - PID 4226 | RSS: Main: 173150208 05:31:55 INFO - PID 4226 | 05:31:58 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:59 INFO - PID 4226 | RSS: Main: 173506560 05:31:59 INFO - PID 4226 | 05:32:02 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:02 INFO - PID 4226 | RSS: Main: 173527040 05:32:02 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | Cycle 1(1): loaded http://localhost:35566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35566/tests/kraken/driver.html?testName=ai-astar) 05:32:04 INFO - PID 4226 | RSS: Main: 174501888 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | __start_tp_report 05:32:04 INFO - PID 4226 | _x_x_mozilla_page_load 05:32:04 INFO - PID 4226 | _x_x_mozilla_page_load_details 05:32:04 INFO - PID 4226 | |i|pagename|runs| 05:32:04 INFO - PID 4226 | |0;ai-astar;101;109;109;106;110;108;108;110;111;108 05:32:04 INFO - PID 4226 | |1;audio-beat-detection;150;119;150;177;127;152;149;120;172;121 05:32:04 INFO - PID 4226 | |2;audio-dft;164;161;161;161;163;167;161;167;165;169 05:32:04 INFO - PID 4226 | |3;audio-fft;74;75;76;159;76;74;74;74;101;74 05:32:04 INFO - PID 4226 | |4;audio-oscillator;81;82;137;82;82;82;128;82;82;136 05:32:04 INFO - PID 4226 | |5;imaging-gaussian-blur;114;113;113;115;114;113;114;114;113;114 05:32:04 INFO - PID 4226 | |6;imaging-darkroom;150;150;150;150;150;152;152;151;150;150 05:32:04 INFO - PID 4226 | |7;imaging-desaturate;94;94;94;94;94;94;93;94;95;94 05:32:04 INFO - PID 4226 | |8;json-parse-financial;55;55;55;56;55;55;57;54;54;55 05:32:04 INFO - PID 4226 | |9;json-stringify-tinderbox;54;54;54;53;53;54;54;53;54;53 05:32:04 INFO - PID 4226 | |10;stanford-crypto-aes;85;78;77;86;78;76;81;75;76;76 05:32:04 INFO - PID 4226 | |11;stanford-crypto-ccm;125;133;138;131;128;130;125;126;125;155 05:32:04 INFO - PID 4226 | |12;stanford-crypto-pbkdf2;182;188;188;184;181;185;195;179;181;185 05:32:04 INFO - PID 4226 | |13;stanford-crypto-sha256-iterative;68;68;67;67;66;67;69;65;69;67 05:32:04 INFO - PID 4226 | __end_tp_report 05:32:04 INFO - PID 4226 | __start_cc_report 05:32:04 INFO - PID 4226 | _x_x_mozilla_cycle_collect,944 05:32:04 INFO - PID 4226 | __end_cc_report 05:32:04 INFO - PID 4226 | __startTimestamp1498653124877__endTimestamp 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | ------- Summary: start ------- 05:32:04 INFO - PID 4226 | Number of tests: 14 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:2.83 (2.6%) stddev-sans-first:1.48 05:32:04 INFO - PID 4226 | Values: 101.0 109.0 109.0 106.0 110.0 108.0 108.0 110.0 111.0 108.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:150.00 stddev:21.22 (14.1%) stddev-sans-first:22.38 05:32:04 INFO - PID 4226 | Values: 150.0 119.0 150.0 177.0 127.0 152.0 149.0 120.0 172.0 121.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:3.00 (1.8%) stddev-sans-first:3.18 05:32:04 INFO - PID 4226 | Values: 164.0 161.0 161.0 161.0 163.0 167.0 161.0 167.0 165.0 169.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.00 stddev:27.07 (36.6%) stddev-sans-first:28.38 05:32:04 INFO - PID 4226 | Values: 74.0 75.0 76.0 159.0 76.0 74.0 74.0 74.0 101.0 74.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:82.00 stddev:25.14 (30.7%) stddev-sans-first:25.95 05:32:04 INFO - PID 4226 | Values: 81.0 82.0 137.0 82.0 82.0 82.0 128.0 82.0 82.0 136.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:32:04 INFO - PID 4226 | Values: 114.0 113.0 113.0 115.0 114.0 113.0 114.0 114.0 113.0 114.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:32:04 INFO - PID 4226 | Values: 150.0 150.0 150.0 150.0 150.0 152.0 152.0 151.0 150.0 150.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:32:04 INFO - PID 4226 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 05:32:04 INFO - PID 4226 | Values: 55.0 55.0 55.0 56.0 55.0 55.0 57.0 54.0 54.0 55.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 05:32:04 INFO - PID 4226 | Values: 54.0 54.0 54.0 53.0 53.0 54.0 54.0 53.0 54.0 53.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.91 (5.0%) stddev-sans-first:3.44 05:32:04 INFO - PID 4226 | Values: 85.0 78.0 77.0 86.0 78.0 76.0 81.0 75.0 76.0 76.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:130.50 stddev:9.24 (7.1%) stddev-sans-first:9.49 05:32:04 INFO - PID 4226 | Values: 125.0 133.0 138.0 131.0 128.0 130.0 125.0 126.0 125.0 155.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:185.00 stddev:4.66 (2.5%) stddev-sans-first:4.83 05:32:04 INFO - PID 4226 | Values: 182.0 188.0 188.0 184.0 181.0 185.0 195.0 179.0 181.0 185.0 05:32:04 INFO - PID 4226 | 05:32:04 INFO - PID 4226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.30 05:32:04 INFO - PID 4226 | Values: 68.0 68.0 67.0 67.0 66.0 67.0 69.0 65.0 69.0 67.0 05:32:04 INFO - PID 4226 | -------- Summary: end -------- 05:32:04 INFO - PID 4226 | 05:32:05 INFO - TEST-INFO | 4226: exit 0 05:32:05 INFO - TEST-OK | kraken | took 61988ms 05:32:05 INFO - SUITE-END | took 1182s 05:32:06 INFO - Completed test suite (00:19:42) 05:32:06 INFO - javascript benchmark 05:32:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8127.673816951255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.4955132403156, 3067.355855270393, 3084.583581216536, 3092.118746157345, 3104.8758049678013, 6014.699265036747, 6019.638821670703, 6036.0644100164545, 6095.847603809907, 6161.16824228729, 6124.869201255664, 6129.297663865963, 6133.969330153354, 6150.261968563767, 6156.569040167179, 5630.324361076677, 5643.830685079454, 5703.287089113861, 5708.1152421374545, 5758.9424105759035, 5686.004949133885, 5737.540996720273, 5767.480926716595, 5767.711614419283, 5773.740181691834, 5558.86102847428, 5647.632903861236, 5673.092305231185, 5690.829275121753, 5701.942980570183, 5557.499825015768, 5604.131359639263, 5639.0, 5645.294338207724, 5667.093265077609, 5643.294588176478, 5655.745491452894, 5674.205611214434, 5694.886102277973, 5700.657960522382, 5957.821265362046, 6091.634501929854, 6092.817215483543, 6112.052631842072, 6119.265688117454, 6559.6064236145985, 6577.845147393182, 6613.966930165367, 6630.9005364919085, 6631.204255489324, 6486.383793539606, 6587.604743715345, 6630.6684665767, 6631.900521492182, 6688.565243259172, 6139.2325959255095, 6143.082036032849, 6155.72299246535, 6162.568620196633, 6176.042713379434, 6581.177352830896, 6735.562188457735, 6762.154730658668, 6808.046873437723, 6815.625140617313, 6429.421352078241, 6447.806565803034, 6449.96775016122, 6455.0, 6464.741410343628, 6515.446187074057, 6562.671866406756, 6584.242812076577, 6594.109795177686, 6607.735690572419, 6525.836854078686, 6536.24833144185, 6538.673066346663, 6550.0829883816305, 6561.606303621798, 6459.547831651833, 6531.6081035137095, 6561.540692151503, 6573.0, 6573.441257493071, 5283.392409872914, 5299.814506492255, 5314.468553144655, 5353.812616558402, 5354.518093371537, 4520.660950428731, 4538.636909047268, 4560.0, 4602.907941841211, 4615.399998000238, 5686.118651609007, 5747.712614369265, 5761.798337058183, 5762.1068734346245, 5775.306963164363, 6575.934240657628, 6606.438452731475, 6612.933870661328, 6633.7346506140175, 6639.701213445406, 5639.689817060101, 5758.971205144031, 5785.276471380347, 5808.506276966421, 5843.3864444233595, 5702.2301989231755, 5738.053221218453, 5778.855528611818, 5795.391483894215, 5796.159556864315, 6421.454176395058, 6469.967650161719, 6484.1894763154605, 6486.286508483969, 6502.60984340941, 6663.833404164935, 6671.866562668816, 6679.799606011828, 6691.029800678777, 6707.262201157966, 6243.843903902439, 6498.480121590167, 6515.511336649675, 6516.543841931019, 6527.5757075789925, 6389.201349831271, 6393.680315984089, 6406.327335629691, 6490.448311893542, 6495.512836537184, 6631.502637302126, 6693.431058360094, 6705.195376554844, 6710.597364158166, 6728.8654226914205, 6460.709268083042, 6470.708818103102, 6476.902846457401, 6479.222493300834, 6483.870322593616, 6474.611523308617, 6475.384838440341, 6481.222253329631, 6490.0, 6495.480361570969, 6181.443670069715, 6291.150694656163, 6310.1796766420075, 6310.968445157745, 6315.5894866833505, 6335.429811317003, 6357.777477788441, 6431.774887878902, 6447.806565803034, 6450.129232553545, 6209.5032397409, 6213.813585592439, 6218.751249950133, 6227.878981783141, 6280.026595877646], "value": 6017.06758110536, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.8226825561864, 790.1940021178402, 822.2312138150828, 839.626366267011, 843.582426698784, 42028.94927626811, 43230.0, 43374.0, 43454.34818477721, 43491.34762978554, 38908.61091389085, 38950.4157437638, 39026.0, 39081.0, 39377.60622393775, 6888.448924086074, 7025.508214424993, 7040.084788977451, 7064.823379415504, 7066.116735408048, 6863.897041544381, 6944.270851560589, 6975.686094125751, 6975.755848545302, 7004.929950700504, 6962.825929351781, 6965.0, 6975.197852247005, 6978.406835418996, 6979.790606281819, 6925.342092501204, 6926.826829329257, 6943.826404339907, 6948.27043160471, 6975.686094125776, 6194.0, 6194.473469755077, 6214.161088253073, 6253.030780229072, 6256.343083976208, 34149.658503414896, 34295.14262143442, 34328.65671343279, 34491.65508344935, 34611.82694086513, 3385.1367901185286, 3425.0581090200144, 3427.0575591712477, 3560.181158333598, 3621.2214373909474, 31189.220269493446, 31254.37491250185, 31256.21859453509, 31320.0, 31339.529907051412, 3759.2105657811894, 3782.8865134045745, 3792.27946690128, 3804.0489877530617, 3827.8660246891227, 174325.0, 175428.0, 175991.0, 179299.0, 181302.0, 42095.7895210522, 50150.247746283836, 50172.74913625408, 50537.494625054016, 50752.746236268584, 52636.73681631644, 52667.209991850155, 52923.47076529262, 53040.73479632654, 53187.0, 15730.606734831721, 15885.920570397306, 15926.28331725075, 15926.442574510069, 15944.521664350088, 12959.935200323938, 12973.740525189443, 13010.089293749535, 13013.089083764235, 13014.739705205842, 14954.177520236492, 14984.400623975136, 15005.24973751308, 15098.169600671848, 15208.08751474915, 5704.572157088235, 5808.419158084243, 5863.560232982543, 5954.642721436728, 5966.224390829165, 950.705281362766, 988.8566157907063, 1013.9340942838692, 1017.1303535477208, 1021.4983973558857, 22707.88646056759, 23029.309120726404, 23035.07859685594, 23078.884605576866, 23134.8843255786, 1048.3866937841296, 1089.6186334782922, 1100.7523307255804, 1101.6034227678028, 1119.2651390344934, 11810.350430726392, 12061.638150855488, 12367.567135150226, 12448.75102497945, 12553.309567973667, 223272.76727232843, 224950.0, 225097.0, 225792.0, 225950.0, 55445.44554554483, 56226.0, 56235.43764562302, 56255.43744562502, 56656.15015774767, 1405.9226742529258, 1456.6358410397402, 1458.1688437590471, 1474.336548553134, 1479.8002269693454, 21853.344399668036, 22426.66360004634, 22461.550768984856, 22653.093876244766, 22716.65925011093, 38807.41788873113, 38882.6111738879, 38938.4159237606, 39179.0, 39183.608163918, 195400.0, 196157.0, 196807.0, 197318.0, 198576.0, 31797.20506987344, 31805.36389272248, 32154.67845321517, 32300.83849580737, 35155.472667910515, 40161.59838401696, 40249.0, 42158.36762448504, 42179.57820421756, 44458.777706111265, 31565.368692626478, 32528.34943301168, 32636.347273054882, 32767.0, 32799.344013120084, 31202.531962020134, 32075.35849283048, 32156.51765223477, 32251.677483225805, 32270.677293226767, 33145.50281745824, 35339.46990795191, 35427.0, 35462.113447164025, 35479.46780798342, 30524.389512210077, 31081.53377699291, 31086.68913310838, 31408.685913140576, 31437.68562314439, 21455.0, 22370.440738981655, 22447.77552224457, 22545.8872705642, 22688.773112269326], "value": 16573.60311109538, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7821738630626, 572.9656220626761, 575.516566084489, 578.5053779018939, 593.8841925824464, 21771.0, 21776.782232177673, 22736.06743426811, 23067.42331441715, 23070.423239419, 23761.40596485089, 24003.279901602935, 24176.395590110213, 24192.27423177303, 24324.39189020271, 6337.683115844213, 6492.285848556655, 6517.055027021079, 6521.282658907517, 6525.8042258732075, 6408.263049749268, 6465.8706825863455, 6480.675966201671, 6484.675766211694, 6487.156669632941, 6097.115918191859, 6114.633122012693, 6314.305426403092, 6382.106505089291, 6398.0, 6311.116443697886, 6349.936500635027, 6363.077353783722, 6371.87256254877, 6376.330485299047, 5879.029960056586, 5910.763569457216, 5915.822525324247, 5936.198613187207, 5954.970225148846, 26722.465550688878, 28226.576601350996, 28528.857355713295, 28584.28539286514, 28760.137195884156, 1933.2750218668, 1975.940721778349, 1978.6933025381088, 1987.5925435285876, 1992.471994921347, 18153.364632237808, 18495.612829037742, 18646.62706745871, 18682.439526814218, 18682.532936676555, 2231.419830843976, 2277.5103352779233, 2294.644330128816, 2297.1959814065112, 2398.5322862041908, 120067.39966300112, 123434.0, 124243.0, 124944.0, 125096.37451812773, 14340.354684039243, 14490.203038832966, 14852.405903763945, 14883.33025013877, 15167.620809479631, 23206.7679323208, 23298.65052024221, 23331.416714582272, 23409.531809363718, 23515.7648423517, 9470.715878523655, 9791.951040244754, 9840.507974601385, 9973.401595904124, 9974.501274936225, 8868.8669669955, 8957.283417326598, 9025.187733104052, 9120.45277283365, 9131.360804743605, 8575.871361929576, 8802.515861627544, 8841.955790221007, 9042.412243204302, 9152.63389464414, 2580.832245904048, 2646.8808903599383, 2687.2341382705836, 2690.838549687025, 2752.0918097027934, 949.2595775295281, 957.2389949989774, 958.9760255993656, 981.3425005246502, 996.6661168508631, 19022.239110435705, 19298.614027719366, 19401.2239510418, 19489.707654385194, 19697.901510492644, 1001.8797744270735, 1013.3869009249298, 1029.3016522737544, 1030.896910308963, 1037.4242295526055, 10561.313514621525, 10798.622048228432, 10897.891021089847, 10937.726556835984, 11079.50142243601, 434555.0, 443928.0, 453474.0, 460645.0, 461412.0, 97202.0, 97628.51185744026, 99027.50486247666, 99773.50113249387, 100044.49977750065, 1142.6349401013933, 1167.5580657887333, 1177.776222517719, 1190.7797057544383, 1192.1654841610907, 16218.270177842262, 16777.245023973708, 17197.914010429868, 17244.741328879827, 17299.7405038922, 45516.54483455256, 47389.526104738514, 48164.5183548174, 48597.0, 51104.48895511146, 60788.08817867824, 61039.389606103374, 61507.69246153741, 61679.38320616737, 61829.69085154725, 12239.75520489603, 12829.422675979416, 12835.35823208817, 13153.342332883509, 13172.209667419986, 18714.719279211095, 18825.623487529898, 18957.241710331433, 19045.523861903563, 19198.520036999187, 15394.461193858162, 15562.688746225238, 15624.453144139901, 15644.608884777515, 15801.762973555176, 13363.331833408096, 13857.861421385656, 13901.930490347484, 14371.85628143747, 14437.711245775236, 15814.9209253953, 15865.127417992122, 15928.123953182687, 16056.67886642284, 16059.518214453585, 13022.739545209231, 13080.0, 13100.60698179056, 13125.343732813511, 13154.539591114266, 15609.375624974873, 15614.843851561793, 15729.528114156594, 15732.842671573138, 15789.289481973108], "value": 11216.433658280663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.5271681269962, 1416.8512306207847, 1419.1768774111017, 1425.809449109993, 1434.7847822826577, 12991.935040324797, 13513.797293040612, 13568.525101621433, 13579.388927498274, 13628.454861805541, 13115.21308721475, 13509.392077356519, 13512.05415620907, 13558.457661693521, 13663.385147668354, 2575.317540851676, 2627.8948842046293, 2627.934301642455, 2628.6714160729907, 2636.288202185409, 2376.9049238030457, 2451.534208500379, 2455.5211733711935, 2455.6439316299125, 2458.5820410530164, 2376.263358358914, 2401.711794584652, 2410.337157281744, 2418.8790560471994, 2422.970237648992, 2287.5882341178663, 2332.242021343062, 2344.7069116360453, 2370.5140446208484, 2438.634204869266, 2390.940226494334, 2410.2287268074224, 2420.697412823397, 2422.321749910028, 2430.1008626808193, 13006.934965325112, 13253.204807711472, 13263.403146858414, 13275.535356262484, 13322.800157997637, 6891.104156459678, 7120.28797120289, 7127.10911136108, 7132.215456299803, 7176.712931482734, 4061.1471590965934, 4230.978845105755, 4328.826846926119, 4340.8480703175555, 4350.847720329805, 1589.9841001589953, 1594.920253987296, 1611.3071379306894, 1627.2839950421776, 1656.8508834204858, 19756.50608734779, 20417.081231344626, 20956.79043209579, 21290.25484108049, 21351.786482135292, 5549.250851135126, 5672.14917762339, 6100.572959892765, 6344.111824344595, 6367.94928836746, 14596.12423254608, 14710.264486775832, 14719.411223551153, 14720.705585888223, 14728.852711472962, 7122.0, 7235.0, 7259.237780033126, 7287.963560182166, 7330.926690733131, 6765.221999470025, 6860.0738900248825, 6866.073080134218, 6888.0, 6943.201531823804, 4795.112904112751, 4869.780859861315, 4886.902261954741, 5023.2214006829, 5024.547790698854, 1433.426629348269, 1450.6083357493417, 1454.316471258507, 1456.9635759105895, 1466.003117879852, 895.4090300401704, 895.6372669069037, 909.6543313540944, 915.6108653822099, 923.8013827027221, 6987.965060174666, 7014.859702805916, 7106.0, 7110.537815042006, 7149.249328820399, 726.9963650181716, 727.2291371146601, 739.5525706947219, 744.1107876088131, 745.5973774162001, 4173.937390939138, 4573.794179261875, 4975.577075948585, 5073.162928116893, 5240.34495688039, 17035.91482042582, 17683.292668293383, 17756.55608609769, 17800.643987120184, 17856.46430607084, 15942.920285398499, 17716.734248986275, 17852.642947141245, 17872.374466893856, 17921.820781792016, 9355.4386736796, 10042.799144017079, 10080.495975201356, 10097.697069087939, 10271.537780799881, 7296.160941491797, 7454.105507339154, 7567.508111972704, 7648.65581048843, 7779.066512018594, 14484.203368814817, 14704.264786760405, 14876.0, 14891.0, 14952.177630230442, 15029.473968411054, 15189.16459594733, 15369.0, 15403.0, 15728.134952577719, 9771.755706107404, 9954.900450995687, 9963.003699629979, 9968.850467243143, 9970.451625160686, 12778.680532986378, 13387.799183012457, 13424.530141445002, 13434.328283585977, 13467.528636497676, 10112.84830727525, 10416.895831041593, 10612.8938710615, 10863.076638485501, 10869.945650271698, 9376.156145946898, 9885.258605604464, 9920.702378928643, 9940.751481212737, 10243.0, 8858.689945851864, 9009.099090090938, 9030.864537032081, 9037.68368107113, 9043.140901614335, 6670.366315200048, 6997.895031574429, 7022.473314501331, 7022.964885175541, 7028.367446929801, 6936.2976131751875, 7097.361237488651, 7207.9639601801655, 7221.927780722336, 7253.782386528413], "value": 5934.610757384222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.15128147538115, 481.90602832447667, 483.181008191116, 509.8444974282842, 511.0698528677806, 6271.560990730645, 6299.905501417476, 6331.493480521559, 6341.80974570763, 6357.078223657579, 6007.987324246372, 6155.353687862777, 6176.84557886052, 6192.81421557354, 6199.783007594735, 4963.35476388069, 4971.279164521142, 4972.751362431882, 5011.248312753098, 5019.347484826967, 4946.826861059863, 4948.15881300178, 4959.950400495985, 4965.28003439501, 4993.0, 4938.456769755324, 4943.703377797344, 4953.182724850395, 4958.67768595042, 4967.354243948282, 4724.692894961817, 4901.926471102936, 4937.876553086202, 4969.254611808222, 4981.0, 4414.889627759299, 4425.36261583213, 4425.889352766175, 4441.400410944513, 4452.510223875371, 6017.879642407127, 6046.516278697693, 6053.4551890330085, 6068.937935861207, 6129.478994285491, 5619.157126431027, 5624.521915637176, 5632.9436705632825, 5642.717864106819, 5643.971780141114, 6576.375244351779, 6598.746238214771, 6606.834829129262, 6608.605277490463, 6619.735210591571, 4819.614430845524, 4825.9034819303415, 4828.46886842447, 4836.274558816171, 4843.346148269974, 6892.758753443605, 6895.103636527269, 6904.4131248843905, 6919.238883722786, 6968.930310696929, 4968.478309777422, 5001.349824522788, 5001.8499445016705, 5008.84973450797, 5012.992204677237, 5044.9495505045215, 5078.263651770547, 5087.440381558025, 5089.211172268304, 5093.923591146136, 5675.474413885781, 5682.374938756733, 5683.801066962719, 5684.687342196219, 5695.145728140812, 6668.66626674667, 6674.965380366051, 6675.833104172434, 6677.833054173684, 6684.231313398924, 1643.2112585958807, 1754.6402987387555, 1775.0858307971405, 1780.2256018631936, 1783.4382169616529, 1205.6503613951857, 1221.3343727668441, 1231.96920076997, 1237.0845574274972, 1241.0, 5829.88340233193, 5866.23738913947, 5873.914760260046, 5896.786251492947, 5903.3801450847905, 6568.573042752301, 6662.400383965466, 6702.564333318319, 6714.630695311805, 6788.2193547742645, 5819.679917604572, 5841.707914604252, 5842.532597392198, 5844.824655260349, 5859.912101318484, 3588.3540962626457, 3620.837062332201, 3624.7462677612843, 3629.1471504196493, 3640.6177351378255, 6496.707648155844, 6553.868922621617, 6563.212414510289, 6587.967060164764, 6596.670166491656, 6858.177018757781, 6931.792046238621, 6942.132233470817, 6951.3396227359335, 6976.302369763084, 6538.934610653832, 6579.30917253691, 6593.175853018372, 6646.734130634817, 6662.367075127855, 6751.831204219934, 6752.594844309161, 6784.321567843176, 6790.287019863041, 6794.150731158606, 6651.33486651331, 6695.933040669531, 6713.932860671331, 6760.932390676227, 6761.864762704817, 6646.9002964956535, 6652.434543063894, 6657.241486114379, 6664.600123992576, 6679.799606011828, 4803.567678908915, 4924.285978533021, 4926.211806111005, 4935.8025678972435, 4988.301637770787, 6612.371824676648, 6771.559848609824, 6795.286494917962, 6806.549642128731, 6819.863602728017, 6604.438622717123, 6608.43828274602, 6621.437177839937, 6624.436922861418, 6627.304133065959, 6502.252240992158, 6545.738170473128, 6593.703283352164, 6616.801495955129, 6626.867462650624, 6531.183602049744, 6533.444657204001, 6537.673116344069, 6552.57408268461, 6564.179477565304, 6652.910523449662, 6654.933450665431, 6657.633830139195, 6666.966665166643, 6671.966640166768, 6425.742970281136, 6450.903236451551, 6456.903146452713, 6466.418022378009, 6484.546081774419], "value": 5072.787613642887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.193266396923, 863.4646519158123, 864.6238886084552, 867.2151702709051, 876.62743334083, 16410.507684769447, 16911.661766764657, 17422.82577174228, 17482.038487883176, 17565.20956556955, 17255.0, 20214.999999999964, 20329.695054574193, 20352.389428317176, 20460.07929643166, 1031.6440827914375, 1057.735566108473, 1059.9947000264988, 1061.6337363609543, 1062.7290041039523, 1055.9102476289524, 1056.3345092591655, 1057.6139709006234, 1057.8360354145082, 1058.4231593781408, 1026.8408396698487, 1066.8506409102731, 1071.6677829872726, 1106.5131342209402, 1111.1222134513725, 1063.7766069125494, 1064.2018486135398, 1068.6526878764355, 1069.1393428290223, 1069.9465026748671, 783.3459061683501, 785.5404588315843, 786.3473317146754, 789.2423273657296, 790.9406794490378, 16960.406385776438, 17015.31938722462, 17031.744523832152, 17147.74278385825, 18122.09389530518, 18968.5257868553, 19217.423477295702, 19247.711284330748, 19290.71063934042, 19401.611967760567, 15903.920480397639, 15910.124943128123, 15916.283767230503, 15927.044377337397, 15985.040897546069, 3496.7901925884275, 3619.330423871566, 3620.25784714133, 3643.0163855758797, 3652.397354436515, 97038.0, 99040.0, 101450.49274753653, 101653.0, 103296.48351758193, 15410.537683869501, 15465.0, 15483.922580387027, 15645.687086258438, 15684.137372444397, 27336.0, 27837.860810695816, 27927.441451171268, 28024.8598757009, 28062.579061314096, 7588.354989825927, 7769.650365733555, 7769.922300777033, 7799.493032952953, 7825.413094017971, 3887.8056097195026, 3891.8248678809523, 3935.1932853765484, 3941.467901833273, 3951.545572259227, 4738.431388233434, 4781.904361912742, 4784.2823576463115, 4879.2925025871045, 4908.8772780680765, 878.5563290538237, 887.5473508510706, 890.6481939633809, 893.41927746965, 933.2580598424133, 621.8880601491685, 681.7443458702986, 687.9174499060044, 712.8966299886488, 721.4336745654635, 12780.948002758203, 12864.48542058326, 12979.675508112372, 13241.867581324255, 13536.59390218295, 660.6498555765452, 694.2467422846167, 698.0332239847847, 700.7687463137255, 728.9161746399232, 5463.580293155605, 5483.862903427446, 5539.806106786243, 5561.193626924073, 5675.829725108253, 95038.5248073769, 95307.04865936452, 97019.51490242504, 98524.0, 99690.0, 83924.58037709894, 86986.56506717553, 87208.0, 88535.0, 88989.55505222433, 71836.0, 75989.62005189939, 76233.0, 76793.2320676786, 78207.0, 10736.355818650905, 10806.35161890289, 10807.35155890649, 11007.449627518752, 11222.989930906258, 32628.34743305073, 33382.33235335328, 33752.0, 34286.31427371489, 35369.64630353663, 41157.382639261035, 43583.34624980565, 44312.0, 44889.551104488535, 45285.0, 15552.377904883679, 17096.40162594353, 17257.0, 18159.636807264043, 18451.44645660632, 19832.801671983674, 20433.79566204319, 20473.181072756925, 20662.17351305991, 21108.683369749775, 16129.596760081093, 16361.873925730617, 16372.508824735278, 16811.91594042022, 18967.525811854262, 17377.82622173762, 17516.562085947953, 17710.91144544269, 17732.645347092726, 18620.534486637942, 16962.575935601708, 18154.455366339032, 18238.817611824245, 18251.269949201884, 18309.54226144357, 12429.378531073591, 13026.674333141747, 13172.0, 13320.600381988555, 13383.263920484078, 12095.0, 12585.496580136693, 12650.810237846255, 12682.873171268538, 13389.598312050653], "value": 8560.044914659142, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 106.0, 110.0, 108.0, 108.0, 110.0, 111.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 150.0, 177.0, 127.0, 152.0, 149.0, 120.0, 172.0, 121.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 161.0, 163.0, 167.0, 161.0, 167.0, 165.0, 169.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 159.0, 76.0, 74.0, 74.0, 74.0, 101.0, 74.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 137.0, 82.0, 82.0, 82.0, 128.0, 82.0, 82.0, 136.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 150.0, 150.0, 152.0, 152.0, 151.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 57.0, 54.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 77.0, 86.0, 78.0, 76.0, 81.0, 75.0, 76.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 138.0, 131.0, 128.0, 130.0, 125.0, 126.0, 125.0, 155.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 188.0, 188.0, 184.0, 181.0, 185.0, 195.0, 179.0, 181.0, 185.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 66.0, 67.0, 69.0, 65.0, 69.0, 67.0], "value": 67.3, "unit": "score"}]}]} 05:32:06 INFO - Return code: 0 05:32:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:32:06 INFO - # TBPL SUCCESS # 05:32:06 INFO - Running post-action listener: _resource_record_post_action 05:32:06 INFO - [mozharness: 2017-06-28 12:32:06.240411Z] Finished run-tests step (success) 05:32:06 INFO - Running post-run listener: _resource_record_post_run 05:32:06 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 5763072; Write bytes: 441126912; Read time: 4812; Write time: 812296 05:32:06 INFO - TinderboxPrint: CPU usage
13.1% 05:32:06 INFO - TinderboxPrint: I/O read bytes / time
5,763,072 / 4,812 05:32:06 INFO - TinderboxPrint: I/O write bytes / time
441,126,912 / 812,296 05:32:06 INFO - TinderboxPrint: CPU idle
8,340.4 (86.9%) 05:32:06 INFO - TinderboxPrint: CPU user
1,202.0 (12.5%) 05:32:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:32:06 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 8192; Write bytes: 142151680; Read time: 128; Write time: 248208 05:32:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:32:06 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4005888; Write bytes: 265945088; Read time: 3696; Write time: 504216 05:32:06 INFO - Running post-run listener: _upload_blobber_files 05:32:06 INFO - Blob upload gear active. 05:32:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:06 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 05:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:32:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:08 INFO - (blobuploader) - INFO - Done attempting. 05:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:11 INFO - (blobuploader) - INFO - Done attempting. 05:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:12 INFO - (blobuploader) - INFO - Done attempting. 05:32:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:32:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:32:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:13 INFO - (blobuploader) - INFO - Done attempting. 05:32:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:13 INFO - Return code: 0 05:32:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fd1ec7e54211397363eb3413e373cc716b100eb30e3e1f4db73e944c906b078be0ae2c3fafe644667b8e980f4f6597646d792e4122b77fefc6e143200f419e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/957857c9f90fd6a3c45e59542abedc20291a8d2d2803d2899e471922f719b5012a56df575737ce7f4db1a10cf417ae01521332b6bf9a47a367f91dd97948bb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467564d1a1f9977b54013f4b5c2e6676d19cc65ee6ddad47e60c2ca3b5af5bfaca413d305b91eed0be62336b1a135f0f801b6edc029cce405ab429a44f34718e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b8d532f9f90a1147f10c70afbbf2a973419b66acf473e7decb9f45d3b6c24fabe37899c8f9a09145b376fb4181d95123b74168c85018df7389505c449661cd5"} 05:32:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:13 INFO - Contents: 05:32:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fd1ec7e54211397363eb3413e373cc716b100eb30e3e1f4db73e944c906b078be0ae2c3fafe644667b8e980f4f6597646d792e4122b77fefc6e143200f419e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/957857c9f90fd6a3c45e59542abedc20291a8d2d2803d2899e471922f719b5012a56df575737ce7f4db1a10cf417ae01521332b6bf9a47a367f91dd97948bb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467564d1a1f9977b54013f4b5c2e6676d19cc65ee6ddad47e60c2ca3b5af5bfaca413d305b91eed0be62336b1a135f0f801b6edc029cce405ab429a44f34718e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b8d532f9f90a1147f10c70afbbf2a973419b66acf473e7decb9f45d3b6c24fabe37899c8f9a09145b376fb4181d95123b74168c85018df7389505c449661cd5"} 05:32:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:13 INFO - Copying logs to upload dir... 05:32:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.150952 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-06-28 05:32:12.891602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-28 05:32:12.896609) ========= 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=8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fd1ec7e54211397363eb3413e373cc716b100eb30e3e1f4db73e944c906b078be0ae2c3fafe644667b8e980f4f6597646d792e4122b77fefc6e143200f419e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/957857c9f90fd6a3c45e59542abedc20291a8d2d2803d2899e471922f719b5012a56df575737ce7f4db1a10cf417ae01521332b6bf9a47a367f91dd97948bb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467564d1a1f9977b54013f4b5c2e6676d19cc65ee6ddad47e60c2ca3b5af5bfaca413d305b91eed0be62336b1a135f0f801b6edc029cce405ab429a44f34718e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b8d532f9f90a1147f10c70afbbf2a973419b66acf473e7decb9f45d3b6c24fabe37899c8f9a09145b376fb4181d95123b74168c85018df7389505c449661cd5"} build_url:https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/ZhqIuEZ8TJWME0-iPOMIzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7fd1ec7e54211397363eb3413e373cc716b100eb30e3e1f4db73e944c906b078be0ae2c3fafe644667b8e980f4f6597646d792e4122b77fefc6e143200f419e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/957857c9f90fd6a3c45e59542abedc20291a8d2d2803d2899e471922f719b5012a56df575737ce7f4db1a10cf417ae01521332b6bf9a47a367f91dd97948bb42", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467564d1a1f9977b54013f4b5c2e6676d19cc65ee6ddad47e60c2ca3b5af5bfaca413d305b91eed0be62336b1a135f0f801b6edc029cce405ab429a44f34718e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b8d532f9f90a1147f10c70afbbf2a973419b66acf473e7decb9f45d3b6c24fabe37899c8f9a09145b376fb4181d95123b74168c85018df7389505c449661cd5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-28 05:32:12.923482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:32:12.923832) ========= 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=8783db0840cc980e80bb0bd400000236-1498635005.80052-1549131709 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 05:32:13.003023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-28 05:32:13.006399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-28 05:32:13.006720) ========= ========= Total master_lag: 0.30 =========