builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1502012763.03 results: success (0) revision: b34cf908546b9f37f5d1b100e67dc8ef814fca7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.033954) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.034461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.034744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.074184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.077580) ========= 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=0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 02:46:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2017-08-06 02:46:03 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.261020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.261308) ========= 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=0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019027 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.320176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:03.320500) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b34cf908546b9f37f5d1b100e67dc8ef814fca7a --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 b34cf908546b9f37f5d1b100e67dc8ef814fca7a --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=0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 02:46:03,722 truncating revision to first 12 chars 2017-08-06 02:46:03,722 Setting DEBUG logging. 2017-08-06 02:46:03,722 attempt 1/10 2017-08-06 02:46:03,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b34cf908546b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 02:46:04,173 unpacking tar archive at: mozilla-central-b34cf908546b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.847672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:04.181284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:04.184612) ========= script_repo_revision: b34cf908546b9f37f5d1b100e67dc8ef814fca7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:04.184980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:04.185237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 02:46:04.194395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-06 02:46:04.194673) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:46:04 INFO - MultiFileLogger online at 20170806 02:46:04 in /builds/slave/test 02:46:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:46:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:46:04 INFO - {'append_to_log': False, 02:46:04 INFO - 'base_work_dir': '/builds/slave/test', 02:46:04 INFO - 'blob_upload_branch': 'Firefox', 02:46:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:46:04 INFO - 'branch': 'Firefox', 02:46:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:46:04 INFO - 'code_coverage': False, 02:46:04 INFO - 'config_files': ('talos/linux_config.py',), 02:46:04 INFO - 'default_actions': ('clobber', 02:46:04 INFO - 'read-buildbot-config', 02:46:04 INFO - 'download-and-extract', 02:46:04 INFO - 'populate-webroot', 02:46:04 INFO - 'create-virtualenv', 02:46:04 INFO - 'install', 02:46:04 INFO - 'setup-mitmproxy', 02:46:04 INFO - 'run-tests'), 02:46:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:46:04 INFO - 'disable_ccov_upload': False, 02:46:04 INFO - 'download_minidump_stackwalk': True, 02:46:04 INFO - 'download_symbols': 'ondemand', 02:46:04 INFO - 'enable_stylo': False, 02:46:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:46:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:46:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:46:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:46:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:46:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:46:04 INFO - 'gecko_profile': False, 02:46:04 INFO - 'gecko_profile_interval': 0, 02:46:04 INFO - 'installer_path': 'installer.exe', 02:46:04 INFO - 'log_level': 'info', 02:46:04 INFO - 'log_name': 'talos', 02:46:04 INFO - 'log_to_console': True, 02:46:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:46:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:46:04 INFO - 'opt_config_files': (), 02:46:04 INFO - 'pip_index': False, 02:46:04 INFO - 'suite': 'dromaeojs-e10s', 02:46:04 INFO - 'system_bits': '32', 02:46:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:46:04 INFO - 'title': 'talos-linux64-ix-017', 02:46:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:46:04 INFO - 'use_talos_json': True, 02:46:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:46:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:46:04 INFO - 'work_dir': 'build'} 02:46:04 INFO - [mozharness: 2017-08-06 09:46:04.784944Z] Running clobber step. 02:46:04 INFO - Running pre-action listener: _resource_record_pre_action 02:46:04 INFO - Running main action method: clobber 02:46:04 INFO - rmtree: /builds/slave/test/build 02:46:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:46:05 INFO - Running post-action listener: _resource_record_post_action 02:46:05 INFO - [mozharness: 2017-08-06 09:46:05.753665Z] Finished clobber step (success) 02:46:05 INFO - [mozharness: 2017-08-06 09:46:05.753768Z] Running read-buildbot-config step. 02:46:05 INFO - Running pre-action listener: _resource_record_pre_action 02:46:05 INFO - Running main action method: read_buildbot_config 02:46:05 INFO - Using buildbot properties: 02:46:05 INFO - { 02:46:05 INFO - "project": "", 02:46:05 INFO - "product": "firefox", 02:46:05 INFO - "who": "archaeopteryx@coole-files.de", 02:46:05 INFO - "installer_path": "public/build/target.tar.bz2", 02:46:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:46:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:46:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:46:05 INFO - "stage_platform": "linux64-stylo", 02:46:05 INFO - "basedir": "/builds/slave/test", 02:46:05 INFO - "buildnumber": 16, 02:46:05 INFO - "platform": "ubuntu64_hw_stylo", 02:46:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:46:05 INFO - "slavebuilddir": "test", 02:46:05 INFO - "taskId": "VHygQu8gQcWGQhH_IZvOzg", 02:46:05 INFO - "branch": "mozilla-central", 02:46:05 INFO - "script_repo_revision": "production", 02:46:05 INFO - "revision": "b34cf908546b9f37f5d1b100e67dc8ef814fca7a", 02:46:05 INFO - "slavename": "talos-linux64-ix-017", 02:46:05 INFO - "repo_path": "mozilla-central" 02:46:05 INFO - } 02:46:05 INFO - Finding installer, test and symbols from parent task. 02:46:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VHygQu8gQcWGQhH_IZvOzg'}, attempt #1 02:46:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VHygQu8gQcWGQhH_IZvOzg'}, attempt #1 02:46:06 INFO - Task dependencies: HGTfaUZKSw63N3VOwyJcJQ 02:46:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ'}, attempt #1 02:46:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2 02:46:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.test_packages.json 02:46:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.crashreporter-symbols.zip 02:46:07 INFO - Running post-action listener: _resource_record_post_action 02:46:07 INFO - [mozharness: 2017-08-06 09:46:07.105465Z] Finished read-buildbot-config step (success) 02:46:07 INFO - [mozharness: 2017-08-06 09:46:07.105686Z] Running download-and-extract step. 02:46:07 INFO - Running pre-action listener: _resource_record_pre_action 02:46:07 INFO - Running main action method: download_and_extract 02:46:07 INFO - mkdir: /builds/slave/test/build/tests 02:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:07 INFO - trying https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.test_packages.json 02:46:07 INFO - Downloading https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:46:07 INFO - Downloaded 989 bytes. 02:46:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:46:07 INFO - Using the following test package requirements: 02:46:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:46:07 INFO - u'common': [u'target.common.tests.zip'], 02:46:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:46:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:46:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:46:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:46:07 INFO - u'mozbase': [u'target.common.tests.zip'], 02:46:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:46:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:46:07 INFO - u'web-platform': [u'target.common.tests.zip', 02:46:07 INFO - u'target.web-platform.tests.tar.gz'], 02:46:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:46:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:46:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.common.tests.zip 02:46:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:46:07 INFO - Fetch https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.common.tests.zip into memory 02:46:08 INFO - Content-Length response header: 54284903 02:46:08 INFO - Bytes received: 54284903 02:46:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:46:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.common.tests.zip 02:46:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:46:20 INFO - Fetch https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.common.tests.zip into memory 02:46:21 INFO - Content-Length response header: 54284903 02:46:21 INFO - Bytes received: 54284903 02:46:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.talos.tests.zip 02:46:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:46:33 INFO - Fetch https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.talos.tests.zip into memory 02:46:34 INFO - Content-Length response header: 14496008 02:46:34 INFO - Bytes received: 14496008 02:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:34 INFO - trying https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2 02:46:34 INFO - Downloading https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:46:35 INFO - Downloaded 61942977 bytes. 02:46:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2 02:46:35 INFO - mkdir: /builds/slave/test/properties 02:46:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:35 INFO - Contents: 02:46:35 INFO - build_url:https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2 02:46:35 INFO - Running post-action listener: _resource_record_post_action 02:46:35 INFO - Running post-action listener: set_extra_try_arguments 02:46:35 INFO - [mozharness: 2017-08-06 09:46:35.764581Z] Finished download-and-extract step (success) 02:46:35 INFO - [mozharness: 2017-08-06 09:46:35.764680Z] Running populate-webroot step. 02:46:35 INFO - Running pre-action listener: _resource_record_pre_action 02:46:35 INFO - Running main action method: populate_webroot 02:46:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:35 INFO - 'tests': ['damp', 'tps']}, 02:46:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:46:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:46:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:46:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:35 INFO - 'ts_paint', 02:46:35 INFO - 'tpaint', 02:46:35 INFO - 'sessionrestore', 02:46:35 INFO - 'sessionrestore_many_windows', 02:46:35 INFO - 'sessionrestore_no_auto_restore', 02:46:35 INFO - 'tabpaint']}, 02:46:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:46:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:46:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:35 INFO - 'tsvgr_opacity', 02:46:35 INFO - 'tart', 02:46:35 INFO - 'tscrollx', 02:46:35 INFO - 'tsvg_static']}, 02:46:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:35 INFO - 'talos_options': ['--mitmproxy', 02:46:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:35 INFO - '--firstNonBlankPaint'], 02:46:35 INFO - 'tests': ['tp6_google', 02:46:35 INFO - 'tp6_youtube', 02:46:35 INFO - 'tp6_amazon', 02:46:35 INFO - 'tp6_facebook']}, 02:46:35 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:35 INFO - 'talos_options': ['--stylo', 02:46:35 INFO - '--mitmproxy', 02:46:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:35 INFO - '--firstNonBlankPaint'], 02:46:35 INFO - 'tests': ['tp6_google', 02:46:35 INFO - 'tp6_youtube', 02:46:35 INFO - 'tp6_amazon', 02:46:35 INFO - 'tp6_facebook']}, 02:46:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:46:35 INFO - 'talos_options': ['--stylo', 02:46:35 INFO - '--stylo-threads=1', 02:46:35 INFO - '--mitmproxy', 02:46:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:46:35 INFO - '--firstNonBlankPaint'], 02:46:35 INFO - 'tests': ['tp6_google', 02:46:35 INFO - 'tp6_youtube', 02:46:35 INFO - 'tp6_amazon', 02:46:35 INFO - 'tp6_facebook']}, 02:46:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:35 INFO - 'talos_options': ['--xperf_path', 02:46:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:35 INFO - 'tests': ['tp5n']}}} 02:46:35 INFO - Running post-action listener: _resource_record_post_action 02:46:35 INFO - [mozharness: 2017-08-06 09:46:35.773068Z] Finished populate-webroot step (success) 02:46:35 INFO - [mozharness: 2017-08-06 09:46:35.773157Z] Running create-virtualenv step. 02:46:35 INFO - Running pre-action listener: _resource_record_pre_action 02:46:35 INFO - Running main action method: create_virtualenv 02:46:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:46:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:46:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:35 INFO - Using real prefix '/usr' 02:46:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:38 INFO - Installing pip.................done. 02:46:38 INFO - Return code: 0 02:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:46:38 INFO - Reading from file tmpfile_stdout 02:46:38 INFO - Output received: 02:46:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:46:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:38 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:46:38 INFO - Using env: {'DISPLAY': ':0', 02:46:38 INFO - 'HOME': '/home/cltbld', 02:46:38 INFO - 'LANG': 'en_US.UTF-8', 02:46:38 INFO - 'LANGUAGE': 'en_US:en', 02:46:38 INFO - 'LOGNAME': 'cltbld', 02:46:38 INFO - 'MAIL': '/var/mail/cltbld', 02:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:38 INFO - 'MOZ_NO_REMOTE': '1', 02:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:38 INFO - 'NO_EM_RESTART': '1', 02:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:38 INFO - 'PWD': '/builds/slave/test', 02:46:38 INFO - 'SHELL': '/bin/bash', 02:46:38 INFO - 'SHLVL': '1', 02:46:38 INFO - 'TERM': 'linux', 02:46:38 INFO - 'TMOUT': '86400', 02:46:38 INFO - 'USER': 'cltbld', 02:46:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:38 INFO - '_': '/tools/buildbot/bin/python'} 02:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:46:39 INFO - Cleaning up... 02:46:39 INFO - Return code: 0 02:46:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46: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')]} 02:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:39 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:46:39 INFO - Using env: {'DISPLAY': ':0', 02:46:39 INFO - 'HOME': '/home/cltbld', 02:46:39 INFO - 'LANG': 'en_US.UTF-8', 02:46:39 INFO - 'LANGUAGE': 'en_US:en', 02:46:39 INFO - 'LOGNAME': 'cltbld', 02:46:39 INFO - 'MAIL': '/var/mail/cltbld', 02:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:39 INFO - 'MOZ_NO_REMOTE': '1', 02:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:39 INFO - 'NO_EM_RESTART': '1', 02:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:39 INFO - 'PWD': '/builds/slave/test', 02:46:39 INFO - 'SHELL': '/bin/bash', 02:46:39 INFO - 'SHLVL': '1', 02:46:39 INFO - 'TERM': 'linux', 02:46:39 INFO - 'TMOUT': '86400', 02:46:39 INFO - 'USER': 'cltbld', 02:46:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:39 INFO - '_': '/tools/buildbot/bin/python'} 02:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:39 INFO - Downloading/unpacking psutil>=3.1.1 02:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:40 INFO - Installing collected packages: psutil 02:46:40 INFO - Running setup.py install for psutil 02:46:40 INFO - building 'psutil._psutil_linux' extension 02:46:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:46:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:46:41 INFO - building 'psutil._psutil_posix' extension 02:46:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:46:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:41 INFO - Successfully installed psutil 02:46:41 INFO - Cleaning up... 02:46:41 INFO - Return code: 0 02:46:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:41 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:46:41 INFO - Using env: {'DISPLAY': ':0', 02:46:41 INFO - 'HOME': '/home/cltbld', 02:46:41 INFO - 'LANG': 'en_US.UTF-8', 02:46:41 INFO - 'LANGUAGE': 'en_US:en', 02:46:41 INFO - 'LOGNAME': 'cltbld', 02:46:41 INFO - 'MAIL': '/var/mail/cltbld', 02:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:41 INFO - 'MOZ_NO_REMOTE': '1', 02:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:41 INFO - 'NO_EM_RESTART': '1', 02:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:41 INFO - 'PWD': '/builds/slave/test', 02:46:41 INFO - 'SHELL': '/bin/bash', 02:46:41 INFO - 'SHLVL': '1', 02:46:41 INFO - 'TERM': 'linux', 02:46:41 INFO - 'TMOUT': '86400', 02:46:41 INFO - 'USER': 'cltbld', 02:46:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:41 INFO - '_': '/tools/buildbot/bin/python'} 02:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:43 INFO - Installing collected packages: mozsystemmonitor 02:46:43 INFO - Running setup.py install for mozsystemmonitor 02:46:43 INFO - Successfully installed mozsystemmonitor 02:46:43 INFO - Cleaning up... 02:46:43 INFO - Return code: 0 02:46:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:43 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:46:43 INFO - Using env: {'DISPLAY': ':0', 02:46:43 INFO - 'HOME': '/home/cltbld', 02:46:43 INFO - 'LANG': 'en_US.UTF-8', 02:46:43 INFO - 'LANGUAGE': 'en_US:en', 02:46:43 INFO - 'LOGNAME': 'cltbld', 02:46:43 INFO - 'MAIL': '/var/mail/cltbld', 02:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:43 INFO - 'MOZ_NO_REMOTE': '1', 02:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:43 INFO - 'NO_EM_RESTART': '1', 02:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:43 INFO - 'PWD': '/builds/slave/test', 02:46:43 INFO - 'SHELL': '/bin/bash', 02:46:43 INFO - 'SHLVL': '1', 02:46:43 INFO - 'TERM': 'linux', 02:46:43 INFO - 'TMOUT': '86400', 02:46:43 INFO - 'USER': 'cltbld', 02:46:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:43 INFO - '_': '/tools/buildbot/bin/python'} 02:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46: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 02:46: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 02:46: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 02:46: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 02:46:44 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:44 INFO - warning: no files found matching '*.txt' 02:46:44 INFO - no previously-included directories found matching 'build' 02:46:44 INFO - no previously-included directories found matching 'dist' 02:46:44 INFO - no previously-included directories found matching '.git*' 02:46:44 INFO - Installing collected packages: jsonschema, functools32 02:46:44 INFO - Running setup.py install for functools32 02:46:44 INFO - warning: no files found matching '*.txt' 02:46:44 INFO - no previously-included directories found matching 'build' 02:46:44 INFO - no previously-included directories found matching 'dist' 02:46:44 INFO - no previously-included directories found matching '.git*' 02:46:44 INFO - Successfully installed jsonschema functools32 02:46:44 INFO - Cleaning up... 02:46:44 INFO - Return code: 0 02:46:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46: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')]} 02:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46: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', '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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:46: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 functools32==3.2.3-2 02:46:44 INFO - Using env: {'DISPLAY': ':0', 02:46:44 INFO - 'HOME': '/home/cltbld', 02:46:44 INFO - 'LANG': 'en_US.UTF-8', 02:46:44 INFO - 'LANGUAGE': 'en_US:en', 02:46:44 INFO - 'LOGNAME': 'cltbld', 02:46:44 INFO - 'MAIL': '/var/mail/cltbld', 02:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:44 INFO - 'MOZ_NO_REMOTE': '1', 02:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:44 INFO - 'NO_EM_RESTART': '1', 02:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:44 INFO - 'PWD': '/builds/slave/test', 02:46:44 INFO - 'SHELL': '/bin/bash', 02:46:44 INFO - 'SHLVL': '1', 02:46:44 INFO - 'TERM': 'linux', 02:46:44 INFO - 'TMOUT': '86400', 02:46:44 INFO - 'USER': 'cltbld', 02:46:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:44 INFO - '_': '/tools/buildbot/bin/python'} 02:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:45 INFO - Cleaning up... 02:46:45 INFO - Return code: 0 02:46:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:45 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:46:45 INFO - Using env: {'DISPLAY': ':0', 02:46:45 INFO - 'HOME': '/home/cltbld', 02:46:45 INFO - 'LANG': 'en_US.UTF-8', 02:46:45 INFO - 'LANGUAGE': 'en_US:en', 02:46:45 INFO - 'LOGNAME': 'cltbld', 02:46:45 INFO - 'MAIL': '/var/mail/cltbld', 02:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:45 INFO - 'MOZ_NO_REMOTE': '1', 02:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:45 INFO - 'NO_EM_RESTART': '1', 02:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:45 INFO - 'PWD': '/builds/slave/test', 02:46:45 INFO - 'SHELL': '/bin/bash', 02:46:45 INFO - 'SHLVL': '1', 02:46:45 INFO - 'TERM': 'linux', 02:46:45 INFO - 'TMOUT': '86400', 02:46:45 INFO - 'USER': 'cltbld', 02:46:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:45 INFO - '_': '/tools/buildbot/bin/python'} 02:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:47 INFO - Downloading docopt-0.6.1.tar.gz 02:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:48 INFO - Running setup.py install for blobuploader 02:46:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:48 INFO - Running setup.py install for requests 02:46:48 INFO - Running setup.py install for docopt 02:46:48 INFO - Successfully installed blobuploader requests docopt 02:46:48 INFO - Cleaning up... 02:46:48 INFO - Return code: 0 02:46:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:48 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:48 INFO - Using env: {'DISPLAY': ':0', 02:46:48 INFO - 'HOME': '/home/cltbld', 02:46:48 INFO - 'LANG': 'en_US.UTF-8', 02:46:48 INFO - 'LANGUAGE': 'en_US:en', 02:46:48 INFO - 'LOGNAME': 'cltbld', 02:46:48 INFO - 'MAIL': '/var/mail/cltbld', 02:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:48 INFO - 'MOZ_NO_REMOTE': '1', 02:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:48 INFO - 'NO_EM_RESTART': '1', 02:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:48 INFO - 'PWD': '/builds/slave/test', 02:46:48 INFO - 'SHELL': '/bin/bash', 02:46:48 INFO - 'SHLVL': '1', 02:46:48 INFO - 'TERM': 'linux', 02:46:48 INFO - 'TMOUT': '86400', 02:46:48 INFO - 'USER': 'cltbld', 02:46:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:48 INFO - '_': '/tools/buildbot/bin/python'} 02:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:48 INFO - Running setup.py (path:/tmp/pip-0xpqk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:48 INFO - Running setup.py (path:/tmp/pip-3n64_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:48 INFO - Running setup.py (path:/tmp/pip-RoKFJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:49 INFO - Running setup.py (path:/tmp/pip-TUg7Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:49 INFO - Running setup.py (path:/tmp/pip-IO8OT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:49 INFO - Running setup.py (path:/tmp/pip-GCkQ7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:49 INFO - Running setup.py (path:/tmp/pip-7ZLjW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:49 INFO - Running setup.py (path:/tmp/pip-z0mUB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:49 INFO - Running setup.py (path:/tmp/pip-1o2iDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:49 INFO - Running setup.py (path:/tmp/pip-mDhk7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:49 INFO - Running setup.py (path:/tmp/pip-dlUckg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:49 INFO - Running setup.py (path:/tmp/pip-5R_c6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:49 INFO - Running setup.py (path:/tmp/pip-L2aehZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:49 INFO - Running setup.py (path:/tmp/pip-4cfPS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:49 INFO - Running setup.py (path:/tmp/pip-JfYwuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:49 INFO - Running setup.py (path:/tmp/pip-_FCzWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:49 INFO - Running setup.py (path:/tmp/pip-yceHAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:49 INFO - Running setup.py install for manifestparser 02:46:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Running setup.py install for mozcrash 02:46:50 INFO - Running setup.py install for mozdebug 02:46:50 INFO - Running setup.py install for mozdevice 02:46:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Running setup.py install for mozfile 02:46:50 INFO - Running setup.py install for mozhttpd 02:46:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Running setup.py install for mozinfo 02:46:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Running setup.py install for mozInstall 02:46:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:50 INFO - Running setup.py install for mozleak 02:46:50 INFO - Running setup.py install for mozlog 02:46:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Running setup.py install for moznetwork 02:46:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Running setup.py install for mozprocess 02:46:51 INFO - Running setup.py install for mozprofile 02:46:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Running setup.py install for mozrunner 02:46:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Running setup.py install for mozscreenshot 02:46:51 INFO - Running setup.py install for moztest 02:46:51 INFO - Running setup.py install for mozversion 02:46:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:51 INFO - Cleaning up... 02:46:51 INFO - Return code: 0 02:46:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46: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')]} 02:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:51 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:51 INFO - Using env: {'DISPLAY': ':0', 02:46:51 INFO - 'HOME': '/home/cltbld', 02:46:51 INFO - 'LANG': 'en_US.UTF-8', 02:46:51 INFO - 'LANGUAGE': 'en_US:en', 02:46:51 INFO - 'LOGNAME': 'cltbld', 02:46:51 INFO - 'MAIL': '/var/mail/cltbld', 02:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:51 INFO - 'MOZ_NO_REMOTE': '1', 02:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:51 INFO - 'NO_EM_RESTART': '1', 02:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:51 INFO - 'PWD': '/builds/slave/test', 02:46:51 INFO - 'SHELL': '/bin/bash', 02:46:51 INFO - 'SHLVL': '1', 02:46:51 INFO - 'TERM': 'linux', 02:46:51 INFO - 'TMOUT': '86400', 02:46:51 INFO - 'USER': 'cltbld', 02:46:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:51 INFO - '_': '/tools/buildbot/bin/python'} 02:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:51 INFO - Running setup.py (path:/tmp/pip-S3vZhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:52 INFO - Running setup.py (path:/tmp/pip-Rbih5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:52 INFO - Running setup.py (path:/tmp/pip-jOL1wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:52 INFO - Running setup.py (path:/tmp/pip-OoFKNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:52 INFO - Running setup.py (path:/tmp/pip-MYAPRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:52 INFO - Running setup.py (path:/tmp/pip-OEWcVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:52 INFO - Running setup.py (path:/tmp/pip-cTPBuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:52 INFO - Running setup.py (path:/tmp/pip-zpS5uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:52 INFO - Running setup.py (path:/tmp/pip-WeBOda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:52 INFO - Running setup.py (path:/tmp/pip-xGOU4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:52 INFO - Running setup.py (path:/tmp/pip-C8Pddw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:52 INFO - Running setup.py (path:/tmp/pip-fUkgCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:52 INFO - Running setup.py (path:/tmp/pip-Zigl37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:52 INFO - Running setup.py (path:/tmp/pip-s68FOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:52 INFO - Running setup.py (path:/tmp/pip-hIz5_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:53 INFO - Running setup.py (path:/tmp/pip-Ra3iBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:53 INFO - Running setup.py (path:/tmp/pip-mvFDPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:46:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:54 INFO - Downloading blessings-1.6.tar.gz 02:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:54 INFO - Installing collected packages: blessings 02:46:54 INFO - Running setup.py install for blessings 02:46:54 INFO - Successfully installed blessings 02:46:54 INFO - Cleaning up... 02:46:54 INFO - Return code: 0 02:46:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:54 INFO - Reading from file tmpfile_stdout 02:46:54 INFO - Current package versions: 02:46:54 INFO - argparse == 1.2.1 02:46:54 INFO - blessings == 1.6 02:46:54 INFO - blobuploader == 1.2.4 02:46:54 INFO - docopt == 0.6.1 02:46:54 INFO - functools32 == 3.2.3-2 02:46:54 INFO - jsonschema == 2.5.1 02:46:54 INFO - manifestparser == 1.1 02:46:54 INFO - mozInstall == 1.13 02:46:54 INFO - mozcrash == 1.0 02:46:54 INFO - mozdebug == 0.1 02:46:54 INFO - mozdevice == 0.51 02:46:54 INFO - mozfile == 1.2 02:46:54 INFO - mozhttpd == 0.7 02:46:54 INFO - mozinfo == 0.10 02:46:54 INFO - mozleak == 0.1 02:46:54 INFO - mozlog == 3.5 02:46:54 INFO - moznetwork == 0.27 02:46:54 INFO - mozprocess == 0.25 02:46:54 INFO - mozprofile == 0.28 02:46:54 INFO - mozrunner == 6.13 02:46:54 INFO - mozscreenshot == 0.1 02:46:54 INFO - mozsystemmonitor == 0.3 02:46:54 INFO - moztest == 0.8 02:46:54 INFO - mozversion == 1.4 02:46:54 INFO - psutil == 3.1.1 02:46:54 INFO - requests == 1.2.3 02:46:54 INFO - wsgiref == 0.1.2 02:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:54 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:46:54 INFO - Using env: {'DISPLAY': ':0', 02:46:54 INFO - 'HOME': '/home/cltbld', 02:46:54 INFO - 'LANG': 'en_US.UTF-8', 02:46:54 INFO - 'LANGUAGE': 'en_US:en', 02:46:54 INFO - 'LOGNAME': 'cltbld', 02:46:54 INFO - 'MAIL': '/var/mail/cltbld', 02:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:54 INFO - 'MOZ_NO_REMOTE': '1', 02:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:54 INFO - 'NO_EM_RESTART': '1', 02:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:54 INFO - 'PWD': '/builds/slave/test', 02:46:54 INFO - 'SHELL': '/bin/bash', 02:46:54 INFO - 'SHLVL': '1', 02:46:54 INFO - 'TERM': 'linux', 02:46:54 INFO - 'TMOUT': '86400', 02:46:54 INFO - 'USER': 'cltbld', 02:46:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:54 INFO - '_': '/tools/buildbot/bin/python'} 02:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:46:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:46:56 INFO - Installing collected packages: simplejson 02:46:56 INFO - Running setup.py install for simplejson 02:46:56 INFO - building 'simplejson._speedups' extension 02:46:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:46:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:46:57 INFO - Successfully installed simplejson 02:46:57 INFO - Cleaning up... 02:46:57 INFO - Return code: 0 02:46:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:57 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 0x1a731f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, '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': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:46:57 INFO - Using env: {'DISPLAY': ':0', 02:46:57 INFO - 'HOME': '/home/cltbld', 02:46:57 INFO - 'LANG': 'en_US.UTF-8', 02:46:57 INFO - 'LANGUAGE': 'en_US:en', 02:46:57 INFO - 'LOGNAME': 'cltbld', 02:46:57 INFO - 'MAIL': '/var/mail/cltbld', 02:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:57 INFO - 'MOZ_NO_REMOTE': '1', 02:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:57 INFO - 'NO_EM_RESTART': '1', 02:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:57 INFO - 'PWD': '/builds/slave/test', 02:46:57 INFO - 'SHELL': '/bin/bash', 02:46:57 INFO - 'SHLVL': '1', 02:46:57 INFO - 'TERM': 'linux', 02:46:57 INFO - 'TMOUT': '86400', 02:46:57 INFO - 'USER': 'cltbld', 02:46:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:57 INFO - '_': '/tools/buildbot/bin/python'} 02:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:57 INFO - Cleaning up... 02:46:57 INFO - Return code: 0 02:46:57 INFO - Running post-action listener: _resource_record_post_action 02:46:57 INFO - Running post-action listener: _start_resource_monitoring 02:46:57 INFO - Starting resource monitoring. 02:46:57 INFO - [mozharness: 2017-08-06 09:46:57.487999Z] Finished create-virtualenv step (success) 02:46:57 INFO - [mozharness: 2017-08-06 09:46:57.488950Z] Running install step. 02:46:57 INFO - Running pre-action listener: _resource_record_pre_action 02:46:57 INFO - Running main action method: install 02:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:57 INFO - Reading from file tmpfile_stdout 02:46:57 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:57 INFO - Reading from file tmpfile_stdout 02:46:57 INFO - Output received: 02:46:57 INFO - Usage: mozinstall [options] installer 02:46:57 INFO - Options: 02:46:57 INFO - -h, --help show this help message and exit 02:46:57 INFO - -d DEST, --destination=DEST 02:46:57 INFO - Directory to install application into. [default: 02:46:57 INFO - "/builds/slave/test"] 02:46:57 INFO - --app=APP Application being installed. [default: firefox] 02:46:57 INFO - mkdir: /builds/slave/test/build/application 02:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:47:15 INFO - Reading from file tmpfile_stdout 02:47:15 INFO - Output received: 02:47:15 INFO - /builds/slave/test/build/application/firefox/firefox 02:47:15 INFO - Running post-action listener: _resource_record_post_action 02:47:15 INFO - [mozharness: 2017-08-06 09:47:15.853991Z] Finished install step (success) 02:47:15 INFO - [mozharness: 2017-08-06 09:47:15.854247Z] Running setup-mitmproxy step. 02:47:15 INFO - Running pre-action listener: _resource_record_pre_action 02:47:15 INFO - Running main action method: setup_mitmproxy 02:47:15 INFO - Skipping: mitmproxy is not required 02:47:15 INFO - Running post-action listener: _resource_record_post_action 02:47:15 INFO - [mozharness: 2017-08-06 09:47:15.855386Z] Finished setup-mitmproxy step (success) 02:47:15 INFO - [mozharness: 2017-08-06 09:47:15.855609Z] Running run-tests step. 02:47:15 INFO - Running pre-action listener: _resource_record_pre_action 02:47:15 INFO - Running pre-action listener: _set_gcov_prefix 02:47:15 INFO - Running main action method: run_tests 02:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:15 INFO - Python 2.7.3 02:47:15 INFO - Return code: 0 02:47:15 INFO - grabbing minidump binary from tooltool 02:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:15 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 0x1ddfeb0>, '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 0x1de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de1240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:47:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:47:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:47:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:16 INFO - Return code: 0 02:47:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:47:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:16 INFO - ENV: RUST_BACKTRACE is now 1 02:47:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:47:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:47:16 INFO - Using env: {'DISPLAY': ':0', 02:47:16 INFO - 'HOME': '/home/cltbld', 02:47:16 INFO - 'LANG': 'en_US.UTF-8', 02:47:16 INFO - 'LANGUAGE': 'en_US:en', 02:47:16 INFO - 'LOGNAME': 'cltbld', 02:47:16 INFO - 'MAIL': '/var/mail/cltbld', 02:47:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:16 INFO - 'MOZ_NO_REMOTE': '1', 02:47:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:16 INFO - 'NO_EM_RESTART': '1', 02:47:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:16 INFO - 'PWD': '/builds/slave/test', 02:47:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:16 INFO - 'RUST_BACKTRACE': '1', 02:47:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:47:16 INFO - 'SHELL': '/bin/bash', 02:47:16 INFO - 'SHLVL': '1', 02:47:16 INFO - 'STYLO_FORCE_ENABLED': '1', 02:47:16 INFO - 'TERM': 'linux', 02:47:16 INFO - 'TMOUT': '86400', 02:47:16 INFO - 'USER': 'cltbld', 02:47:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406', 02:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:16 INFO - '_': '/tools/buildbot/bin/python'} 02:47:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:47:16 INFO - mozversion application_buildid: 20170806090346 02:47:16 INFO - mozversion application_changeset: b34cf908546b9f37f5d1b100e67dc8ef814fca7a 02:47:16 INFO - mozversion application_display_name: Nightly 02:47:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:16 INFO - mozversion application_name: Firefox 02:47:16 INFO - mozversion application_remotingname: firefox 02:47:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:47:16 INFO - mozversion application_vendor: Mozilla 02:47:16 INFO - mozversion application_version: 57.0a1 02:47:16 INFO - mozversion platform_buildid: 20170806090346 02:47:16 INFO - mozversion platform_changeset: b34cf908546b9f37f5d1b100e67dc8ef814fca7a 02:47:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:47:16 INFO - mozversion platform_version: 57.0a1 02:47:16 INFO - using testdate: 1502012836 02:47:16 INFO - actual date: 1502012836 02:47:16 INFO - starting webserver on 'localhost:39035' 02:47:16 INFO - SUITE-START | Running 2 tests 02:47:16 INFO - TEST-START | dromaeo_css 02:47:16 INFO - Initialising browser for dromaeo_css test... 02:47:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39035/getInfo.html -profile /tmp/tmpnmCFw9/profile 02:47:16 INFO - TEST-INFO | started process 3436 (/builds/slave/test/build/application/firefox/firefox http://localhost:39035/getInfo.html) 02:47:24 INFO - TEST-INFO | 3436: exit 0 02:47:24 INFO - Browser initialized. 02:47:24 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:24 INFO - TEST-INFO | started process 3665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnmCFw9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:25 INFO - PID 3665 | 02:47:25 INFO - PID 3665 | (/builds/slave/test/build/application/firefox/firefox:3719): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:47:25 INFO - PID 3665 | 02:47:36 INFO - PID 3665 | RSS: Main: 170242048 02:47:36 INFO - PID 3665 | 02:47:36 INFO - PID 3665 | serialization: Helvetica 02:47:36 INFO - PID 3665 | serialization: Arial 02:50:35 INFO - PID 3665 | Cycle 1(1): loaded http://localhost:39035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39035/tests/dromaeo/cssquery-ext.html) 02:50:37 INFO - PID 3665 | RSS: Main: 174821376 02:50:37 INFO - PID 3665 | 02:50:37 INFO - PID 3665 | serialization: Helvetica 02:50:37 INFO - PID 3665 | serialization: Arial 02:53:39 INFO - PID 3665 | Cycle 1(1): loaded http://localhost:39035/tests/dromaeo/cssquery-ext.html (next: http://localhost:39035/tests/dromaeo/cssquery-jquery.html) 02:53:39 INFO - PID 3665 | RSS: Main: 172732416 02:53:39 INFO - PID 3665 | 02:53:39 INFO - PID 3665 | serialization: Helvetica 02:53:39 INFO - PID 3665 | serialization: Arial 02:56:41 INFO - PID 3665 | Cycle 1(1): loaded http://localhost:39035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39035/tests/dromaeo/cssquery-mootools.html) 02:56:42 INFO - PID 3665 | RSS: Main: 174751744 02:56:42 INFO - PID 3665 | 02:56:42 INFO - PID 3665 | serialization: Helvetica 02:56:42 INFO - PID 3665 | serialization: Arial 02:59:44 INFO - PID 3665 | Cycle 1(1): loaded http://localhost:39035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39035/tests/dromaeo/cssquery-prototype.html) 02:59:44 INFO - PID 3665 | RSS: Main: 173035520 02:59:44 INFO - PID 3665 | 02:59:44 INFO - PID 3665 | serialization: Helvetica 02:59:44 INFO - PID 3665 | serialization: Arial 03:02:48 INFO - PID 3665 | Cycle 1(1): loaded http://localhost:39035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39035/tests/dromaeo/cssquery-yui.html) 03:02:49 INFO - PID 3665 | RSS: Main: 176631808 03:02:49 INFO - PID 3665 | 03:02:49 INFO - PID 3665 | serialization: Helvetica 03:02:49 INFO - PID 3665 | serialization: Arial 03:05:51 INFO - PID 3665 | Cycle 1(1): loaded http://localhost:39035/tests/dromaeo/cssquery-yui.html (next: http://localhost:39035/tests/dromaeo/cssquery-dojo.html) 03:05:51 INFO - PID 3665 | RSS: Main: 177106944 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | __start_tp_report 03:05:51 INFO - PID 3665 | _x_x_mozilla_page_load 03:05:51 INFO - PID 3665 | _x_x_mozilla_page_load_details 03:05:51 INFO - PID 3665 | |i|pagename|runs| 03:05:51 INFO - PID 3665 | |0;dojo.html;3117.267442151093;3186.6654001329844;3195.792273502222;3205.374951884382;3220.3398303347817;6237.3138954715005;6292.874142517158;6339.207599050119;6365.140706004688;6370.203724534434;6133.570650054498;6257.71840267188;6263.154474145989;6270.686465676721;6299.464545513637;5704.515116215116;5737.311522617292;5756.74094665739;5771.567132465061;5857.092150716646;5810;5821.068629019358;5866.853328666796;5893.941060589404;5930.525557955353;5593.8601534961745;5750.166225897243;5750.1949727038245;5776.59563830532;5793.681347525884;5425.647332923348;5767.33675627304;5853.47318741311;5856.326522449909;5859.1504231886565;5631.9718401408145;5647.040003199466;5654.688992105433;5681.488666020036;5727.312722473288;6121.173641558422;6187.288461826903;6193.690315484253;6210.627362358273;6214.533909956771;6804.523683342168;6817.863642727118;6819.045333653293;6820.727170913157;6821.658917054127;6791.286914873916;6794.388505034522;6804.55770374924;6898.896516552256;6907.240203577602;6155.446009859134;6287.528435367274;6309.87380252397;6368.363163683594;6378.808635740888;6961.338672826073;7003.159620845531;7073.681684324218;7086.751963681247;7095.254998225112;6617;6682;6703.262641109474;6714.3957043866285;6715.865682686319;6733.8653226935185;6745.898811517831;6805.625690587065;6841.076454678555;6865.347791959756;6590.176227971504;6599.901001484982;6667.19993600771;6723.0923825283935;6756.189257289157;6647.734090636417;6710.1947766267385;6715.059891615178;6724.428423583952;6726.327367263332;5446.400895901447;5491.28613280279;5506.531944784658;5508.3114610673665;5520.392756796749;4688.156131896291;4712.057588482317;4732.550407711331;4775.594074503706;4780.259059845729;5781.739821708034;5864.472197502245;5868.325142608569;5889.4699477046415;5893.381194974466;6740.595564266159;6750.3249675033085;6757.425618822357;6827.317268273133;6858.971154326891;5689.743961521659;5773.88452230953;5781.4507621775865;5783.797567085132;5820;5962.07587823888;5967.8209653710455;5981.910271345933;5982.760689572368;5995.820125396245;6509;6513.576617519846;6528.869422611521;6539.738410463528;6550.901736473957;6710.66446677674;6832.248452670302;6844.623545704835;6911.75808846688;6919.7232110715;6492.740290388331;6575.572587781779;6589.143411356493;6633.535652504278;6643.30245324234;6546.214454265519;6594.901076483952;6682.2649508555;6685.899711504234;6707.228668703162;6636.402723754885;6660.900951342974;6663.600183988976;6677.699503522256;6710.060591517094;6421.389967953037;6433.356664333529;6439.034144878118;6444.871102578016;6561.967190164019;6584.868302633825;6629.966850165718;6634.469242460688;6676.198856137295;6721.059051732859;6401.167848179894;6516.380943810331;6523.380278873499;6543.934560654333;6638.336166383516;6554.115194448879;6615;6628.767993120217;6718.059471674067;6727.192736871607;6442.645654489048;6477.708503117466;6485.643289619116;6511.283758786435;6515.934840651533 03:05:51 INFO - PID 3665 | |1;ext.html;803.2329125684971;849.8045449546605;883.3772190605622;883.8895138107737;1127.8590176227972;30542.69457305426;42193.578064219386;42932.35601465977;43026.56973430265;43043.56956430435;31687.207819804516;42870.571294287125;43136.352954705624;43458.13083738331;43522.56477435225;5793.594448388625;5918.556108291874;7687.692492300302;7871.567063811488;7913.485623434487;7725.845483090335;7794.571298578576;7811.336036436881;7819.530828150329;7831.451798374088;7800.804979875492;7839.843203135933;7856.7642970710685;7862.095858976205;7865.882011769828;7789.065312162548;7835.921640783577;7839.804004899895;7847.176046515091;7850.371970242367;7751;7766.805829854242;7769.223077692242;7810.492317999312;7816.921830781676;36989.260214795555;37215.81392093049;37650.81174594109;37668;37747.433788493196;3531.699805516534;3563.6436356364416;3570.357335679577;3575.4994300797907;3582.373084710165;31260.687393126005;31309.217269568217;31316;31554.053378398683;31587;4999.700017998895;5006.299118123466;5012.097822391968;5048.545630893201;5062.54437100659;196701;198243;198266;198815;198848.0057599717;48408.515914841104;48708.26937595939;48835.267470987965;48934.75532622314;48944.7552762241;50345.74827125841;50456;50662.22682206105;50719;50794.74602626963;16066.11636359988;16184.271707773178;16395.42616008458;16396.426125085563;16520.917395412947;11438.199326047263;11678.591249306233;13530.120542164728;13669.111507752163;13903.4438622456;13200;13223.33883305831;13298.268595227355;13367.331633418291;13423.3959471824;5175;5220.634555581073;5224.791008359623;5236.39781425141;5286.418493965661;992.5136683025265;1005.6128390569537;1021.9642312519026;1036.2176556699644;1042.6871938418444;22771.40600158006;23660.88169559141;23700.64449033266;23760;24027.038918443417;1143.0512674480162;1149.9080073594093;1150.442035612727;1151.6660168551193;1153.5155234801402;16506.42227522031;16646.50302454617;16708.916455417646;16954.321827127023;17265.827341726672;220190;220193;220255;220317;220324;56191;56306.71846640741;56552;56617.99999999918;56660.43339566634;1422.7012327411153;1439.9496017639333;1481.525911708243;1509.3509790790065;1515.0758037597277;26439.735602643726;27129.558339749517;27385.31536711598;27515.44969100647;27541.586876196474;37671.434928475544;38121.80939095287;38128.80935595415;38199.42700859545;38219.61780382161;185915;186154;186771;186800;187249;29154.854225728737;29860;33644.32711345809;33854.153646159044;33885.830570846985;37958.24083518369;38263.80868095642;38580.228395432496;38972.61027389803;40030.65476046037;32740.34519309648;32923.835380822944;33101.17247068843;33583.49624755582;33995.66004340024;32193;32207.35585288328;32248.516272256406;32668.346633067682;35219;38447.423288651255;38981.220375591765;39119.80440097781;39196;39240.6075939237;33514.32971340511;33530.32939341248;33841.49237761485;33928.66071339255;34686.65313346935;24640.50718985646;24717;24812.87593562093;24981.75018249794;25302.620460693473 03:05:51 INFO - PID 3665 | |2;jquery.html;576.3688760806915;590.1148277583625;591.517912900986;593.5904226084002;598.2641351138099;21321.466963325925;22088.33734987953;22121.115155393785;22140.33578992633;22899.198528051522;25684.87157564214;27803.860980695117;27841.443171136565;27863.721362786368;27872.581911271296;6600.93399066008;6744.898826517606;6782.593044417351;6787.389134977851;6787.660616969157;6070.210872586557;6501.317361677026;6646.401823835854;6655.46756259498;6701.798946031627;6492.805215843508;6499.9350006500035;6508.121403610499;6509;6509.609423434586;6489.123968264271;6495.415412612864;6501.154849869534;6504.252011018746;6528.967355163241;6075.17985072014;6081.300650425169;6082.239720034996;6084.60450070744;6090.086487026937;29593.70406295931;30380.69619303801;30992.845035774677;31698.683013169804;32086.839565802256;1872.3446793622122;1940.4566721318054;1956.5695546979641;1956.9706454403054;1960.6862901935622;19231.807681923143;19827.30604428838;19849.603007939906;19849.702254466196;19877.30429434977;2376.4475131006793;2439.475512764764;2440.9511809763885;2499.3501689560844;2507.6113202453466;136828;143603.56396436007;144390.27804861014;144406;144814;14551.636209094646;15506.5348039559;15620;15671.921640391725;15787.447439339569;23749.168779092994;24358.75641243565;24433.75566244315;24455;25279.620805687562;10680.198985075995;10727.249092563601;10782.67651970442;10807.35155890649;10909.672709818718;10013.148882345082;10087.848682269772;10090.192784577217;10164;10221.386716797017;9738.805223895482;9950.35322704022;10026.147777438853;10102.494875256354;10138.695839124837;2769.1000424862;2795.8332292473087;2808.466391385671;2812.1141840320643;2864.74217320438;952.3904700991233;965.0976337124811;971.3589031239349;975.4634950777045;982.1308142294121;20145.798542014687;20595.58808823815;20882.895585522278;20936.267230646856;21005.264815731683;1023.469912480831;1033.3438266700548;1035.6841163445072;1048.4390850894736;1053.3100818963592;11264.831027534594;11330.150238732129;11361.14791390649;11498.77002459963;11546.653600392001;489838;503881;505641;511605;518807;113451.43274283576;116239;123209.38395307965;123394;123527;1210.9515619375302;1293.5084667826166;1294.2816736711216;1295.3393769177787;1296.8767967043116;21575.24486643023;21834.344969650934;22121;22254.443638909157;22367.328980130624;58842.4115758854;59592;62144;62490.687546561974;64148;79916;79927.60036199781;80082.1991780098;80331.59834200791;80996;15051.247437628293;15258.923705381401;15417.460388886335;15424;15447.459338923532;21172.25897093656;21522.784772152703;23991.760082398952;24207.394815129763;24427;17236.913815430842;17679.911600441916;17711.46865594034;18912;19137;15593.922030389775;16086.517404477885;16497.587560310607;16631.584210394838;17324.653506930044;16772.412965546147;17587.56031099233;17641.206145723216;17839.46481605554;17930.820691792916;15275.923620382271;15369.538913832603;15371;15602.375904963674;15618.594326510669;17050.573735656708;17158.65682686314;17265.482035538953;17279.308827646753;17294.65410691754 03:05:51 INFO - PID 3665 | |3;mootools.html;1330.793726972319;1381.2610253514372;1386.3345594114824;1397.3432486731235;1404.6839461121242;13638.38627261773;14150;14162.858371416283;14190.787138192922;14282.785758213622;12956.93521532391;13432.261225632587;13750.38123284452;13766.518171863987;13771.517996870112;2649.3641526033757;2688.7580117789394;2705.715899830519;2708.6072519484665;2708.7426694463993;2459.1761759810397;2572.7941764658876;2601.778848797845;2668.5463471209846;2672.665916760405;2513.949721005579;2531.4683916377585;2534.936626584332;2537.0232460502657;2537.023246050275;2488.8631125288102;2489.166129346662;2491.9377015574755;2500.3874050857657;2516.6476693262957;2389.0802041214083;2395.5089206712582;2410.20463247128;2410.68661074061;2413.8310318277727;13986.930065349608;14203.431862725478;14256.28718564078;14280.357383917748;14285.071470354498;7667;7966.840663186762;7972.681092756283;7980.600969951479;7986.161453047404;5131.794728210867;5203.713795741232;5281.287026251483;5330.120530112566;5370.8925821483745;1818.1818181818103;1829.871908966373;1831.2125785912053;1878.6806242938733;1891.0828248299563;23372.415689607897;23457.53084938309;23478.64782028271;23521.29436116919;23698.40753981147;6416.35836416364;6593.505487088391;6661.233958094881;6705.966470167716;6772.153480814898;15938.521844344688;15984.920075399548;15996;16012.439564615415;16029.679406411806;7418.888716669254;7728.343090837229;7742.845143097106;7743.612819359009;7748.263914928073;6977.302269772982;7147.2852714728115;7183.209846916835;7244.637768111679;7254.5647261164495;5050.191969284897;5223.817166399158;5243.501867322599;5275.683458992473;5291.841244762663;1310.6461255460972;1334.6329759316266;1543.9382424702885;1550.4960887711538;1556.5797234746556;784.2197013971136;805.0299389235956;807.3904202327205;809.5021561739605;810.0522388805113;7990.320822730133;8028.518288902567;8114.715984940617;8127.471714338549;8190.467619604707;721.1742554774859;722.357102179061;728.3845150847526;730.302561054192;810.3031393002013;4938.9012219755405;5245.921311180336;5409.756560954766;5447.428020057916;5488.204210389471;19659.41021769349;19902.203911843655;20110.69833952492;20337.389878303675;20352.389428317176;18769.812301876806;19459.8054019458;19679;19700.70448943267;19810.801891981184;11010.50452729629;11218.607348742755;11234;11252.043576295942;11360.886391136148;7758.9612051939375;7945.205479452008;8043.436959412785;8115.188481151838;8337;15942.362305508113;15952;15981.600459988593;15989.8401015993;16077.517674469784;16392.67214655724;16505.17474126265;16550.337986480405;16747.74878376801;16948;11563.190576659554;11882.940585297018;11894;11901.821472677744;11908.285502869856;12453.813192801934;12826.55107071248;12884.677883052624;13001.739965200453;13067.34663266852;10654.89345106539;10815.67552973412;10883.619073332395;10949.288296260718;11003.944980275048;10240.180785537288;10529.57881684724;10534.57861685524;10687.038166565046;10734.19493537972;8768.561571921506;8865.512396818236;8867.157620026088;8939.553022348986;8941.105889411007;6738.157730283715;6799.89800153008;6832.453403727789;6866.896996544956;6879.724811007503;6900.861982760417;6907.896381554381;6932;6969.337912898267;7019.613921234177 03:05:51 INFO - PID 3665 | |4;prototype.html;490.44284397039394;508.40008789628223;521.9243209734589;524.5384062025418;531.1554628141255;6099.481544068754;6123.203983482153;6135.447809697132;6136.601120927136;6137.263528376596;5766.423357664232;5826.883462330751;5900.970495147529;5911.940880591193;6006.069059295805;4892.119418504668;4928.383952005999;4945.752712364385;4949.13390156722;4958.429780575226;4778.880527986811;4855.465898751135;4892.266160075981;4919.499552636445;4929.556339929406;4775.474697783241;4784.521547845223;4845.394325709286;4882.121218180726;4895.971845912362;4834.903301933941;4835.782389792468;4861.975690121527;4894.4371397289415;4908.361912951312;4423.845165419195;4441.955580444186;4478.0596074824325;4483.843065492692;4486.865394038184;5971.671558064305;5974.820755377345;5997.070454079581;5997.910031349533;6028.788992385289;5587.273654424939;5591.776328946878;5633.436656334334;5685.431456854323;5688.345840228344;6344.524160687967;6369.713362898634;6407.135036770023;6434.388733070351;6450.451711604473;4749.9762501187615;4842.83050093245;4849.248366503198;4867.610591152699;4876.926846097312;6670;6681.198256209237;6738.292479289653;6759.256481787;6818.28408017156;4890.608751299887;4911.16510193268;4922.433920099163;4930.827421040318;4977.776000080005;5029.622778291569;5037.924431133536;5051.595872330205;5066.290719299301;5068.315777370008;5589.916151257735;5651.180578816049;5660.29246344207;5660.660360378391;5691.231683722727;6422.165118534654;6462.289148193695;6465.676716164173;6480.287168411471;6484.902726459107;1642.7125253080662;1687.7721507596564;1692.4753326468833;1703;1743.616404391032;1199.6521008907494;1221.4564518789055;1221.955228279808;1223.1682455929874;1224.69994851262;5617.157426386075;5637.802676906289;5650.152477128464;5660.405657405913;5671.404502527175;6404.48764098871;6456.967715161488;6524.869502609921;6577.947528395433;6610.8347291318105;5618.803341883015;5623.465770751772;5630.296212973379;5681.205170725836;5692.601517893708;3424.195314101184;3489.092835862694;3503;3518.648135186461;3524.1894364296354;6252.6873656317;6314.842128946813;6350.7777227796805;6374.649394283266;6456.257530383972;6774.085498457744;6803.788768650208;6806.4554835613035;6850.554713943578;6883.724651013903;6392.16901802772;6408.839779005562;6419.454346380423;6427.775027874002;6457.5479716419395;6595.571287866273;6599.878020736391;6660.966695166493;6671.599704017581;6691.732330706912;6441.938579654653;6453.289878182191;6534.411902928759;6538.803835884931;6546.9883853427955;6380.840478988062;6415.230172379344;6446.774362897276;6446.967765161145;6447.2263328400895;4867.269909513601;4914.803407863646;4931.753412329441;4936.741750444689;4966.304717339648;6614.735410583715;6617.371349721769;6621.172353455818;6641.50188735837;6653.933460665525;6351.745930162741;6378.936210637834;6393.584417012879;6402.583832050902;6412.166418365583;6371.044343348535;6392.296847346695;6412.35876412355;6422.967885160544;6487.481001519773;6006.639601623917;6141.07883817431;6260.937390626035;6263.655498947602;6278.152449419453;6247.281562620356;6432.497251923765;6441.838954026187;6444.258910225384;6450.290468048417;6228.844278893064;6262.843428914313;6266.780662676784;6268.968655156695;6284.654344011124 03:05:51 INFO - PID 3665 | |5;yui.html;886.8448021596221;905.4567259644215;915.3318077803203;926.5876684875229;930.1117432851628;18989.715154272697;19865.801341986575;19897.602047959033;19926.10332535036;19958.30145944892;21055.368338949855;21913;21946.122155113775;21953.121875124976;21992.560148797016;1047.4553232319208;1067.423591260722;1068.6954218047858;1069.9893001069968;1070.3524367757511;1004.5228516454698;1047.5914393386547;1053.220616743608;1063.5479921033568;1067.0609863320306;1111.5776005118043;1114.4594871487323;1114.6433141394757;1114.6656003199048;1115.2639258089662;1110.5613282753347;1114.0419239454063;1115.074488174813;1117.190037223015;1117.312852595652;810.116972499972;815.0748899998486;815.355868863597;815.5106935838509;815.6778072661325;17563.5609109772;17879.73180402295;17961.820381796144;18021.7296740549;18076.367327143485;21712;21811.127554897786;22179.223727169632;22200.666989995163;22302.21942232014;16754.83245167557;17017.744733829004;17065.914670426693;17246.65506689872;17255.309787608607;3534.8939531814085;3567.678908898212;3568.1614820517157;3569.7679650822615;3580.534530511043;129295;130339;131040;133840;134126;16776.412825551048;17149.228284727218;17636.735448968277;17799.911000444914;17968.640627187382;32381;32536.674633253366;32747;32975;33170;8978.595963181673;9032.774180645536;9189.954050229706;9190.90809091914;9198.080191980882;3729.850805967785;4249.107687385622;4343.630791382768;4349.064951035542;4351.042770590465;4389.4513185851765;5778.219940308089;5978.55160862937;5987.64074155552;6001.159837622737;1117.754094099297;1148.8563929508812;1161.6573110932295;1171.6719318590808;1175.1773758369004;552.2075821196596;562.2493970549281;568.1421054208175;590.3329237961076;591.133988706547;11129.443527823576;11657.650270491898;11716.88283117175;11820.172587918934;11972.221805582609;538.5476199991947;543.5868739757733;557.3061538384655;571.2431028886741;575.128680049725;5194.4026436959475;5868.530517558585;5919.230500034968;5945.643261404243;6009.038553831366;101055.49472252592;104430.47784761028;105214.47392762988;105559;109584.4520777407;92976;94337;94732.52633736788;95893;99298;80532;82338;82753.58623206966;82880.17119828844;83802.58098709346;11197.72005699864;11352.205345625727;11457.541698332307;11637;11828.40857957116;37022.8148859254;37179.814100929325;37252;38510.61489385182;39328.606713932495;47776.327828525835;48625;49780;50333.24500132574;50908.745456273966;16987.23557439943;17332.220050097523;17435.912820435817;17514.124293785004;17558.91220543889;17266.223019964382;17276.22256998463;17384.391546295818;17424.390146344816;17448.73826892572;16742.66058715324;16822.495325140266;16852.325906963582;16951.15244237808;17022.74465882988;16578.088205148833;17079.573010674834;17238.827611723722;17448;17615.64768704593;17095.14524273806;17131.229094691018;17209.741853872452;17323;17579.56051098733;12077.939610301892;12141.75716485683;12210.38948052576;12279;12419.254844709347;12787.552435664707;13178.341082946006;13301.201927884358;13358.265295408846;13409.66475838112 03:05:51 INFO - PID 3665 | __end_tp_report 03:05:51 INFO - PID 3665 | __start_cc_report 03:05:51 INFO - PID 3665 | _x_x_mozilla_cycle_collect,362 03:05:51 INFO - PID 3665 | __end_cc_report 03:05:51 INFO - PID 3665 | __startTimestamp1502013951374__endTimestamp 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | ------- Summary: start ------- 03:05:51 INFO - PID 3665 | Number of tests: 6 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | [#0] dojo.html Cycles:165 Average:6219.55 Median:6485.64 stddev:737.88 (11.4%) stddev-sans-first:698.86 03:05:51 INFO - PID 3665 | Values: 3117.3 3186.7 3195.8 3205.4 3220.3 6237.3 6292.9 6339.2 6365.1 6370.2 6133.6 6257.7 6263.2 6270.7 6299.5 5704.5 5737.3 5756.7 5771.6 5857.1 5810.0 5821.1 5866.9 5893.9 5930.5 5593.9 5750.2 5750.2 5776.6 5793.7 5425.6 5767.3 5853.5 5856.3 5859.2 5632.0 5647.0 5654.7 5681.5 5727.3 6121.2 6187.3 6193.7 6210.6 6214.5 6804.5 6817.9 6819.0 6820.7 6821.7 6791.3 6794.4 6804.6 6898.9 6907.2 6155.4 6287.5 6309.9 6368.4 6378.8 6961.3 7003.2 7073.7 7086.8 7095.3 6617.0 6682.0 6703.3 6714.4 6715.9 6733.9 6745.9 6805.6 6841.1 6865.3 6590.2 6599.9 6667.2 6723.1 6756.2 6647.7 6710.2 6715.1 6724.4 6726.3 5446.4 5491.3 5506.5 5508.3 5520.4 4688.2 4712.1 4732.6 4775.6 4780.3 5781.7 5864.5 5868.3 5889.5 5893.4 6740.6 6750.3 6757.4 6827.3 6859.0 5689.7 5773.9 5781.5 5783.8 5820.0 5962.1 5967.8 5981.9 5982.8 5995.8 6509.0 6513.6 6528.9 6539.7 6550.9 6710.7 6832.2 6844.6 6911.8 6919.7 6492.7 6575.6 6589.1 6633.5 6643.3 6546.2 6594.9 6682.3 6685.9 6707.2 6636.4 6660.9 6663.6 6677.7 6710.1 6421.4 6433.4 6439.0 6444.9 6562.0 6584.9 6630.0 6634.5 6676.2 6721.1 6401.2 6516.4 6523.4 6543.9 6638.3 6554.1 6615.0 6628.8 6718.1 6727.2 6442.6 6477.7 6485.6 6511.3 6515.9 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | [#1] ext.html Cycles:180 Average:37516.09 Median:34952.83 stddev:52271.12 (149.5%) stddev-sans-first:52345.06 03:05:51 INFO - PID 3665 | Values: 803.2 849.8 883.4 883.9 1127.9 30542.7 42193.6 42932.4 43026.6 43043.6 31687.2 42870.6 43136.4 43458.1 43522.6 5793.6 5918.6 7687.7 7871.6 7913.5 7725.8 7794.6 7811.3 7819.5 7831.5 7800.8 7839.8 7856.8 7862.1 7865.9 7789.1 7835.9 7839.8 7847.2 7850.4 7751.0 7766.8 7769.2 7810.5 7816.9 36989.3 37215.8 37650.8 37668.0 37747.4 3531.7 3563.6 3570.4 3575.5 3582.4 31260.7 31309.2 31316.0 31554.1 31587.0 4999.7 5006.3 5012.1 5048.5 5062.5 196701.0 198243.0 198266.0 198815.0 198848.0 48408.5 48708.3 48835.3 48934.8 48944.8 50345.7 50456.0 50662.2 50719.0 50794.7 16066.1 16184.3 16395.4 16396.4 16520.9 11438.2 11678.6 13530.1 13669.1 13903.4 13200.0 13223.3 13298.3 13367.3 13423.4 5175.0 5220.6 5224.8 5236.4 5286.4 992.5 1005.6 1022.0 1036.2 1042.7 22771.4 23660.9 23700.6 23760.0 24027.0 1143.1 1149.9 1150.4 1151.7 1153.5 16506.4 16646.5 16708.9 16954.3 17265.8 220190.0 220193.0 220255.0 220317.0 220324.0 56191.0 56306.7 56552.0 56618.0 56660.4 1422.7 1439.9 1481.5 1509.4 1515.1 26439.7 27129.6 27385.3 27515.4 27541.6 37671.4 38121.8 38128.8 38199.4 38219.6 185915.0 186154.0 186771.0 186800.0 187249.0 29154.9 29860.0 33644.3 33854.2 33885.8 37958.2 38263.8 38580.2 38972.6 40030.7 32740.3 32923.8 33101.2 33583.5 33995.7 32193.0 32207.4 32248.5 32668.3 35219.0 38447.4 38981.2 39119.8 39196.0 39240.6 33514.3 33530.3 33841.5 33928.7 34686.7 24640.5 24717.0 24812.9 24981.8 25302.6 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | [#2] jquery.html Cycles:180 Average:36170.04 Median:21549.01 stddev:85425.06 (396.4%) stddev-sans-first:85622.89 03:05:51 INFO - PID 3665 | Values: 576.4 590.1 591.5 593.6 598.3 21321.5 22088.3 22121.1 22140.3 22899.2 25684.9 27803.9 27841.4 27863.7 27872.6 6600.9 6744.9 6782.6 6787.4 6787.7 6070.2 6501.3 6646.4 6655.5 6701.8 6492.8 6499.9 6508.1 6509.0 6509.6 6489.1 6495.4 6501.2 6504.3 6529.0 6075.2 6081.3 6082.2 6084.6 6090.1 29593.7 30380.7 30992.8 31698.7 32086.8 1872.3 1940.5 1956.6 1957.0 1960.7 19231.8 19827.3 19849.6 19849.7 19877.3 2376.4 2439.5 2441.0 2499.4 2507.6 136828.0 143603.6 144390.3 144406.0 144814.0 14551.6 15506.5 15620.0 15671.9 15787.4 23749.2 24358.8 24433.8 24455.0 25279.6 10680.2 10727.2 10782.7 10807.4 10909.7 10013.1 10087.8 10090.2 10164.0 10221.4 9738.8 9950.4 10026.1 10102.5 10138.7 2769.1 2795.8 2808.5 2812.1 2864.7 952.4 965.1 971.4 975.5 982.1 20145.8 20595.6 20882.9 20936.3 21005.3 1023.5 1033.3 1035.7 1048.4 1053.3 11264.8 11330.2 11361.1 11498.8 11546.7 489838.0 503881.0 505641.0 511605.0 518807.0 113451.4 116239.0 123209.4 123394.0 123527.0 1211.0 1293.5 1294.3 1295.3 1296.9 21575.2 21834.3 22121.0 22254.4 22367.3 58842.4 59592.0 62144.0 62490.7 64148.0 79916.0 79927.6 80082.2 80331.6 80996.0 15051.2 15258.9 15417.5 15424.0 15447.5 21172.3 21522.8 23991.8 24207.4 24427.0 17236.9 17679.9 17711.5 18912.0 19137.0 15593.9 16086.5 16497.6 16631.6 17324.7 16772.4 17587.6 17641.2 17839.5 17930.8 15275.9 15369.5 15371.0 15602.4 15618.6 17050.6 17158.7 17265.5 17279.3 17294.7 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | [#3] mootools.html Cycles:180 Average:8713.68 Median:2474.02 stddev:5975.15 (241.5%) stddev-sans-first:5966.16 03:05:51 INFO - PID 3665 | Values: 1330.8 1381.3 1386.3 1397.3 1404.7 13638.4 14150.0 14162.9 14190.8 14282.8 12956.9 13432.3 13750.4 13766.5 13771.5 2649.4 2688.8 2705.7 2708.6 2708.7 2459.2 2572.8 2601.8 2668.5 2672.7 2513.9 2531.5 2534.9 2537.0 2537.0 2488.9 2489.2 2491.9 2500.4 2516.6 2389.1 2395.5 2410.2 2410.7 2413.8 13986.9 14203.4 14256.3 14280.4 14285.1 7667.0 7966.8 7972.7 7980.6 7986.2 5131.8 5203.7 5281.3 5330.1 5370.9 1818.2 1829.9 1831.2 1878.7 1891.1 23372.4 23457.5 23478.6 23521.3 23698.4 6416.4 6593.5 6661.2 6706.0 6772.2 15938.5 15984.9 15996.0 16012.4 16029.7 7418.9 7728.3 7742.8 7743.6 7748.3 6977.3 7147.3 7183.2 7244.6 7254.6 5050.2 5223.8 5243.5 5275.7 5291.8 1310.6 1334.6 1543.9 1550.5 1556.6 784.2 805.0 807.4 809.5 810.1 7990.3 8028.5 8114.7 8127.5 8190.5 721.2 722.4 728.4 730.3 810.3 4938.9 5245.9 5409.8 5447.4 5488.2 19659.4 19902.2 20110.7 20337.4 20352.4 18769.8 19459.8 19679.0 19700.7 19810.8 11010.5 11218.6 11234.0 11252.0 11360.9 7759.0 7945.2 8043.4 8115.2 8337.0 15942.4 15952.0 15981.6 15989.8 16077.5 16392.7 16505.2 16550.3 16747.7 16948.0 11563.2 11882.9 11894.0 11901.8 11908.3 12453.8 12826.6 12884.7 13001.7 13067.3 10654.9 10815.7 10883.6 10949.3 11003.9 10240.2 10529.6 10534.6 10687.0 10734.2 8768.6 8865.5 8867.2 8939.6 8941.1 6738.2 6799.9 6832.5 6866.9 6879.7 6900.9 6907.9 6932.0 6969.3 7019.6 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | [#4] prototype.html Cycles:180 Average:5410.94 Median:5985.95 stddev:1512.02 (25.3%) stddev-sans-first:1470.47 03:05:51 INFO - PID 3665 | Values: 490.4 508.4 521.9 524.5 531.2 6099.5 6123.2 6135.4 6136.6 6137.3 5766.4 5826.9 5901.0 5911.9 6006.1 4892.1 4928.4 4945.8 4949.1 4958.4 4778.9 4855.5 4892.3 4919.5 4929.6 4775.5 4784.5 4845.4 4882.1 4896.0 4834.9 4835.8 4862.0 4894.4 4908.4 4423.8 4442.0 4478.1 4483.8 4486.9 5971.7 5974.8 5997.1 5997.9 6028.8 5587.3 5591.8 5633.4 5685.4 5688.3 6344.5 6369.7 6407.1 6434.4 6450.5 4750.0 4842.8 4849.2 4867.6 4876.9 6670.0 6681.2 6738.3 6759.3 6818.3 4890.6 4911.2 4922.4 4930.8 4977.8 5029.6 5037.9 5051.6 5066.3 5068.3 5589.9 5651.2 5660.3 5660.7 5691.2 6422.2 6462.3 6465.7 6480.3 6484.9 1642.7 1687.8 1692.5 1703.0 1743.6 1199.7 1221.5 1222.0 1223.2 1224.7 5617.2 5637.8 5650.2 5660.4 5671.4 6404.5 6457.0 6524.9 6577.9 6610.8 5618.8 5623.5 5630.3 5681.2 5692.6 3424.2 3489.1 3503.0 3518.6 3524.2 6252.7 6314.8 6350.8 6374.6 6456.3 6774.1 6803.8 6806.5 6850.6 6883.7 6392.2 6408.8 6419.5 6427.8 6457.5 6595.6 6599.9 6661.0 6671.6 6691.7 6441.9 6453.3 6534.4 6538.8 6547.0 6380.8 6415.2 6446.8 6447.0 6447.2 4867.3 4914.8 4931.8 4936.7 4966.3 6614.7 6617.4 6621.2 6641.5 6653.9 6351.7 6378.9 6393.6 6402.6 6412.2 6371.0 6392.3 6412.4 6423.0 6487.5 6006.6 6141.1 6260.9 6263.7 6278.2 6247.3 6432.5 6441.8 6444.3 6450.3 6228.8 6262.8 6266.8 6269.0 6284.7 03:05:51 INFO - PID 3665 | 03:05:51 INFO - PID 3665 | [#5] yui.html Cycles:180 Average:22838.63 Median:17920.78 stddev:31288.55 (174.6%) stddev-sans-first:31332.90 03:05:51 INFO - PID 3665 | Values: 886.8 905.5 915.3 926.6 930.1 18989.7 19865.8 19897.6 19926.1 19958.3 21055.4 21913.0 21946.1 21953.1 21992.6 1047.5 1067.4 1068.7 1070.0 1070.4 1004.5 1047.6 1053.2 1063.5 1067.1 1111.6 1114.5 1114.6 1114.7 1115.3 1110.6 1114.0 1115.1 1117.2 1117.3 810.1 815.1 815.4 815.5 815.7 17563.6 17879.7 17961.8 18021.7 18076.4 21712.0 21811.1 22179.2 22200.7 22302.2 16754.8 17017.7 17065.9 17246.7 17255.3 3534.9 3567.7 3568.2 3569.8 3580.5 129295.0 130339.0 131040.0 133840.0 134126.0 16776.4 17149.2 17636.7 17799.9 17968.6 32381.0 32536.7 32747.0 32975.0 33170.0 8978.6 9032.8 9190.0 9190.9 9198.1 3729.9 4249.1 4343.6 4349.1 4351.0 4389.5 5778.2 5978.6 5987.6 6001.2 1117.8 1148.9 1161.7 1171.7 1175.2 552.2 562.2 568.1 590.3 591.1 11129.4 11657.7 11716.9 11820.2 11972.2 538.5 543.6 557.3 571.2 575.1 5194.4 5868.5 5919.2 5945.6 6009.0 101055.5 104430.5 105214.5 105559.0 109584.5 92976.0 94337.0 94732.5 95893.0 99298.0 80532.0 82338.0 82753.6 82880.2 83802.6 11197.7 11352.2 11457.5 11637.0 11828.4 37022.8 37179.8 37252.0 38510.6 39328.6 47776.3 48625.0 49780.0 50333.2 50908.7 16987.2 17332.2 17435.9 17514.1 17558.9 17266.2 17276.2 17384.4 17424.4 17448.7 16742.7 16822.5 16852.3 16951.2 17022.7 16578.1 17079.6 17238.8 17448.0 17615.6 17095.1 17131.2 17209.7 17323.0 17579.6 12077.9 12141.8 12210.4 12279.0 12419.3 12787.6 13178.3 13301.2 13358.3 13409.7 03:05:51 INFO - PID 3665 | -------- Summary: end -------- 03:05:51 INFO - PID 3665 | 03:05:52 INFO - TEST-INFO | 3665: exit 0 03:05:52 INFO - TEST-OK | dromaeo_css | took 1115355ms 03:05:52 INFO - TEST-START | kraken 03:05:52 INFO - Initialising browser for kraken test... 03:05:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39035/getInfo.html -profile /tmp/tmpcBgz8L/profile 03:05:52 INFO - TEST-INFO | started process 4039 (/builds/slave/test/build/application/firefox/firefox http://localhost:39035/getInfo.html) 03:05:57 INFO - TEST-INFO | 4039: exit 0 03:05:58 INFO - Browser initialized. 03:05:58 INFO - Running cycle 1/1 for kraken test... 03:05:58 INFO - TEST-INFO | started process 4264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcBgz8L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:59 INFO - PID 4264 | 03:05:59 INFO - PID 4264 | (/builds/slave/test/build/application/firefox/firefox:4318): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:05:59 INFO - PID 4264 | 03:06:09 INFO - PID 4264 | RSS: Main: 173592576 03:06:09 INFO - PID 4264 | 03:06:09 INFO - PID 4264 | serialization: Helvetica 03:06:09 INFO - PID 4264 | serialization: Arial 03:06:12 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39035/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:13 INFO - PID 4264 | RSS: Main: 178536448 03:06:13 INFO - PID 4264 | 03:06:13 INFO - PID 4264 | serialization: Helvetica 03:06:13 INFO - PID 4264 | serialization: Arial 03:06:15 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39035/tests/kraken/driver.html?testName=audio-dft) 03:06:16 INFO - PID 4264 | RSS: Main: 179548160 03:06:16 INFO - PID 4264 | 03:06:16 INFO - PID 4264 | serialization: Helvetica 03:06:16 INFO - PID 4264 | serialization: Arial 03:06:19 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39035/tests/kraken/driver.html?testName=audio-fft) 03:06:20 INFO - PID 4264 | RSS: Main: 174104576 03:06:20 INFO - PID 4264 | 03:06:20 INFO - PID 4264 | serialization: Helvetica 03:06:20 INFO - PID 4264 | serialization: Arial 03:06:22 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39035/tests/kraken/driver.html?testName=audio-oscillator) 03:06:22 INFO - PID 4264 | RSS: Main: 174600192 03:06:22 INFO - PID 4264 | 03:06:22 INFO - PID 4264 | serialization: Helvetica 03:06:22 INFO - PID 4264 | serialization: Arial 03:06:25 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:25 INFO - PID 4264 | RSS: Main: 174968832 03:06:25 INFO - PID 4264 | 03:06:25 INFO - PID 4264 | serialization: Helvetica 03:06:25 INFO - PID 4264 | serialization: Arial 03:06:28 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39035/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:29 INFO - PID 4264 | RSS: Main: 177254400 03:06:29 INFO - PID 4264 | 03:06:29 INFO - PID 4264 | serialization: Helvetica 03:06:29 INFO - PID 4264 | serialization: Arial 03:06:33 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39035/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:33 INFO - PID 4264 | RSS: Main: 176451584 03:06:33 INFO - PID 4264 | 03:06:33 INFO - PID 4264 | serialization: Helvetica 03:06:33 INFO - PID 4264 | serialization: Arial 03:06:36 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39035/tests/kraken/driver.html?testName=json-parse-financial) 03:06:37 INFO - PID 4264 | RSS: Main: 177672192 03:06:37 INFO - PID 4264 | 03:06:37 INFO - PID 4264 | serialization: Helvetica 03:06:37 INFO - PID 4264 | serialization: Arial 03:06:38 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:39 INFO - PID 4264 | RSS: Main: 177692672 03:06:39 INFO - PID 4264 | 03:06:39 INFO - PID 4264 | serialization: Helvetica 03:06:39 INFO - PID 4264 | serialization: Arial 03:06:41 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:42 INFO - PID 4264 | RSS: Main: 174739456 03:06:42 INFO - PID 4264 | 03:06:42 INFO - PID 4264 | serialization: Helvetica 03:06:42 INFO - PID 4264 | serialization: Arial 03:06:44 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:45 INFO - PID 4264 | RSS: Main: 174821376 03:06:45 INFO - PID 4264 | 03:06:45 INFO - PID 4264 | serialization: Helvetica 03:06:45 INFO - PID 4264 | serialization: Arial 03:06:47 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:48 INFO - PID 4264 | RSS: Main: 175640576 03:06:48 INFO - PID 4264 | 03:06:48 INFO - PID 4264 | serialization: Helvetica 03:06:48 INFO - PID 4264 | serialization: Arial 03:06:51 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:52 INFO - PID 4264 | RSS: Main: 175374336 03:06:52 INFO - PID 4264 | 03:06:52 INFO - PID 4264 | serialization: Helvetica 03:06:52 INFO - PID 4264 | serialization: Arial 03:06:54 INFO - PID 4264 | Cycle 1(1): loaded http://localhost:39035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39035/tests/kraken/driver.html?testName=ai-astar) 03:06:54 INFO - PID 4264 | RSS: Main: 177041408 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | __start_tp_report 03:06:54 INFO - PID 4264 | _x_x_mozilla_page_load 03:06:54 INFO - PID 4264 | _x_x_mozilla_page_load_details 03:06:54 INFO - PID 4264 | |i|pagename|runs| 03:06:54 INFO - PID 4264 | |0;ai-astar;99;114;99;107;107;108;114;100;108;109 03:06:54 INFO - PID 4264 | |1;audio-beat-detection;150;115;154;186;118;151;144;118;165;123 03:06:54 INFO - PID 4264 | |2;audio-dft;163;165;163;163;162;168;179;169;161;165 03:06:54 INFO - PID 4264 | |3;audio-fft;76;77;75;165;76;75;74;77;165;75 03:06:54 INFO - PID 4264 | |4;audio-oscillator;82;78;143;78;79;78;133;79;84;124 03:06:54 INFO - PID 4264 | |5;imaging-gaussian-blur;114;114;113;116;114;114;119;115;114;119 03:06:54 INFO - PID 4264 | |6;imaging-darkroom;150;150;154;149;151;150;151;158;156;154 03:06:54 INFO - PID 4264 | |7;imaging-desaturate;94;95;95;94;98;99;94;94;94;94 03:06:54 INFO - PID 4264 | |8;json-parse-financial;53;56;54;53;54;54;53;53;54;53 03:06:54 INFO - PID 4264 | |9;json-stringify-tinderbox;53;52;55;53;56;62;53;54;59;53 03:06:54 INFO - PID 4264 | |10;stanford-crypto-aes;95;89;78;103;97;89;79;89;95;77 03:06:54 INFO - PID 4264 | |11;stanford-crypto-ccm;133;129;132;128;132;141;128;135;142;162 03:06:54 INFO - PID 4264 | |12;stanford-crypto-pbkdf2;176;185;180;173;184;181;177;176;186;182 03:06:54 INFO - PID 4264 | |13;stanford-crypto-sha256-iterative;68;67;65;70;64;67;69;64;64;68 03:06:54 INFO - PID 4264 | __end_tp_report 03:06:54 INFO - PID 4264 | __start_cc_report 03:06:54 INFO - PID 4264 | _x_x_mozilla_cycle_collect,972 03:06:54 INFO - PID 4264 | __end_cc_report 03:06:54 INFO - PID 4264 | __startTimestamp1502014014377__endTimestamp 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | ------- Summary: start ------- 03:06:54 INFO - PID 4264 | Number of tests: 14 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#0] ai-astar Cycles:10 Average:106.50 Median:111.50 stddev:5.56 (5.0%) stddev-sans-first:5.20 03:06:54 INFO - PID 4264 | Values: 99.0 114.0 99.0 107.0 107.0 108.0 114.0 100.0 108.0 109.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:150.50 stddev:23.57 (15.7%) stddev-sans-first:24.84 03:06:54 INFO - PID 4264 | Values: 150.0 115.0 154.0 186.0 118.0 151.0 144.0 118.0 165.0 123.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:5.29 (3.2%) stddev-sans-first:5.51 03:06:54 INFO - PID 4264 | Values: 163.0 165.0 163.0 163.0 162.0 168.0 179.0 169.0 161.0 165.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:37.70 (49.9%) stddev-sans-first:39.45 03:06:54 INFO - PID 4264 | Values: 76.0 77.0 75.0 165.0 76.0 75.0 74.0 77.0 165.0 75.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:78.50 stddev:26.36 (33.6%) stddev-sans-first:27.48 03:06:54 INFO - PID 4264 | Values: 82.0 78.0 143.0 78.0 79.0 78.0 133.0 79.0 84.0 124.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:114.50 stddev:2.15 (1.9%) stddev-sans-first:2.24 03:06:54 INFO - PID 4264 | Values: 114.0 114.0 113.0 116.0 114.0 114.0 119.0 115.0 114.0 119.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:152.50 stddev:3.02 (2.0%) stddev-sans-first:3.09 03:06:54 INFO - PID 4264 | Values: 150.0 150.0 154.0 149.0 151.0 150.0 151.0 158.0 156.0 154.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.85 (2.0%) stddev-sans-first:1.92 03:06:54 INFO - PID 4264 | Values: 94.0 95.0 95.0 94.0 98.0 99.0 94.0 94.0 94.0 94.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.95 (1.8%) stddev-sans-first:0.97 03:06:54 INFO - PID 4264 | Values: 53.0 56.0 54.0 53.0 54.0 54.0 53.0 53.0 54.0 53.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:54.50 stddev:3.20 (5.9%) stddev-sans-first:3.31 03:06:54 INFO - PID 4264 | Values: 53.0 52.0 55.0 53.0 56.0 62.0 53.0 54.0 59.0 53.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:89.00 stddev:8.80 (9.9%) stddev-sans-first:9.07 03:06:54 INFO - PID 4264 | Values: 95.0 89.0 78.0 103.0 97.0 89.0 79.0 89.0 95.0 77.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:134.00 stddev:10.30 (7.7%) stddev-sans-first:10.86 03:06:54 INFO - PID 4264 | Values: 133.0 129.0 132.0 128.0 132.0 141.0 128.0 135.0 142.0 162.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:181.50 stddev:4.37 (2.4%) stddev-sans-first:4.39 03:06:54 INFO - PID 4264 | Values: 176.0 185.0 180.0 173.0 184.0 181.0 177.0 176.0 186.0 182.0 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:2.22 (3.3%) stddev-sans-first:2.30 03:06:54 INFO - PID 4264 | Values: 68.0 67.0 65.0 70.0 64.0 67.0 69.0 64.0 64.0 68.0 03:06:54 INFO - PID 4264 | -------- Summary: end -------- 03:06:54 INFO - PID 4264 | 03:06:54 INFO - PID 4264 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:06:55 INFO - TEST-INFO | 4264: exit 0 03:06:55 INFO - TEST-OK | kraken | took 63022ms 03:06:55 INFO - SUITE-END | took 1178s 03:06:55 INFO - Completed test suite (00:19:38) 03:06:55 INFO - javascript benchmark 03:06:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8472.257089347233, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.267442151093, 3186.6654001329844, 3195.792273502222, 3205.374951884382, 3220.3398303347817, 6237.3138954715005, 6292.874142517158, 6339.207599050119, 6365.140706004688, 6370.203724534434, 6133.570650054498, 6257.71840267188, 6263.154474145989, 6270.686465676721, 6299.464545513637, 5704.515116215116, 5737.311522617292, 5756.74094665739, 5771.567132465061, 5857.092150716646, 5810.0, 5821.068629019358, 5866.853328666796, 5893.941060589404, 5930.525557955353, 5593.8601534961745, 5750.166225897243, 5750.1949727038245, 5776.59563830532, 5793.681347525884, 5425.647332923348, 5767.33675627304, 5853.47318741311, 5856.326522449909, 5859.1504231886565, 5631.9718401408145, 5647.040003199466, 5654.688992105433, 5681.488666020036, 5727.312722473288, 6121.173641558422, 6187.288461826903, 6193.690315484253, 6210.627362358273, 6214.533909956771, 6804.523683342168, 6817.863642727118, 6819.045333653293, 6820.727170913157, 6821.658917054127, 6791.286914873916, 6794.388505034522, 6804.55770374924, 6898.896516552256, 6907.240203577602, 6155.446009859134, 6287.528435367274, 6309.87380252397, 6368.363163683594, 6378.808635740888, 6961.338672826073, 7003.159620845531, 7073.681684324218, 7086.751963681247, 7095.254998225112, 6617.0, 6682.0, 6703.262641109474, 6714.3957043866285, 6715.865682686319, 6733.8653226935185, 6745.898811517831, 6805.625690587065, 6841.076454678555, 6865.347791959756, 6590.176227971504, 6599.901001484982, 6667.19993600771, 6723.0923825283935, 6756.189257289157, 6647.734090636417, 6710.1947766267385, 6715.059891615178, 6724.428423583952, 6726.327367263332, 5446.400895901447, 5491.28613280279, 5506.531944784658, 5508.3114610673665, 5520.392756796749, 4688.156131896291, 4712.057588482317, 4732.550407711331, 4775.594074503706, 4780.259059845729, 5781.739821708034, 5864.472197502245, 5868.325142608569, 5889.4699477046415, 5893.381194974466, 6740.595564266159, 6750.3249675033085, 6757.425618822357, 6827.317268273133, 6858.971154326891, 5689.743961521659, 5773.88452230953, 5781.4507621775865, 5783.797567085132, 5820.0, 5962.07587823888, 5967.8209653710455, 5981.910271345933, 5982.760689572368, 5995.820125396245, 6509.0, 6513.576617519846, 6528.869422611521, 6539.738410463528, 6550.901736473957, 6710.66446677674, 6832.248452670302, 6844.623545704835, 6911.75808846688, 6919.7232110715, 6492.740290388331, 6575.572587781779, 6589.143411356493, 6633.535652504278, 6643.30245324234, 6546.214454265519, 6594.901076483952, 6682.2649508555, 6685.899711504234, 6707.228668703162, 6636.402723754885, 6660.900951342974, 6663.600183988976, 6677.699503522256, 6710.060591517094, 6421.389967953037, 6433.356664333529, 6439.034144878118, 6444.871102578016, 6561.967190164019, 6584.868302633825, 6629.966850165718, 6634.469242460688, 6676.198856137295, 6721.059051732859, 6401.167848179894, 6516.380943810331, 6523.380278873499, 6543.934560654333, 6638.336166383516, 6554.115194448879, 6615.0, 6628.767993120217, 6718.059471674067, 6727.192736871607, 6442.645654489048, 6477.708503117466, 6485.643289619116, 6511.283758786435, 6515.934840651533], "value": 6164.0703982869245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.2329125684971, 849.8045449546605, 883.3772190605622, 883.8895138107737, 1127.8590176227972, 30542.69457305426, 42193.578064219386, 42932.35601465977, 43026.56973430265, 43043.56956430435, 31687.207819804516, 42870.571294287125, 43136.352954705624, 43458.13083738331, 43522.56477435225, 5793.594448388625, 5918.556108291874, 7687.692492300302, 7871.567063811488, 7913.485623434487, 7725.845483090335, 7794.571298578576, 7811.336036436881, 7819.530828150329, 7831.451798374088, 7800.804979875492, 7839.843203135933, 7856.7642970710685, 7862.095858976205, 7865.882011769828, 7789.065312162548, 7835.921640783577, 7839.804004899895, 7847.176046515091, 7850.371970242367, 7751.0, 7766.805829854242, 7769.223077692242, 7810.492317999312, 7816.921830781676, 36989.260214795555, 37215.81392093049, 37650.81174594109, 37668.0, 37747.433788493196, 3531.699805516534, 3563.6436356364416, 3570.357335679577, 3575.4994300797907, 3582.373084710165, 31260.687393126005, 31309.217269568217, 31316.0, 31554.053378398683, 31587.0, 4999.700017998895, 5006.299118123466, 5012.097822391968, 5048.545630893201, 5062.54437100659, 196701.0, 198243.0, 198266.0, 198815.0, 198848.0057599717, 48408.515914841104, 48708.26937595939, 48835.267470987965, 48934.75532622314, 48944.7552762241, 50345.74827125841, 50456.0, 50662.22682206105, 50719.0, 50794.74602626963, 16066.11636359988, 16184.271707773178, 16395.42616008458, 16396.426125085563, 16520.917395412947, 11438.199326047263, 11678.591249306233, 13530.120542164728, 13669.111507752163, 13903.4438622456, 13200.0, 13223.33883305831, 13298.268595227355, 13367.331633418291, 13423.3959471824, 5175.0, 5220.634555581073, 5224.791008359623, 5236.39781425141, 5286.418493965661, 992.5136683025265, 1005.6128390569537, 1021.9642312519026, 1036.2176556699644, 1042.6871938418444, 22771.40600158006, 23660.88169559141, 23700.64449033266, 23760.0, 24027.038918443417, 1143.0512674480162, 1149.9080073594093, 1150.442035612727, 1151.6660168551193, 1153.5155234801402, 16506.42227522031, 16646.50302454617, 16708.916455417646, 16954.321827127023, 17265.827341726672, 220190.0, 220193.0, 220255.0, 220317.0, 220324.0, 56191.0, 56306.71846640741, 56552.0, 56617.99999999918, 56660.43339566634, 1422.7012327411153, 1439.9496017639333, 1481.525911708243, 1509.3509790790065, 1515.0758037597277, 26439.735602643726, 27129.558339749517, 27385.31536711598, 27515.44969100647, 27541.586876196474, 37671.434928475544, 38121.80939095287, 38128.80935595415, 38199.42700859545, 38219.61780382161, 185915.0, 186154.0, 186771.0, 186800.0, 187249.0, 29154.854225728737, 29860.0, 33644.32711345809, 33854.153646159044, 33885.830570846985, 37958.24083518369, 38263.80868095642, 38580.228395432496, 38972.61027389803, 40030.65476046037, 32740.34519309648, 32923.835380822944, 33101.17247068843, 33583.49624755582, 33995.66004340024, 32193.0, 32207.35585288328, 32248.516272256406, 32668.346633067682, 35219.0, 38447.423288651255, 38981.220375591765, 39119.80440097781, 39196.0, 39240.6075939237, 33514.32971340511, 33530.32939341248, 33841.49237761485, 33928.66071339255, 34686.65313346935, 24640.50718985646, 24717.0, 24812.87593562093, 24981.75018249794, 25302.620460693473], "value": 17379.895977576205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3688760806915, 590.1148277583625, 591.517912900986, 593.5904226084002, 598.2641351138099, 21321.466963325925, 22088.33734987953, 22121.115155393785, 22140.33578992633, 22899.198528051522, 25684.87157564214, 27803.860980695117, 27841.443171136565, 27863.721362786368, 27872.581911271296, 6600.93399066008, 6744.898826517606, 6782.593044417351, 6787.389134977851, 6787.660616969157, 6070.210872586557, 6501.317361677026, 6646.401823835854, 6655.46756259498, 6701.798946031627, 6492.805215843508, 6499.9350006500035, 6508.121403610499, 6509.0, 6509.609423434586, 6489.123968264271, 6495.415412612864, 6501.154849869534, 6504.252011018746, 6528.967355163241, 6075.17985072014, 6081.300650425169, 6082.239720034996, 6084.60450070744, 6090.086487026937, 29593.70406295931, 30380.69619303801, 30992.845035774677, 31698.683013169804, 32086.839565802256, 1872.3446793622122, 1940.4566721318054, 1956.5695546979641, 1956.9706454403054, 1960.6862901935622, 19231.807681923143, 19827.30604428838, 19849.603007939906, 19849.702254466196, 19877.30429434977, 2376.4475131006793, 2439.475512764764, 2440.9511809763885, 2499.3501689560844, 2507.6113202453466, 136828.0, 143603.56396436007, 144390.27804861014, 144406.0, 144814.0, 14551.636209094646, 15506.5348039559, 15620.0, 15671.921640391725, 15787.447439339569, 23749.168779092994, 24358.75641243565, 24433.75566244315, 24455.0, 25279.620805687562, 10680.198985075995, 10727.249092563601, 10782.67651970442, 10807.35155890649, 10909.672709818718, 10013.148882345082, 10087.848682269772, 10090.192784577217, 10164.0, 10221.386716797017, 9738.805223895482, 9950.35322704022, 10026.147777438853, 10102.494875256354, 10138.695839124837, 2769.1000424862, 2795.8332292473087, 2808.466391385671, 2812.1141840320643, 2864.74217320438, 952.3904700991233, 965.0976337124811, 971.3589031239349, 975.4634950777045, 982.1308142294121, 20145.798542014687, 20595.58808823815, 20882.895585522278, 20936.267230646856, 21005.264815731683, 1023.469912480831, 1033.3438266700548, 1035.6841163445072, 1048.4390850894736, 1053.3100818963592, 11264.831027534594, 11330.150238732129, 11361.14791390649, 11498.77002459963, 11546.653600392001, 489838.0, 503881.0, 505641.0, 511605.0, 518807.0, 113451.43274283576, 116239.0, 123209.38395307965, 123394.0, 123527.0, 1210.9515619375302, 1293.5084667826166, 1294.2816736711216, 1295.3393769177787, 1296.8767967043116, 21575.24486643023, 21834.344969650934, 22121.0, 22254.443638909157, 22367.328980130624, 58842.4115758854, 59592.0, 62144.0, 62490.687546561974, 64148.0, 79916.0, 79927.60036199781, 80082.1991780098, 80331.59834200791, 80996.0, 15051.247437628293, 15258.923705381401, 15417.460388886335, 15424.0, 15447.459338923532, 21172.25897093656, 21522.784772152703, 23991.760082398952, 24207.394815129763, 24427.0, 17236.913815430842, 17679.911600441916, 17711.46865594034, 18912.0, 19137.0, 15593.922030389775, 16086.517404477885, 16497.587560310607, 16631.584210394838, 17324.653506930044, 16772.412965546147, 17587.56031099233, 17641.206145723216, 17839.46481605554, 17930.820691792916, 15275.923620382271, 15369.538913832603, 15371.0, 15602.375904963674, 15618.594326510669, 17050.573735656708, 17158.65682686314, 17265.482035538953, 17279.308827646753, 17294.65410691754], "value": 12335.6164277513, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.793726972319, 1381.2610253514372, 1386.3345594114824, 1397.3432486731235, 1404.6839461121242, 13638.38627261773, 14150.0, 14162.858371416283, 14190.787138192922, 14282.785758213622, 12956.93521532391, 13432.261225632587, 13750.38123284452, 13766.518171863987, 13771.517996870112, 2649.3641526033757, 2688.7580117789394, 2705.715899830519, 2708.6072519484665, 2708.7426694463993, 2459.1761759810397, 2572.7941764658876, 2601.778848797845, 2668.5463471209846, 2672.665916760405, 2513.949721005579, 2531.4683916377585, 2534.936626584332, 2537.0232460502657, 2537.023246050275, 2488.8631125288102, 2489.166129346662, 2491.9377015574755, 2500.3874050857657, 2516.6476693262957, 2389.0802041214083, 2395.5089206712582, 2410.20463247128, 2410.68661074061, 2413.8310318277727, 13986.930065349608, 14203.431862725478, 14256.28718564078, 14280.357383917748, 14285.071470354498, 7667.0, 7966.840663186762, 7972.681092756283, 7980.600969951479, 7986.161453047404, 5131.794728210867, 5203.713795741232, 5281.287026251483, 5330.120530112566, 5370.8925821483745, 1818.1818181818103, 1829.871908966373, 1831.2125785912053, 1878.6806242938733, 1891.0828248299563, 23372.415689607897, 23457.53084938309, 23478.64782028271, 23521.29436116919, 23698.40753981147, 6416.35836416364, 6593.505487088391, 6661.233958094881, 6705.966470167716, 6772.153480814898, 15938.521844344688, 15984.920075399548, 15996.0, 16012.439564615415, 16029.679406411806, 7418.888716669254, 7728.343090837229, 7742.845143097106, 7743.612819359009, 7748.263914928073, 6977.302269772982, 7147.2852714728115, 7183.209846916835, 7244.637768111679, 7254.5647261164495, 5050.191969284897, 5223.817166399158, 5243.501867322599, 5275.683458992473, 5291.841244762663, 1310.6461255460972, 1334.6329759316266, 1543.9382424702885, 1550.4960887711538, 1556.5797234746556, 784.2197013971136, 805.0299389235956, 807.3904202327205, 809.5021561739605, 810.0522388805113, 7990.320822730133, 8028.518288902567, 8114.715984940617, 8127.471714338549, 8190.467619604707, 721.1742554774859, 722.357102179061, 728.3845150847526, 730.302561054192, 810.3031393002013, 4938.9012219755405, 5245.921311180336, 5409.756560954766, 5447.428020057916, 5488.204210389471, 19659.41021769349, 19902.203911843655, 20110.69833952492, 20337.389878303675, 20352.389428317176, 18769.812301876806, 19459.8054019458, 19679.0, 19700.70448943267, 19810.801891981184, 11010.50452729629, 11218.607348742755, 11234.0, 11252.043576295942, 11360.886391136148, 7758.9612051939375, 7945.205479452008, 8043.436959412785, 8115.188481151838, 8337.0, 15942.362305508113, 15952.0, 15981.600459988593, 15989.8401015993, 16077.517674469784, 16392.67214655724, 16505.17474126265, 16550.337986480405, 16747.74878376801, 16948.0, 11563.190576659554, 11882.940585297018, 11894.0, 11901.821472677744, 11908.285502869856, 12453.813192801934, 12826.55107071248, 12884.677883052624, 13001.739965200453, 13067.34663266852, 10654.89345106539, 10815.67552973412, 10883.619073332395, 10949.288296260718, 11003.944980275048, 10240.180785537288, 10529.57881684724, 10534.57861685524, 10687.038166565046, 10734.19493537972, 8768.561571921506, 8865.512396818236, 8867.157620026088, 8939.553022348986, 8941.105889411007, 6738.157730283715, 6799.89800153008, 6832.453403727789, 6866.896996544956, 6879.724811007503, 6900.861982760417, 6907.896381554381, 6932.0, 6969.337912898267, 7019.613921234177], "value": 6289.455433395235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.44284397039394, 508.40008789628223, 521.9243209734589, 524.5384062025418, 531.1554628141255, 6099.481544068754, 6123.203983482153, 6135.447809697132, 6136.601120927136, 6137.263528376596, 5766.423357664232, 5826.883462330751, 5900.970495147529, 5911.940880591193, 6006.069059295805, 4892.119418504668, 4928.383952005999, 4945.752712364385, 4949.13390156722, 4958.429780575226, 4778.880527986811, 4855.465898751135, 4892.266160075981, 4919.499552636445, 4929.556339929406, 4775.474697783241, 4784.521547845223, 4845.394325709286, 4882.121218180726, 4895.971845912362, 4834.903301933941, 4835.782389792468, 4861.975690121527, 4894.4371397289415, 4908.361912951312, 4423.845165419195, 4441.955580444186, 4478.0596074824325, 4483.843065492692, 4486.865394038184, 5971.671558064305, 5974.820755377345, 5997.070454079581, 5997.910031349533, 6028.788992385289, 5587.273654424939, 5591.776328946878, 5633.436656334334, 5685.431456854323, 5688.345840228344, 6344.524160687967, 6369.713362898634, 6407.135036770023, 6434.388733070351, 6450.451711604473, 4749.9762501187615, 4842.83050093245, 4849.248366503198, 4867.610591152699, 4876.926846097312, 6670.0, 6681.198256209237, 6738.292479289653, 6759.256481787, 6818.28408017156, 4890.608751299887, 4911.16510193268, 4922.433920099163, 4930.827421040318, 4977.776000080005, 5029.622778291569, 5037.924431133536, 5051.595872330205, 5066.290719299301, 5068.315777370008, 5589.916151257735, 5651.180578816049, 5660.29246344207, 5660.660360378391, 5691.231683722727, 6422.165118534654, 6462.289148193695, 6465.676716164173, 6480.287168411471, 6484.902726459107, 1642.7125253080662, 1687.7721507596564, 1692.4753326468833, 1703.0, 1743.616404391032, 1199.6521008907494, 1221.4564518789055, 1221.955228279808, 1223.1682455929874, 1224.69994851262, 5617.157426386075, 5637.802676906289, 5650.152477128464, 5660.405657405913, 5671.404502527175, 6404.48764098871, 6456.967715161488, 6524.869502609921, 6577.947528395433, 6610.8347291318105, 5618.803341883015, 5623.465770751772, 5630.296212973379, 5681.205170725836, 5692.601517893708, 3424.195314101184, 3489.092835862694, 3503.0, 3518.648135186461, 3524.1894364296354, 6252.6873656317, 6314.842128946813, 6350.7777227796805, 6374.649394283266, 6456.257530383972, 6774.085498457744, 6803.788768650208, 6806.4554835613035, 6850.554713943578, 6883.724651013903, 6392.16901802772, 6408.839779005562, 6419.454346380423, 6427.775027874002, 6457.5479716419395, 6595.571287866273, 6599.878020736391, 6660.966695166493, 6671.599704017581, 6691.732330706912, 6441.938579654653, 6453.289878182191, 6534.411902928759, 6538.803835884931, 6546.9883853427955, 6380.840478988062, 6415.230172379344, 6446.774362897276, 6446.967765161145, 6447.2263328400895, 4867.269909513601, 4914.803407863646, 4931.753412329441, 4936.741750444689, 4966.304717339648, 6614.735410583715, 6617.371349721769, 6621.172353455818, 6641.50188735837, 6653.933460665525, 6351.745930162741, 6378.936210637834, 6393.584417012879, 6402.583832050902, 6412.166418365583, 6371.044343348535, 6392.296847346695, 6412.35876412355, 6422.967885160544, 6487.481001519773, 6006.639601623917, 6141.07883817431, 6260.937390626035, 6263.655498947602, 6278.152449419453, 6247.281562620356, 6432.497251923765, 6441.838954026187, 6444.258910225384, 6450.290468048417, 6228.844278893064, 6262.843428914313, 6266.780662676784, 6268.968655156695, 6284.654344011124], "value": 4968.262642592529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.8448021596221, 905.4567259644215, 915.3318077803203, 926.5876684875229, 930.1117432851628, 18989.715154272697, 19865.801341986575, 19897.602047959033, 19926.10332535036, 19958.30145944892, 21055.368338949855, 21913.0, 21946.122155113775, 21953.121875124976, 21992.560148797016, 1047.4553232319208, 1067.423591260722, 1068.6954218047858, 1069.9893001069968, 1070.3524367757511, 1004.5228516454698, 1047.5914393386547, 1053.220616743608, 1063.5479921033568, 1067.0609863320306, 1111.5776005118043, 1114.4594871487323, 1114.6433141394757, 1114.6656003199048, 1115.2639258089662, 1110.5613282753347, 1114.0419239454063, 1115.074488174813, 1117.190037223015, 1117.312852595652, 810.116972499972, 815.0748899998486, 815.355868863597, 815.5106935838509, 815.6778072661325, 17563.5609109772, 17879.73180402295, 17961.820381796144, 18021.7296740549, 18076.367327143485, 21712.0, 21811.127554897786, 22179.223727169632, 22200.666989995163, 22302.21942232014, 16754.83245167557, 17017.744733829004, 17065.914670426693, 17246.65506689872, 17255.309787608607, 3534.8939531814085, 3567.678908898212, 3568.1614820517157, 3569.7679650822615, 3580.534530511043, 129295.0, 130339.0, 131040.0, 133840.0, 134126.0, 16776.412825551048, 17149.228284727218, 17636.735448968277, 17799.911000444914, 17968.640627187382, 32381.0, 32536.674633253366, 32747.0, 32975.0, 33170.0, 8978.595963181673, 9032.774180645536, 9189.954050229706, 9190.90809091914, 9198.080191980882, 3729.850805967785, 4249.107687385622, 4343.630791382768, 4349.064951035542, 4351.042770590465, 4389.4513185851765, 5778.219940308089, 5978.55160862937, 5987.64074155552, 6001.159837622737, 1117.754094099297, 1148.8563929508812, 1161.6573110932295, 1171.6719318590808, 1175.1773758369004, 552.2075821196596, 562.2493970549281, 568.1421054208175, 590.3329237961076, 591.133988706547, 11129.443527823576, 11657.650270491898, 11716.88283117175, 11820.172587918934, 11972.221805582609, 538.5476199991947, 543.5868739757733, 557.3061538384655, 571.2431028886741, 575.128680049725, 5194.4026436959475, 5868.530517558585, 5919.230500034968, 5945.643261404243, 6009.038553831366, 101055.49472252592, 104430.47784761028, 105214.47392762988, 105559.0, 109584.4520777407, 92976.0, 94337.0, 94732.52633736788, 95893.0, 99298.0, 80532.0, 82338.0, 82753.58623206966, 82880.17119828844, 83802.58098709346, 11197.72005699864, 11352.205345625727, 11457.541698332307, 11637.0, 11828.40857957116, 37022.8148859254, 37179.814100929325, 37252.0, 38510.61489385182, 39328.606713932495, 47776.327828525835, 48625.0, 49780.0, 50333.24500132574, 50908.745456273966, 16987.23557439943, 17332.220050097523, 17435.912820435817, 17514.124293785004, 17558.91220543889, 17266.223019964382, 17276.22256998463, 17384.391546295818, 17424.390146344816, 17448.73826892572, 16742.66058715324, 16822.495325140266, 16852.325906963582, 16951.15244237808, 17022.74465882988, 16578.088205148833, 17079.573010674834, 17238.827611723722, 17448.0, 17615.64768704593, 17095.14524273806, 17131.229094691018, 17209.741853872452, 17323.0, 17579.56051098733, 12077.939610301892, 12141.75716485683, 12210.38948052576, 12279.0, 12419.254844709347, 12787.552435664707, 13178.341082946006, 13301.201927884358, 13358.265295408846, 13409.66475838112], "value": 8955.163195318262, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 114.0, 99.0, 107.0, 107.0, 108.0, 114.0, 100.0, 108.0, 109.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 154.0, 186.0, 118.0, 151.0, 144.0, 118.0, 165.0, 123.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 162.0, 168.0, 179.0, 169.0, 161.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 165.0, 76.0, 75.0, 74.0, 77.0, 165.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 143.0, 78.0, 79.0, 78.0, 133.0, 79.0, 84.0, 124.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 116.0, 114.0, 114.0, 119.0, 115.0, 114.0, 119.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 154.0, 149.0, 151.0, 150.0, 151.0, 158.0, 156.0, 154.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 98.0, 99.0, 94.0, 94.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 54.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 55.0, 53.0, 56.0, 62.0, 53.0, 54.0, 59.0, 53.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 89.0, 78.0, 103.0, 97.0, 89.0, 79.0, 89.0, 95.0, 77.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 132.0, 128.0, 132.0, 141.0, 128.0, 135.0, 142.0, 162.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 185.0, 180.0, 173.0, 184.0, 181.0, 177.0, 176.0, 186.0, 182.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 70.0, 64.0, 67.0, 69.0, 64.0, 64.0, 68.0], "value": 66.6, "unit": "score"}]}]} 03:06:55 INFO - Return code: 0 03:06:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:55 INFO - # TBPL SUCCESS # 03:06:55 INFO - Running post-action listener: _package_coverage_data 03:06:55 INFO - Running post-action listener: _resource_record_post_action 03:06:55 INFO - [mozharness: 2017-08-06 10:06:55.640771Z] Finished run-tests step (success) 03:06:55 INFO - Running post-run listener: _resource_record_post_run 03:06:55 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 5693440; Write bytes: 438054912; Read time: 2988; Write time: 517724 03:06:55 INFO - TinderboxPrint: CPU usage
13.2% 03:06:55 INFO - TinderboxPrint: I/O read bytes / time
5,693,440 / 2,988 03:06:55 INFO - TinderboxPrint: I/O write bytes / time
438,054,912 / 517,724 03:06:55 INFO - TinderboxPrint: CPU idle
8,292.8 (86.8%) 03:06:55 INFO - TinderboxPrint: CPU user
1,205.8 (12.6%) 03:06:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:06:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 134619136; Read time: 92; Write time: 128432 03:06:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:06:55 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 3657728; Write bytes: 237199360; Read time: 2520; Write time: 300472 03:06:56 INFO - Running post-run listener: _upload_blobber_files 03:06:56 INFO - Blob upload gear active. 03:06:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:06:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:57 INFO - (blobuploader) - INFO - Done attempting. 03:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:58 INFO - (blobuploader) - INFO - Done attempting. 03:06:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:58 INFO - (blobuploader) - INFO - Done attempting. 03:06:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:02 INFO - (blobuploader) - INFO - Done attempting. 03:07:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:02 INFO - Return code: 0 03:07:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:07:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/930d6027a948ab4c80222d3e351f1b1c56af71e4d0ee5ddd003d4d6ed22b433f057a91101a2ba6f8c10bf5559312e7fad4b8954c4680f64c33d183d5402b5d3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54e711cc2196fd77321cc712617f862fb334c33c011d6128afeb3977de3a7bc1fb4c3a53d14c3af36e09e9400ee4c02f87cc7a3895c33d6eff470da7db70b552", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e2c2afb5e5a5ada578f7afa628168394efa47c702d6cef82be3fcdd11ef9e8535446e51d0fc49a3b13f2db3e3acb9a8b04cb6a4e2a26319fa502136c48dfd63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0b0d6b273570fc7459d06e387708a7f226bb48c2df9b9afdc938ee281c541c2be179417fd55f04efa05f4d2ae059a6d06a22761dc12f243ab86157f022b08b"} 03:07:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:07:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:07:02 INFO - Contents: 03:07:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/930d6027a948ab4c80222d3e351f1b1c56af71e4d0ee5ddd003d4d6ed22b433f057a91101a2ba6f8c10bf5559312e7fad4b8954c4680f64c33d183d5402b5d3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54e711cc2196fd77321cc712617f862fb334c33c011d6128afeb3977de3a7bc1fb4c3a53d14c3af36e09e9400ee4c02f87cc7a3895c33d6eff470da7db70b552", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e2c2afb5e5a5ada578f7afa628168394efa47c702d6cef82be3fcdd11ef9e8535446e51d0fc49a3b13f2db3e3acb9a8b04cb6a4e2a26319fa502136c48dfd63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0b0d6b273570fc7459d06e387708a7f226bb48c2df9b9afdc938ee281c541c2be179417fd55f04efa05f4d2ae059a6d06a22761dc12f243ab86157f022b08b"} 03:07:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:02 INFO - Copying logs to upload dir... 03:07:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:07:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.974975 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-06 03:07:02.251703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:07:02.255925) ========= 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=0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406 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/sha512/930d6027a948ab4c80222d3e351f1b1c56af71e4d0ee5ddd003d4d6ed22b433f057a91101a2ba6f8c10bf5559312e7fad4b8954c4680f64c33d183d5402b5d3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54e711cc2196fd77321cc712617f862fb334c33c011d6128afeb3977de3a7bc1fb4c3a53d14c3af36e09e9400ee4c02f87cc7a3895c33d6eff470da7db70b552", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e2c2afb5e5a5ada578f7afa628168394efa47c702d6cef82be3fcdd11ef9e8535446e51d0fc49a3b13f2db3e3acb9a8b04cb6a4e2a26319fa502136c48dfd63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0b0d6b273570fc7459d06e387708a7f226bb48c2df9b9afdc938ee281c541c2be179417fd55f04efa05f4d2ae059a6d06a22761dc12f243ab86157f022b08b"} build_url:https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/HGTfaUZKSw63N3VOwyJcJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/930d6027a948ab4c80222d3e351f1b1c56af71e4d0ee5ddd003d4d6ed22b433f057a91101a2ba6f8c10bf5559312e7fad4b8954c4680f64c33d183d5402b5d3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54e711cc2196fd77321cc712617f862fb334c33c011d6128afeb3977de3a7bc1fb4c3a53d14c3af36e09e9400ee4c02f87cc7a3895c33d6eff470da7db70b552", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e2c2afb5e5a5ada578f7afa628168394efa47c702d6cef82be3fcdd11ef9e8535446e51d0fc49a3b13f2db3e3acb9a8b04cb6a4e2a26319fa502136c48dfd63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0b0d6b273570fc7459d06e387708a7f226bb48c2df9b9afdc938ee281c541c2be179417fd55f04efa05f4d2ae059a6d06a22761dc12f243ab86157f022b08b"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:07:02.306015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:07:02.306647) ========= 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=0333a256a5e4f052382dd180000001b1-1502010829.33721-518604406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:07:02.374821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:07:02.375339) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:07:02.379941) ========= ========= Total master_lag: 0.26 =========