builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1502109562.69 results: success (0) revision: 8437bfefc8417d057015e8b4d77b6a5c67360863 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.694149) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.694640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.694918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.710827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.711089) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 05:39:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2017-08-07 05:39:22 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159608 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.887307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.887679) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016312 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.937391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:22.940756) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8437bfefc8417d057015e8b4d77b6a5c67360863 --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 8437bfefc8417d057015e8b4d77b6a5c67360863 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 05:39:22,639 truncating revision to first 12 chars 2017-08-07 05:39:22,639 Setting DEBUG logging. 2017-08-07 05:39:22,639 attempt 1/10 2017-08-07 05:39:22,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8437bfefc841?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-07 05:39:23,242 unpacking tar archive at: mozilla-central-8437bfefc841/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:23.855707) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:23.856029) ========= script_repo_revision: 8437bfefc8417d057015e8b4d77b6a5c67360863 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:23.856405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:23.856685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 05:39:23.865508) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-07 05:39:23.865787) ========= /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=ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:39:23 INFO - MultiFileLogger online at 20170807 05:39:23 in /builds/slave/test 05:39:23 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 05:39:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:23 INFO - {'append_to_log': False, 05:39:23 INFO - 'base_work_dir': '/builds/slave/test', 05:39:23 INFO - 'blob_upload_branch': 'Firefox', 05:39:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:23 INFO - 'branch': 'Firefox', 05:39:23 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:23 INFO - 'code_coverage': False, 05:39:23 INFO - 'config_files': ('talos/linux_config.py',), 05:39:23 INFO - 'default_actions': ('clobber', 05:39:23 INFO - 'read-buildbot-config', 05:39:23 INFO - 'download-and-extract', 05:39:23 INFO - 'populate-webroot', 05:39:23 INFO - 'create-virtualenv', 05:39:23 INFO - 'install', 05:39:23 INFO - 'setup-mitmproxy', 05:39:23 INFO - 'run-tests'), 05:39:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:23 INFO - 'disable_ccov_upload': False, 05:39:23 INFO - 'download_minidump_stackwalk': True, 05:39:23 INFO - 'download_symbols': 'ondemand', 05:39:23 INFO - 'enable_stylo': False, 05:39:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:23 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:23 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:23 INFO - 'gecko_profile': False, 05:39:23 INFO - 'gecko_profile_interval': 0, 05:39:23 INFO - 'installer_path': 'installer.exe', 05:39:23 INFO - 'log_level': 'info', 05:39:23 INFO - 'log_name': 'talos', 05:39:23 INFO - 'log_to_console': True, 05:39:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:39:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:39:23 INFO - 'opt_config_files': (), 05:39:23 INFO - 'pip_index': False, 05:39:23 INFO - 'suite': 'dromaeojs-e10s', 05:39:23 INFO - 'system_bits': '32', 05:39:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:23 INFO - 'title': 'talos-linux64-ix-029', 05:39:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:23 INFO - 'use_talos_json': True, 05:39:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:23 INFO - 'work_dir': 'build'} 05:39:23 INFO - [mozharness: 2017-08-07 12:39:23.673849Z] Running clobber step. 05:39:23 INFO - Running pre-action listener: _resource_record_pre_action 05:39:23 INFO - Running main action method: clobber 05:39:23 INFO - rmtree: /builds/slave/test/build 05:39:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:24 INFO - Running post-action listener: _resource_record_post_action 05:39:24 INFO - [mozharness: 2017-08-07 12:39:24.685420Z] Finished clobber step (success) 05:39:24 INFO - [mozharness: 2017-08-07 12:39:24.685524Z] Running read-buildbot-config step. 05:39:24 INFO - Running pre-action listener: _resource_record_pre_action 05:39:24 INFO - Running main action method: read_buildbot_config 05:39:24 INFO - Using buildbot properties: 05:39:24 INFO - { 05:39:24 INFO - "project": "", 05:39:24 INFO - "product": "firefox", 05:39:24 INFO - "who": "cbook@mozilla.com", 05:39:24 INFO - "installer_path": "public/build/target.tar.bz2", 05:39:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:39:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:39:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:39:24 INFO - "stage_platform": "linux64-stylosequential", 05:39:24 INFO - "basedir": "/builds/slave/test", 05:39:24 INFO - "buildnumber": 140, 05:39:24 INFO - "platform": "ubuntu64_hw_styloseq", 05:39:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:39:24 INFO - "slavebuilddir": "test", 05:39:24 INFO - "taskId": "fPo-O5Z0QxuItXwCyX8xXA", 05:39:24 INFO - "branch": "mozilla-central", 05:39:24 INFO - "script_repo_revision": "production", 05:39:24 INFO - "revision": "8437bfefc8417d057015e8b4d77b6a5c67360863", 05:39:24 INFO - "slavename": "talos-linux64-ix-029", 05:39:24 INFO - "repo_path": "mozilla-central" 05:39:24 INFO - } 05:39:24 INFO - Finding installer, test and symbols from parent task. 05:39:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPo-O5Z0QxuItXwCyX8xXA'}, attempt #1 05:39:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPo-O5Z0QxuItXwCyX8xXA'}, attempt #1 05:39:25 INFO - Task dependencies: CTkm8jlKQvKlvnvlEGpMow 05:39:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow'}, attempt #1 05:39:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2 05:39:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.test_packages.json 05:39:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.crashreporter-symbols.zip 05:39:26 INFO - Running post-action listener: _resource_record_post_action 05:39:26 INFO - [mozharness: 2017-08-07 12:39:26.029550Z] Finished read-buildbot-config step (success) 05:39:26 INFO - [mozharness: 2017-08-07 12:39:26.029774Z] Running download-and-extract step. 05:39:26 INFO - Running pre-action listener: _resource_record_pre_action 05:39:26 INFO - Running main action method: download_and_extract 05:39:26 INFO - mkdir: /builds/slave/test/build/tests 05:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:26 INFO - trying https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.test_packages.json 05:39:26 INFO - Downloading https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:39:26 INFO - Downloaded 989 bytes. 05:39:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:39:26 INFO - Using the following test package requirements: 05:39:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:39:26 INFO - u'common': [u'target.common.tests.zip'], 05:39:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:39:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:39:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:39:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:39:26 INFO - u'mozbase': [u'target.common.tests.zip'], 05:39:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:39:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:39:26 INFO - u'web-platform': [u'target.common.tests.zip', 05:39:26 INFO - u'target.web-platform.tests.tar.gz'], 05:39:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:39:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.common.tests.zip 05:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.common.tests.zip into memory 05:39:27 INFO - Content-Length response header: 54284820 05:39:27 INFO - Bytes received: 54284820 05:39:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:39:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.common.tests.zip 05:39:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:39:38 INFO - Fetch https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.common.tests.zip into memory 05:39:40 INFO - Content-Length response header: 54284820 05:39:40 INFO - Bytes received: 54284820 05:39:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.talos.tests.zip 05:39:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:39:53 INFO - Fetch https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.talos.tests.zip into memory 05:39:54 INFO - Content-Length response header: 14496008 05:39:54 INFO - Bytes received: 14496008 05:39: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')]} 05:39:54 INFO - trying https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2 05:39:54 INFO - Downloading https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:39:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:39:56 INFO - Downloaded 61784750 bytes. 05:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2 05:39:56 INFO - mkdir: /builds/slave/test/properties 05:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:56 INFO - Contents: 05:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2 05:39:56 INFO - Running post-action listener: _resource_record_post_action 05:39:56 INFO - Running post-action listener: set_extra_try_arguments 05:39:56 INFO - [mozharness: 2017-08-07 12:39:56.034989Z] Finished download-and-extract step (success) 05:39:56 INFO - [mozharness: 2017-08-07 12:39:56.035087Z] Running populate-webroot step. 05:39:56 INFO - Running pre-action listener: _resource_record_pre_action 05:39:56 INFO - Running main action method: populate_webroot 05:39:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:39:56 INFO - 'tests': ['damp', 'tps']}, 05:39:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:39:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:39:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:39:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:56 INFO - 'ts_paint', 05:39:56 INFO - 'tpaint', 05:39:56 INFO - 'sessionrestore', 05:39:56 INFO - 'sessionrestore_many_windows', 05:39:56 INFO - 'sessionrestore_no_auto_restore', 05:39:56 INFO - 'tabpaint']}, 05:39:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:39:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:39:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:56 INFO - 'tsvgr_opacity', 05:39:56 INFO - 'tart', 05:39:56 INFO - 'tscrollx', 05:39:56 INFO - 'tsvg_static']}, 05:39:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:39:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:39:56 INFO - 'talos_options': ['--mitmproxy', 05:39:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:39:56 INFO - '--firstNonBlankPaint'], 05:39:56 INFO - 'tests': ['tp6_google', 05:39:56 INFO - 'tp6_youtube', 05:39:56 INFO - 'tp6_amazon', 05:39:56 INFO - 'tp6_facebook']}, 05:39:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:39:56 INFO - 'talos_options': ['--stylo', 05:39:56 INFO - '--mitmproxy', 05:39:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:39:56 INFO - '--firstNonBlankPaint'], 05:39:56 INFO - 'tests': ['tp6_google', 05:39:56 INFO - 'tp6_youtube', 05:39:56 INFO - 'tp6_amazon', 05:39:56 INFO - 'tp6_facebook']}, 05:39:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:39:56 INFO - 'talos_options': ['--stylo', 05:39:56 INFO - '--stylo-threads=1', 05:39:56 INFO - '--mitmproxy', 05:39:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:39:56 INFO - '--firstNonBlankPaint'], 05:39:56 INFO - 'tests': ['tp6_google', 05:39:56 INFO - 'tp6_youtube', 05:39:56 INFO - 'tp6_amazon', 05:39:56 INFO - 'tp6_facebook']}, 05:39:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:39:56 INFO - 'talos_options': ['--xperf_path', 05:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:56 INFO - 'tests': ['tp5n']}}} 05:39:56 INFO - Running post-action listener: _resource_record_post_action 05:39:56 INFO - [mozharness: 2017-08-07 12:39:56.043480Z] Finished populate-webroot step (success) 05:39:56 INFO - [mozharness: 2017-08-07 12:39:56.043571Z] Running create-virtualenv step. 05:39:56 INFO - Running pre-action listener: _resource_record_pre_action 05:39:56 INFO - Running main action method: create_virtualenv 05:39:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:39:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:39:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:56 INFO - Using real prefix '/usr' 05:39:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:58 INFO - Installing pip.................done. 05:39:58 INFO - Return code: 0 05:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:39:58 INFO - Reading from file tmpfile_stdout 05:39:58 INFO - Output received: 05:39:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:39:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:58 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:39:58 INFO - Using env: {'DISPLAY': ':0', 05:39:58 INFO - 'HOME': '/home/cltbld', 05:39:58 INFO - 'LANG': 'en_US.UTF-8', 05:39:58 INFO - 'LANGUAGE': 'en_US:en', 05:39:58 INFO - 'LOGNAME': 'cltbld', 05:39:58 INFO - 'MAIL': '/var/mail/cltbld', 05:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:58 INFO - 'MOZ_NO_REMOTE': '1', 05:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:58 INFO - 'NO_EM_RESTART': '1', 05:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:58 INFO - 'PWD': '/builds/slave/test', 05:39:58 INFO - 'SHELL': '/bin/bash', 05:39:58 INFO - 'SHLVL': '1', 05:39:58 INFO - 'TERM': 'linux', 05:39:58 INFO - 'TMOUT': '86400', 05:39:58 INFO - 'USER': 'cltbld', 05:39:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:58 INFO - '_': '/tools/buildbot/bin/python'} 05:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:39:59 INFO - Cleaning up... 05:39:59 INFO - Return code: 0 05:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:59 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:39:59 INFO - Using env: {'DISPLAY': ':0', 05:39:59 INFO - 'HOME': '/home/cltbld', 05:39:59 INFO - 'LANG': 'en_US.UTF-8', 05:39:59 INFO - 'LANGUAGE': 'en_US:en', 05:39:59 INFO - 'LOGNAME': 'cltbld', 05:39:59 INFO - 'MAIL': '/var/mail/cltbld', 05:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:59 INFO - 'MOZ_NO_REMOTE': '1', 05:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:59 INFO - 'NO_EM_RESTART': '1', 05:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:59 INFO - 'PWD': '/builds/slave/test', 05:39:59 INFO - 'SHELL': '/bin/bash', 05:39:59 INFO - 'SHLVL': '1', 05:39:59 INFO - 'TERM': 'linux', 05:39:59 INFO - 'TMOUT': '86400', 05:39:59 INFO - 'USER': 'cltbld', 05:39:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:59 INFO - '_': '/tools/buildbot/bin/python'} 05:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:59 INFO - Downloading/unpacking psutil>=3.1.1 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:00 INFO - Installing collected packages: psutil 05:40:00 INFO - Running setup.py install for psutil 05:40:00 INFO - building 'psutil._psutil_linux' extension 05:40:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:40:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:40:00 INFO - building 'psutil._psutil_posix' extension 05:40:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:40:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:40:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:00 INFO - Successfully installed psutil 05:40:00 INFO - Cleaning up... 05:40:00 INFO - Return code: 0 05:40:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:40:01 INFO - Using env: {'DISPLAY': ':0', 05:40:01 INFO - 'HOME': '/home/cltbld', 05:40:01 INFO - 'LANG': 'en_US.UTF-8', 05:40:01 INFO - 'LANGUAGE': 'en_US:en', 05:40:01 INFO - 'LOGNAME': 'cltbld', 05:40:01 INFO - 'MAIL': '/var/mail/cltbld', 05:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:01 INFO - 'MOZ_NO_REMOTE': '1', 05:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:01 INFO - 'NO_EM_RESTART': '1', 05:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:01 INFO - 'PWD': '/builds/slave/test', 05:40:01 INFO - 'SHELL': '/bin/bash', 05:40:01 INFO - 'SHLVL': '1', 05:40:01 INFO - 'TERM': 'linux', 05:40:01 INFO - 'TMOUT': '86400', 05:40:01 INFO - 'USER': 'cltbld', 05:40:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:01 INFO - '_': '/tools/buildbot/bin/python'} 05:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:02 INFO - Installing collected packages: mozsystemmonitor 05:40:02 INFO - Running setup.py install for mozsystemmonitor 05:40:02 INFO - Successfully installed mozsystemmonitor 05:40:02 INFO - Cleaning up... 05:40:02 INFO - Return code: 0 05:40:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:40:02 INFO - Using env: {'DISPLAY': ':0', 05:40:02 INFO - 'HOME': '/home/cltbld', 05:40:02 INFO - 'LANG': 'en_US.UTF-8', 05:40:02 INFO - 'LANGUAGE': 'en_US:en', 05:40:02 INFO - 'LOGNAME': 'cltbld', 05:40:02 INFO - 'MAIL': '/var/mail/cltbld', 05:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:02 INFO - 'MOZ_NO_REMOTE': '1', 05:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:02 INFO - 'NO_EM_RESTART': '1', 05:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:02 INFO - 'PWD': '/builds/slave/test', 05:40:02 INFO - 'SHELL': '/bin/bash', 05:40:02 INFO - 'SHLVL': '1', 05:40:02 INFO - 'TERM': 'linux', 05:40:02 INFO - 'TMOUT': '86400', 05:40:02 INFO - 'USER': 'cltbld', 05:40:02 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:02 INFO - '_': '/tools/buildbot/bin/python'} 05:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:04 INFO - warning: no files found matching '*.txt' 05:40:04 INFO - no previously-included directories found matching 'build' 05:40:04 INFO - no previously-included directories found matching 'dist' 05:40:04 INFO - no previously-included directories found matching '.git*' 05:40:04 INFO - Installing collected packages: jsonschema, functools32 05:40:04 INFO - Running setup.py install for functools32 05:40:04 INFO - warning: no files found matching '*.txt' 05:40:04 INFO - no previously-included directories found matching 'build' 05:40:04 INFO - no previously-included directories found matching 'dist' 05:40:04 INFO - no previously-included directories found matching '.git*' 05:40:04 INFO - Successfully installed jsonschema functools32 05:40:04 INFO - Cleaning up... 05:40:04 INFO - Return code: 0 05:40:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:04 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:40:04 INFO - Using env: {'DISPLAY': ':0', 05:40:04 INFO - 'HOME': '/home/cltbld', 05:40:04 INFO - 'LANG': 'en_US.UTF-8', 05:40:04 INFO - 'LANGUAGE': 'en_US:en', 05:40:04 INFO - 'LOGNAME': 'cltbld', 05:40:04 INFO - 'MAIL': '/var/mail/cltbld', 05:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:04 INFO - 'MOZ_NO_REMOTE': '1', 05:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:04 INFO - 'NO_EM_RESTART': '1', 05:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:04 INFO - 'PWD': '/builds/slave/test', 05:40:04 INFO - 'SHELL': '/bin/bash', 05:40:04 INFO - 'SHLVL': '1', 05:40:04 INFO - 'TERM': 'linux', 05:40:04 INFO - 'TMOUT': '86400', 05:40:04 INFO - 'USER': 'cltbld', 05:40:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:04 INFO - '_': '/tools/buildbot/bin/python'} 05:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:40:04 INFO - Cleaning up... 05:40:04 INFO - Return code: 0 05:40:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:04 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:40:04 INFO - Using env: {'DISPLAY': ':0', 05:40:04 INFO - 'HOME': '/home/cltbld', 05:40:04 INFO - 'LANG': 'en_US.UTF-8', 05:40:04 INFO - 'LANGUAGE': 'en_US:en', 05:40:04 INFO - 'LOGNAME': 'cltbld', 05:40:04 INFO - 'MAIL': '/var/mail/cltbld', 05:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:04 INFO - 'MOZ_NO_REMOTE': '1', 05:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:04 INFO - 'NO_EM_RESTART': '1', 05:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:04 INFO - 'PWD': '/builds/slave/test', 05:40:04 INFO - 'SHELL': '/bin/bash', 05:40:04 INFO - 'SHLVL': '1', 05:40:04 INFO - 'TERM': 'linux', 05:40:04 INFO - 'TMOUT': '86400', 05:40:04 INFO - 'USER': 'cltbld', 05:40:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:04 INFO - '_': '/tools/buildbot/bin/python'} 05:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:06 INFO - Downloading docopt-0.6.1.tar.gz 05:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:06 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:06 INFO - Running setup.py install for blobuploader 05:40:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:06 INFO - Running setup.py install for requests 05:40:06 INFO - Running setup.py install for docopt 05:40:06 INFO - Successfully installed blobuploader requests docopt 05:40:06 INFO - Cleaning up... 05:40:06 INFO - Return code: 0 05:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:06 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:06 INFO - Using env: {'DISPLAY': ':0', 05:40:06 INFO - 'HOME': '/home/cltbld', 05:40:06 INFO - 'LANG': 'en_US.UTF-8', 05:40:06 INFO - 'LANGUAGE': 'en_US:en', 05:40:06 INFO - 'LOGNAME': 'cltbld', 05:40:06 INFO - 'MAIL': '/var/mail/cltbld', 05:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:06 INFO - 'MOZ_NO_REMOTE': '1', 05:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:06 INFO - 'NO_EM_RESTART': '1', 05:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:06 INFO - 'PWD': '/builds/slave/test', 05:40:06 INFO - 'SHELL': '/bin/bash', 05:40:06 INFO - 'SHLVL': '1', 05:40:06 INFO - 'TERM': 'linux', 05:40:06 INFO - 'TMOUT': '86400', 05:40:06 INFO - 'USER': 'cltbld', 05:40:06 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:06 INFO - '_': '/tools/buildbot/bin/python'} 05:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:07 INFO - Running setup.py (path:/tmp/pip-K6Nhq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:07 INFO - Running setup.py (path:/tmp/pip-v4oirt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:07 INFO - Running setup.py (path:/tmp/pip-rkPGoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:07 INFO - Running setup.py (path:/tmp/pip-RO_qp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:07 INFO - Running setup.py (path:/tmp/pip-bufdld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:07 INFO - Running setup.py (path:/tmp/pip-f6fvZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:07 INFO - Running setup.py (path:/tmp/pip-Vy10ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:07 INFO - Running setup.py (path:/tmp/pip-xyDfEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:07 INFO - Running setup.py (path:/tmp/pip-AZuiUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:07 INFO - Running setup.py (path:/tmp/pip-hkCka1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:07 INFO - Running setup.py (path:/tmp/pip-JbJM84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:07 INFO - Running setup.py (path:/tmp/pip-ZhI5PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:08 INFO - Running setup.py (path:/tmp/pip-aK9cpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:08 INFO - Running setup.py (path:/tmp/pip-Di4fFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:08 INFO - Running setup.py (path:/tmp/pip-rN7Kk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:08 INFO - Running setup.py (path:/tmp/pip-em8JKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:08 INFO - Running setup.py (path:/tmp/pip-4j5733-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:08 INFO - Running setup.py install for manifestparser 05:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Running setup.py install for mozcrash 05:40:08 INFO - Running setup.py install for mozdebug 05:40:08 INFO - Running setup.py install for mozdevice 05:40:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:08 INFO - Running setup.py install for mozfile 05:40:08 INFO - Running setup.py install for mozhttpd 05:40:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for mozinfo 05:40:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for mozInstall 05:40:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for mozleak 05:40:09 INFO - Running setup.py install for mozlog 05:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for moznetwork 05:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for mozprocess 05:40:09 INFO - Running setup.py install for mozprofile 05:40:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for mozrunner 05:40:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:09 INFO - Running setup.py install for mozscreenshot 05:40:09 INFO - Running setup.py install for moztest 05:40:10 INFO - Running setup.py install for mozversion 05:40:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:10 INFO - Cleaning up... 05:40:10 INFO - Return code: 0 05:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:10 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:10 INFO - Using env: {'DISPLAY': ':0', 05:40:10 INFO - 'HOME': '/home/cltbld', 05:40:10 INFO - 'LANG': 'en_US.UTF-8', 05:40:10 INFO - 'LANGUAGE': 'en_US:en', 05:40:10 INFO - 'LOGNAME': 'cltbld', 05:40:10 INFO - 'MAIL': '/var/mail/cltbld', 05:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:10 INFO - 'MOZ_NO_REMOTE': '1', 05:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:10 INFO - 'NO_EM_RESTART': '1', 05:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:10 INFO - 'PWD': '/builds/slave/test', 05:40:10 INFO - 'SHELL': '/bin/bash', 05:40:10 INFO - 'SHLVL': '1', 05:40:10 INFO - 'TERM': 'linux', 05:40:10 INFO - 'TMOUT': '86400', 05:40:10 INFO - 'USER': 'cltbld', 05:40:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:10 INFO - '_': '/tools/buildbot/bin/python'} 05:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:10 INFO - Running setup.py (path:/tmp/pip-U2jH3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:10 INFO - Running setup.py (path:/tmp/pip-XSobZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:10 INFO - Running setup.py (path:/tmp/pip-oMX2lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:10 INFO - Running setup.py (path:/tmp/pip-zZP61P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:10 INFO - Running setup.py (path:/tmp/pip-Q98lsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:10 INFO - Running setup.py (path:/tmp/pip-UsJZ9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:10 INFO - Running setup.py (path:/tmp/pip-ULfpxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:10 INFO - Running setup.py (path:/tmp/pip-PkRwIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:10 INFO - Running setup.py (path:/tmp/pip-hz8w3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:11 INFO - Running setup.py (path:/tmp/pip-YNXwp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:11 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)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:11 INFO - Running setup.py (path:/tmp/pip-TdI74j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:11 INFO - Running setup.py (path:/tmp/pip-4pSdj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:11 INFO - Running setup.py (path:/tmp/pip-CKX0un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:11 INFO - Running setup.py (path:/tmp/pip-HPnK5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:11 INFO - Running setup.py (path:/tmp/pip-3RVhxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:11 INFO - Running setup.py (path:/tmp/pip-OWxrFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:11 INFO - Running setup.py (path:/tmp/pip-AhnFgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:40:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:12 INFO - Downloading blessings-1.6.tar.gz 05:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:12 INFO - Installing collected packages: blessings 05:40:12 INFO - Running setup.py install for blessings 05:40:12 INFO - Successfully installed blessings 05:40:12 INFO - Cleaning up... 05:40:12 INFO - Return code: 0 05:40:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:13 INFO - Reading from file tmpfile_stdout 05:40:13 INFO - Current package versions: 05:40:13 INFO - argparse == 1.2.1 05:40:13 INFO - blessings == 1.6 05:40:13 INFO - blobuploader == 1.2.4 05:40:13 INFO - docopt == 0.6.1 05:40:13 INFO - functools32 == 3.2.3-2 05:40:13 INFO - jsonschema == 2.5.1 05:40:13 INFO - manifestparser == 1.1 05:40:13 INFO - mozInstall == 1.13 05:40:13 INFO - mozcrash == 1.0 05:40:13 INFO - mozdebug == 0.1 05:40:13 INFO - mozdevice == 0.51 05:40:13 INFO - mozfile == 1.2 05:40:13 INFO - mozhttpd == 0.7 05:40:13 INFO - mozinfo == 0.10 05:40:13 INFO - mozleak == 0.1 05:40:13 INFO - mozlog == 3.5 05:40:13 INFO - moznetwork == 0.27 05:40:13 INFO - mozprocess == 0.25 05:40:13 INFO - mozprofile == 0.28 05:40:13 INFO - mozrunner == 6.13 05:40:13 INFO - mozscreenshot == 0.1 05:40:13 INFO - mozsystemmonitor == 0.3 05:40:13 INFO - moztest == 0.8 05:40:13 INFO - mozversion == 1.4 05:40:13 INFO - psutil == 3.1.1 05:40:13 INFO - requests == 1.2.3 05:40:13 INFO - wsgiref == 0.1.2 05:40:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:13 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:40:13 INFO - Using env: {'DISPLAY': ':0', 05:40:13 INFO - 'HOME': '/home/cltbld', 05:40:13 INFO - 'LANG': 'en_US.UTF-8', 05:40:13 INFO - 'LANGUAGE': 'en_US:en', 05:40:13 INFO - 'LOGNAME': 'cltbld', 05:40:13 INFO - 'MAIL': '/var/mail/cltbld', 05:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:13 INFO - 'MOZ_NO_REMOTE': '1', 05:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:13 INFO - 'NO_EM_RESTART': '1', 05:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:13 INFO - 'PWD': '/builds/slave/test', 05:40:13 INFO - 'SHELL': '/bin/bash', 05:40:13 INFO - 'SHLVL': '1', 05:40:13 INFO - 'TERM': 'linux', 05:40:13 INFO - 'TMOUT': '86400', 05:40:13 INFO - 'USER': 'cltbld', 05:40:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:13 INFO - '_': '/tools/buildbot/bin/python'} 05:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:40:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:40:14 INFO - Installing collected packages: simplejson 05:40:14 INFO - Running setup.py install for simplejson 05:40:14 INFO - building 'simplejson._speedups' extension 05:40:14 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 05:40:15 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 05:40:15 INFO - Successfully installed simplejson 05:40:15 INFO - Cleaning up... 05:40:15 INFO - Return code: 0 05:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40: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')]} 05:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:15 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 0xc2d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:15 INFO - Using env: {'DISPLAY': ':0', 05:40:15 INFO - 'HOME': '/home/cltbld', 05:40:15 INFO - 'LANG': 'en_US.UTF-8', 05:40:15 INFO - 'LANGUAGE': 'en_US:en', 05:40:15 INFO - 'LOGNAME': 'cltbld', 05:40:15 INFO - 'MAIL': '/var/mail/cltbld', 05:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:15 INFO - 'MOZ_NO_REMOTE': '1', 05:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:15 INFO - 'NO_EM_RESTART': '1', 05:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:15 INFO - 'PWD': '/builds/slave/test', 05:40:15 INFO - 'SHELL': '/bin/bash', 05:40:15 INFO - 'SHLVL': '1', 05:40:15 INFO - 'TERM': 'linux', 05:40:15 INFO - 'TMOUT': '86400', 05:40:15 INFO - 'USER': 'cltbld', 05:40:15 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:15 INFO - '_': '/tools/buildbot/bin/python'} 05:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:15 INFO - Cleaning up... 05:40:15 INFO - Return code: 0 05:40:15 INFO - Running post-action listener: _resource_record_post_action 05:40:15 INFO - Running post-action listener: _start_resource_monitoring 05:40:15 INFO - Starting resource monitoring. 05:40:15 INFO - [mozharness: 2017-08-07 12:40:15.865604Z] Finished create-virtualenv step (success) 05:40:15 INFO - [mozharness: 2017-08-07 12:40:15.866158Z] Running install step. 05:40:15 INFO - Running pre-action listener: _resource_record_pre_action 05:40:15 INFO - Running main action method: install 05:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:16 INFO - Reading from file tmpfile_stdout 05:40:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:16 INFO - Reading from file tmpfile_stdout 05:40:16 INFO - Output received: 05:40:16 INFO - Usage: mozinstall [options] installer 05:40:16 INFO - Options: 05:40:16 INFO - -h, --help show this help message and exit 05:40:16 INFO - -d DEST, --destination=DEST 05:40:16 INFO - Directory to install application into. [default: 05:40:16 INFO - "/builds/slave/test"] 05:40:16 INFO - --app=APP Application being installed. [default: firefox] 05:40:16 INFO - mkdir: /builds/slave/test/build/application 05:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:40:34 INFO - Reading from file tmpfile_stdout 05:40:34 INFO - Output received: 05:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:40:34 INFO - Running post-action listener: _resource_record_post_action 05:40:34 INFO - [mozharness: 2017-08-07 12:40:34.134698Z] Finished install step (success) 05:40:34 INFO - [mozharness: 2017-08-07 12:40:34.134949Z] Running setup-mitmproxy step. 05:40:34 INFO - Running pre-action listener: _resource_record_pre_action 05:40:34 INFO - Running main action method: setup_mitmproxy 05:40:34 INFO - Skipping: mitmproxy is not required 05:40:34 INFO - Running post-action listener: _resource_record_post_action 05:40:34 INFO - [mozharness: 2017-08-07 12:40:34.136080Z] Finished setup-mitmproxy step (success) 05:40:34 INFO - [mozharness: 2017-08-07 12:40:34.136300Z] Running run-tests step. 05:40:34 INFO - Running pre-action listener: _resource_record_pre_action 05:40:34 INFO - Running pre-action listener: _set_gcov_prefix 05:40:34 INFO - Running main action method: run_tests 05:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:40:34 INFO - Python 2.7.3 05:40:34 INFO - Return code: 0 05:40:34 INFO - grabbing minidump binary from tooltool 05:40: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')]} 05:40:34 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 0xf99eb0>, '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 0xf9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9b240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:40:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:40:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:40:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:40:34 INFO - Return code: 0 05:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:40:34 INFO - ENV: RUST_BACKTRACE is now 1 05:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:40:34 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/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:40:34 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/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:40:34 INFO - Using env: {'DISPLAY': ':0', 05:40:34 INFO - 'HOME': '/home/cltbld', 05:40:34 INFO - 'LANG': 'en_US.UTF-8', 05:40:34 INFO - 'LANGUAGE': 'en_US:en', 05:40:34 INFO - 'LOGNAME': 'cltbld', 05:40:34 INFO - 'MAIL': '/var/mail/cltbld', 05:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:34 INFO - 'MOZ_NO_REMOTE': '1', 05:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:34 INFO - 'NO_EM_RESTART': '1', 05:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:34 INFO - 'PWD': '/builds/slave/test', 05:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:40:34 INFO - 'RUST_BACKTRACE': '1', 05:40:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:40:34 INFO - 'SHELL': '/bin/bash', 05:40:34 INFO - 'SHLVL': '1', 05:40:34 INFO - 'STYLO_FORCE_ENABLED': '1', 05:40:34 INFO - 'TERM': 'linux', 05:40:34 INFO - 'TMOUT': '86400', 05:40:34 INFO - 'USER': 'cltbld', 05:40:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929', 05:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:34 INFO - '_': '/tools/buildbot/bin/python'} 05:40:34 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/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:40:34 INFO - mozversion application_buildid: 20170807105655 05:40:34 INFO - mozversion application_changeset: 8437bfefc8417d057015e8b4d77b6a5c67360863 05:40:34 INFO - mozversion application_display_name: Nightly 05:40:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:40:34 INFO - mozversion application_name: Firefox 05:40:34 INFO - mozversion application_remotingname: firefox 05:40:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:40:34 INFO - mozversion application_vendor: Mozilla 05:40:34 INFO - mozversion application_version: 57.0a1 05:40:34 INFO - mozversion platform_buildid: 20170807105655 05:40:34 INFO - mozversion platform_changeset: 8437bfefc8417d057015e8b4d77b6a5c67360863 05:40:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:40:34 INFO - mozversion platform_version: 57.0a1 05:40:34 INFO - using testdate: 1502109634 05:40:34 INFO - actual date: 1502109634 05:40:34 INFO - starting webserver on 'localhost:58478' 05:40:34 INFO - SUITE-START | Running 2 tests 05:40:34 INFO - TEST-START | dromaeo_css 05:40:34 INFO - Initialising browser for dromaeo_css test... 05:40:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58478/getInfo.html -profile /tmp/tmpRwJkr0/profile 05:40:34 INFO - TEST-INFO | started process 4798 (/builds/slave/test/build/application/firefox/firefox http://localhost:58478/getInfo.html) 05:40:41 INFO - TEST-INFO | 4798: exit 0 05:40:41 INFO - Browser initialized. 05:40:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:40:41 INFO - TEST-INFO | started process 5024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwJkr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:42 INFO - PID 5024 | 05:40:42 INFO - PID 5024 | (/builds/slave/test/build/application/firefox/firefox:5078): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:40:42 INFO - PID 5024 | 05:40:52 INFO - PID 5024 | RSS: Main: 173772800 05:40:52 INFO - PID 5024 | 05:40:52 INFO - PID 5024 | serialization: Helvetica 05:40:52 INFO - PID 5024 | serialization: Arial 05:43:52 INFO - PID 5024 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58478/tests/dromaeo/cssquery-ext.html) 05:43:53 INFO - PID 5024 | RSS: Main: 174006272 05:43:53 INFO - PID 5024 | 05:43:53 INFO - PID 5024 | serialization: Helvetica 05:43:53 INFO - PID 5024 | serialization: Arial 05:46:55 INFO - PID 5024 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-ext.html (next: http://localhost:58478/tests/dromaeo/cssquery-jquery.html) 05:46:56 INFO - PID 5024 | RSS: Main: 172896256 05:46:56 INFO - PID 5024 | 05:46:56 INFO - PID 5024 | serialization: Helvetica 05:46:56 INFO - PID 5024 | serialization: Arial 05:49:58 INFO - PID 5024 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58478/tests/dromaeo/cssquery-mootools.html) 05:49:58 INFO - PID 5024 | RSS: Main: 175349760 05:49:58 INFO - PID 5024 | 05:49:58 INFO - PID 5024 | serialization: Helvetica 05:49:58 INFO - PID 5024 | serialization: Arial 05:53:00 INFO - PID 5024 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58478/tests/dromaeo/cssquery-prototype.html) 05:53:01 INFO - PID 5024 | RSS: Main: 173797376 05:53:01 INFO - PID 5024 | 05:53:01 INFO - PID 5024 | serialization: Helvetica 05:53:01 INFO - PID 5024 | serialization: Arial 05:56:05 INFO - PID 5024 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58478/tests/dromaeo/cssquery-yui.html) 05:56:05 INFO - PID 5024 | RSS: Main: 176934912 05:56:05 INFO - PID 5024 | 05:56:05 INFO - PID 5024 | serialization: Helvetica 05:56:05 INFO - PID 5024 | serialization: Arial 05:59:07 INFO - PID 5024 | Cycle 1(1): loaded http://localhost:58478/tests/dromaeo/cssquery-yui.html (next: http://localhost:58478/tests/dromaeo/cssquery-dojo.html) 05:59:08 INFO - PID 5024 | RSS: Main: 177213440 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | __start_tp_report 05:59:08 INFO - PID 5024 | _x_x_mozilla_page_load 05:59:08 INFO - PID 5024 | _x_x_mozilla_page_load_details 05:59:08 INFO - PID 5024 | |i|pagename|runs| 05:59:08 INFO - PID 5024 | |0;dojo.html;3151.401233765586;3171.0962375722916;3179.4118088153677;3199.9040028799136;3218.0667606394145;6165.414285642868;6206.534509911763;6221.844453888655;6227.5952063115865;6230.5327100467475;6197;6202.06968954657;6334.714937827797;6341.651209183493;6366.076918846765;5695.468993269908;5739.856503587402;5782.768689252425;5793.986052440806;5846.912296315559;5561.833145005636;5639.943600564004;5711.914321285184;5725.742341594618;5852.034414321632;5548.77804887804;5638.069718496443;5648.068068768669;5680.4319568043275;5695.487406133447;5705.315362156526;5714.828555143311;5795.710214489259;5806.274215723035;5815.244018277639;5553.333599967989;5637.3235211774845;5653.660780353192;5713.485786279213;5715.028445164332;6018.15745795589;6172.4136207060255;6175.073738939195;6182.783602573933;6196.101565273055;6654.334566543307;6674.2658307586125;6676.599404035774;6685.298043705389;6751.25736169021;6769.3907548320885;6803.829904252384;6820.727170913157;6829.93170068298;6832.658367081626;6168.0439531872635;6239.282482514478;6301.212348456443;6324.905126423016;6338.080978258173;6758.324167583301;6873.037774711544;6895.482838787111;6953.165620125617;6978.197507286625;6520.315366886409;6553.574017688835;6558.967205163944;6584;6601.2738598754095;6711.630860302633;6713.429358504484;6713.765018224339;6720.495962802809;6721.529492935545;6728.697208625624;6729.293424190488;6730.629815360105;6734.797956061326;6749.257581666013;6604.174478190226;6654;6674.466042716571;6767.560108592926;6776.356246156607;5344.91982620261;5444.700541470257;5459.672419654754;5509.531689806411;5513.61404701667;4630.976845115752;4637.721736695809;4650.67445278834;4672.906541869143;4744.810207591727;5804.245448091721;5808.912866307009;5811.506021988093;5814.360420353758;5823.068309070529;6703.698333574904;6790.5925644461495;6791.864162716718;6796.76211332601;6800.625965571842;5747.770089196469;5777.046787280052;5815.738291776795;5826.329972053183;5853.414658534112;5835.299764028344;5919.881602367928;5948.286205655262;5950.404959504015;6019.668918209453;6442.871142577123;6468.2561505427475;6471.0940468334475;6471.158749362647;6478.578892372075;6614.437772789174;6647.135872336566;6657.300983396867;6710.194776626836;6721.193456785217;6501.1548498694865;6522.15212022453;6537.5096867736065;6546.279909210079;6610.702518386588;6440.227172739301;6626.370494802986;6641.468682505291;6708.798736037927;6715.630640314829;6632.867342653217;6643.9335606645245;6654.13496245485;6665.766698165541;6732.831679208059;6463.838404039937;6475.838104047248;6489.253735820441;6492.448141907991;6493.772717954849;6477.190351206099;6485.935140648533;6488.383603557654;6508;6510.316416776171;5499.780008799603;6424.678766061772;6433.742650293936;6459.128017717548;6543.378379053982;6538.869222615426;6564.901526477202;6602.438792702674;6626.304238054935;6643.9335606645245;6241.188645476059;6340.365963403623;6352.301246862934;6433.581817181868;6433.613983161025 05:59:08 INFO - PID 5024 | |1;ext.html;845.8477474054667;885.9955700221498;895.8656201569763;916.6929078758616;1167.8773728758486;31971.52042719358;44003.77998110009;44351.77824110875;44383.33424998628;44460.555394446084;40978.38532422016;43856;44324.335134973;44487.55512444874;44601.776991115;7307.4884758066955;7938.2855543001115;7959.602019899011;7962.203779622049;7963.960180199091;7801.804954876116;7855.921440785576;7864.685412583518;7917.406194535404;7918.287354138127;7897.921020789805;7980.241877021674;7991.120976692559;7992.560409177493;8000.959995200016;7873;7918.366530677532;7921.801954951115;7926.048874135083;7941.126476087626;7731.226877312224;7784.766457006299;7796.142424333319;7804.9609751950875;7827.569483678395;40906;41117.58882411168;41130.79434602838;41155.38266925998;41236.1752764943;3552.928941421183;3584.9103772405897;3586.8565257389673;3603.027182660693;3607.116256517144;31581.526277105862;31693.20766980844;31776.841115794505;31797.84101079503;31818.204544886332;4738.763061846894;4760.880977975544;4777.355057067321;4806.687565308279;4827.348307978448;195279;195297;195792;195866.02066989717;196047;49310.506894931306;49426;49509;49648;49913;51684.48315516872;51823.48176518187;51937.7403112982;51988.22017669738;52038.21942670863;15071.397144114331;15260.236988150547;16646.6670666586;17202.22589983454;17224.483265502055;12617.116801823784;12644.873551264554;13924.373403196678;14233.50182743599;14333.498327558485;13628.65928351799;13736.175829450265;13776.173429594257;13795.379207935666;13880.652983675489;5239.423663397023;5242.501962313574;5243.606729495303;5296.602754793329;5312.256284120226;989.9406035637885;1001.5796056467228;1027.7430642339416;1029.897010298964;1032.0608246495653;23089.653655195187;23301;23322.416939576306;23469.29592112205;23539.882300588386;1119.238917536067;1120.9495572699086;1136.9886301137049;1137.1073707139856;1157.8031734605138;12337.383130843422;12340.691482712824;12439.253644781342;12464.127511074319;12604.684882878002;228416;230722;231060;231465;231677.84161079087;54263;54315.72842135843;54356.45643543514;54441.45558544364;54551.45448545464;1470.0738534723057;1507.366905899525;1521.7945577347139;1528.1900592685895;1539.2073082362592;22749.203777867697;22812.65781013253;22843.885780570992;22927.541449171258;22940.197093101662;38837.6116238834;39128.608713912494;39140.21719565536;39173;39205.21589568136;189515;189885;190028;190108;190376;35837.46243806397;36493.81753091217;38178;38314.42528362133;38452.42321365126;46791.532084678714;48604.75697621489;48779.26831097608;48883.511164887896;49615.25577116274;35149;35230;35256.471152932216;35279.47080793739;35468.645313546534;34754.478682820285;34971.65028349684;35026.474602881484;35279.647203528664;35628.64371356253;38135.42796858105;39024.609753903234;39099.60900391074;39106.804465978625;39153;33770.66229337675;34162.65837341595;34254.82872585621;34357;34696.653033469345;24299.878500607385;24500.509989799746;24566;25048;25173 05:59:08 INFO - PID 5024 | |2;jquery.html;578.7279978410146;586.5454272938472;590.6013440927373;601.5548494114357;603.089335103993;22253.2211372602;23154.84225788712;23208.071677132917;23280.88359558204;23288.534229315403;21393;23831.404214894636;24858.751412485868;27379.178624641292;27472;6502.479801615883;6615.735370585171;6620.437262832665;6634.436072933782;6636.502262330345;6490.675466226693;6548.574342667712;6573.57271777333;6574.835629109262;6599.208095028604;5945.405459454041;6213.5339849511465;6481.611103333815;6505.60966342021;6511.967440162793;6359.395857393563;6406.519511036691;6407.935920640827;6413.0380442933465;6433.035044743279;5991.460768530853;5993.820185394445;5994.55040871932;5998.310194327621;5998.790042348541;28736.425271494663;29543.704562954525;30038.399232015458;30124.397512049636;30415.39169216603;1930.4305229957197;1976.1107501624183;1982.682770756672;1983.3752368004032;1985.4738494299022;19509.512262193417;20192.596148077104;20209.898950505154;20244.291449799188;20262;2423.3699238198196;2447.6328550717535;2510.698716154055;2517.710463296726;2524.684414448194;124745;130561.34719326437;137127;139293.3035334817;145613;14606.551672714535;15008.324625391884;15297.847021529866;15364;15459.227038648023;24235.636465453033;24460.388490287885;24619.13833015836;24641;24651.3837154069;10481.161507079416;10495.317804342692;10596.205284603686;10704;10767;9837;9865.506724663737;9872.259580531489;9874.370728829663;9979.750506237257;9242.399244049115;9282.164605185566;9434.150926416656;9441.433513989183;9471.621135154655;2595.5587550116147;2601.2326363722746;2685.207863680219;2700.554408522572;2744.8764805583796;953.7520244736419;972.6741541583649;985.7929834734642;992.012111312534;998.8152191844532;19918.701219481718;20010.59978800445;20513.692294615594;20715.792842071387;20749;1033.6537260017828;1040.167865707431;1041.9684512332735;1046.1212581431635;1047.9738006549896;10888.61889833852;11449.084073274118;13596.59210223695;14043.859561404255;14377.928110359591;501833;503086;512331;512438;517991;120300.3984980087;124778;125687;125987;126750;1247.2765795838393;1298.5844529750389;1311.1739604049387;1324;1329.9534516291883;20959.476013099793;21411.67882481733;21448.678269825654;21603.35189944304;21604.45988850291;54416.45583544114;55158.448415516934;56561;56675.433245667016;57498.42501574931;70225;70815;71647.28352716615;73045.26954730597;73296.63351683208;14757.92621036888;15148.621284467976;15306.234688265766;15312.923435382752;15370.846291536942;23768.8811555948;23883.28350149498;23905;24049;24089.879550602134;18975.715364269272;19137.712934306273;19154.904225478782;19185.424437266905;19188.712169317194;16243.269052892412;17008;17108.887922285012;17542.561435964202;17640.91179544094;19294.7105793416;19512;19617.901910490928;19630.607387852448;19705;14778.852211477748;15099.54701358961;15099.698006040038;15122.54632361031;15574.844251557339;18801.90599046996;18836.152373143515;18981.715274271173;18983.810161898204;19002.904985474983 05:59:08 INFO - PID 5024 | |3;mootools.html;1358.836939567252;1416.70249247658;1427.4361627157273;1429.0711037825413;1432.5988723157507;11861.347625880573;13348.399322030507;14005.649858753524;14014.579562613126;14020.859791402083;11933.403329833516;13137.343132843343;14079.366428510715;14100.224487653175;14142.363593638285;2630.302969713028;2693.0439693908675;2694.5688689809635;2697;2698.055680511825;2547.821652484327;2615.646887670169;2619.148776647597;2624.973750262492;2630.986845065772;2634.7101818799915;2639.6700412448445;2645.6957449893316;2655.2034389683113;2657.1762753546464;2568.935776605581;2581.2256323102993;2586.974130258711;2592.079811666869;2593.286846117314;2339.017612602711;2340.9297721068224;2340.9882950585306;2349.3774149850306;2355.9057637694473;13091.279979601119;13423.261720605362;13428.664283392896;13437.462501499927;13449.663758406117;7385.9261407385775;7636.236376362375;7661.961690191513;7662.3487003604205;7666.693332266703;4692.788824502905;4912.70523768575;4973.1297023020825;5084.262781896641;5134.922976155361;1770.0972504022911;1774.6805574996495;1806.2865168258595;1816.1101060480269;1842.0973722875694;22531.211407600655;22609.660855087186;22644.094236230532;22672.319830405115;22746.43133921665;6685.966570167118;6762;6993.965030174817;7017.298270172942;7033.683484243222;17660.646787064186;17764.644707105785;17765.289388424317;17778.91110544439;17784.3775467858;7504.287092726182;7603.809904752315;7730.265624765639;7793;7881.172476889844;6020.367861374581;6203.379662033761;6329.3987071229085;6362.2683391409655;7092.503524753218;5381.73091345439;5460.180972854104;5503.697296648643;5536.2249285100115;5691.231683722727;1716.6566686662718;1722.3971609936673;1730.3078768492703;1735.5400818783032;1759.0211012610812;902.5216635183364;915.7481692534607;920.1580553793204;935.0182308575968;938.3619138985418;7886.329661978796;8238.09380968093;8252.381071419668;8296;8298.502089874626;731.7000029987679;734.6730704836403;741.3994664321916;743.5390058163865;747.760716570703;4646.3495110684535;5640.238567793295;5721.113227449752;5803.6807975560905;5877.970610146922;19022.52443688891;19782.70325945112;19802.405927822187;19804.40586782399;19829.900850495655;18969.715454268196;19339.226430942887;19390;19400;19400.514987125152;10580.841287380541;10711.410872401937;10853.728656783485;10947.178961577914;10952.069074128629;8669.479831210148;8777.166169213915;8807.383483156118;8844.46933184011;8900.554972251231;16395.016299022096;16540;16550.255238514055;16624.508853140975;16686.91656541758;17084.145792710562;17208.655826883143;17383.217755200792;17397.21712522914;17426.128693565526;11506.827397588875;11758.58844940423;11807.527698891949;11811.586594469496;11825.290482571074;12777.55278565283;13111.27887966171;13231.139975901535;13259.734805303648;13284.269365185008;10658.62694805678;10733.516991735234;10890.128789696964;10918.6724398265;11101.222914395914;10239.692809215736;10414.479276036016;10447.373157610567;10595.15238780911;10648.307859989076;9424.340296179476;9491.38306010107;9629.422234665662;9662.806743864943;9676.516174191403;7182.174049984319;7453.701851926079;7494.662740176815;7513.098428188652;7550.7734767957045;7466.477346585687;7482.513636613603;7518.473706840468;7559.055118110236;7570.810729731801 05:59:08 INFO - PID 5024 | |4;prototype.html;470.8799256189671;487.2350409856527;496.15405733224844;504.55851130261016;511.2893078620718;6174.660393678346;6207.80298146455;6251.34360892106;6275.3684042149025;6290.811275661726;5814.709264536767;6046.216366171979;6070.605410648316;6074.453299203071;6074.48366888815;4934.506549345073;4935.703857768527;4949.802007919688;4950.133726597849;4951.702897826124;4856.9115280429405;4924.655274130812;4934.605231581483;4934.703917764928;4945.629077819178;4679.578837904588;4880.853574392774;4900.0889653035165;4900.206882077217;4920.581750551208;4821.517848215186;4852.223644216943;4897.559219670246;4919.975400122994;4938.654294199408;4377.402248179392;4379;4383.495897971742;4384.342348647697;4400.713953593038;6078.6048906820915;6101.938980610182;6106.542009349317;6129.111278864584;6162.8767424651705;5664.603477756558;5681.261436013292;5702.800401985911;5719.971400142973;5737.770489180428;6378;6438.935610643881;6510.739570417178;6540.345965403421;6574.112494813235;4749.62003039756;4781.6174706023785;4785.904281914342;4827.25177597473;4840.975795121002;6810.148731408574;6831.69257383414;6881.621510816954;6895.620740859301;6950;4908;4948.183549714328;4973.602111831045;4996;5006.6495345325475;4946.8127649364615;4957.90084198314;5008.123578373843;5042.168042273057;5061.392632884003;5642.266505354278;5693.231413759172;5695.316562012585;5704.71476426177;5735.426457354315;6367.363263673596;6487.156669632917;6545.9018114728315;6587.505937054644;6616.96691516549;1653.2973486268288;1697.6944150052861;1715.5453804741753;1745.8428741413334;1862.366795289608;1404.37505310136;1409.753293173711;1434.426229508205;1443.682389874226;1446.8263808343065;5822.155787410802;5833.82498525045;5855.268091488564;5860.648361098348;5872.236609240771;6681.899771503431;6698.430633396216;6721.22705888829;6735.797926062226;6763.695633696496;5848.61983971049;5861.325947516005;5868.911966320508;5894.351621321651;5898;3595.5146055282726;3596.7122630189524;3632.4572799040775;3653.6251436566445;3659.2315613720884;6619.867602648016;6622.403983641495;6632.469402447792;6668.799936001928;6691.631960242136;6950.096487456598;6989.4408447324095;6994.090768200102;7002.894956575656;7057.6118313492225;6486.708098135689;6511;6571.0471981562405;6601.636909969901;6607.141071660653;6555.311692272243;6643.30245324234;6680.766173183915;6726.771149848199;6766.988690032888;6621.867562648817;6707.29573394806;6719.395254427125;6720.327967203436;6734.427573656294;6489.707963141765;6500.609963402211;6507.902381464187;6529.249136349191;6627.768028118992;4962.652614316963;4965.677230979974;4982.950170498249;4984.1526940420945;5019.146745053276;6757.594544327356;6792.218894827158;6825.996561512919;6863.347981941708;6903.413209877217;6564.606123632598;6604.636744979072;6612.371824676648;6612.471002319707;6643.136392268974;6505.543702563759;6577.053767739319;6587.934120658732;6614.70233839488;6687.598744075371;6170.228721409824;6279.843003924939;6340.873182536231;6407.615543067431;6513.641749703812;6594.538382313192;6603.966980165068;6608.281846719791;6612.966935165294;6617.239017512855;6374.852526545266;6381.553291269566;6388.68056597159;6430.517711171775;6446.5165112615805 05:59:08 INFO - PID 5024 | |5;yui.html;891.5319457284925;923.9676611318605;931.436480929038;935.0742764662981;955.1260596554154;17863.285468581256;18543.258269669215;18547.35084272051;18548.99999999998;20749.896250518763;21661.45846353842;22557.66163507549;22595.887020564915;22674.88662556685;22696.773032269713;1024.841149621808;1056.6988408303635;1061.8247989081792;1063.186662203415;1063.2875973098044;1050.144132531988;1056.5087234435987;1056.9048785609293;1057.0328149742977;1059.7986382587321;1005.4771518810214;1085.8262677971527;1095.8301463273165;1103.5034234594425;1104.34843442369;1084.1976937066554;1085.4572713643179;1085.782843431313;1086.044281032694;1086.169080653297;792.9841403171962;793.6190628498354;795.316028215734;795.996020019902;799.532273619933;20107.59784804296;20593;20802;20829.37511874631;20937.5812483751;21645.350639480683;21929.780702192933;22468.55062898733;22499;22504;16923;17091.48725538236;17227;17237.827621723747;17330.74003889943;3637.8362973665985;3719.6466335698337;3721.888343349704;3727.869524566627;3732.1602639406187;114602;114751;117223;117437.99999999914;118159.4092029543;16959.491215263562;17277.049762263196;17747.870255569156;17828.732569011474;17978.5505362367;31535.21161970969;32119.51820722691;32259.35481290408;32327.676723232937;32444.188895277806;7912.643931023118;8229.423940324119;8806.119388061143;8927.553622318988;9222.907770922338;4279.293916503742;4400.647948164204;4412.139632771643;4416.205083085076;4419.535948725337;5391.353037635509;5410.026195284808;5534.75093620788;5543.916841247385;5553.16702494629;1100.5652767156928;1109.5617231193633;1112.5438570186184;1117.2681893359863;1118.725912151512;679.8470344172522;687.1582311668167;698.4796326736512;712.3339677401646;720.4092644031844;12402.875971240353;12419.875801242053;12575.993920486339;13092.214467132002;13246.271455069871;702.1784512120729;705.4427002667835;710.3393843725282;714.7855643306987;729.7518843593203;5668.461496157858;5742.569307301969;5764.538836893039;5830.240632108221;5847.181394604759;96457.51771241239;97325.51337243269;98450.50774746224;98797;98995.50502247443;90485.09514904898;91459.54270228607;94832.52583737037;96846.51576742213;97329;75164;80363;80493.59753201196;80654.59672701599;84809.57595212109;12532.874671253536;12863.356832158168;13173.802392963922;13174.143680660727;13339.333033348488;35836.566537338214;35909.28181436409;35911.64088359083;36401.817990909876;37744.433833491974;45816.77091614521;46183;46215.3067703978;46950;64800.59128454623;16249.756253655969;19768.505787355432;19813.900930495256;19968.50078748043;20282.290119845733;18432.723509147105;20412.489687757923;21363.89318053462;21860.78139218651;22306.10775568959;19381.612367752285;19651.803481965;19727.506812329808;20017.099230534954;20276.290329838386;19721.506962326057;19812.405627831187;20057.799422006177;20168.193272268945;20405.081771320623;19210.519737006685;19219.51951201231;19504.512387190432;19555.8044419554;19937;13314.733705326033;13520;13622.93188534051;14000.159990400609;14855.628609284422;13847.376868040761;13938.094023888414;13985.860141398456;14024.929875350557;14457.85542144565 05:59:08 INFO - PID 5024 | __end_tp_report 05:59:08 INFO - PID 5024 | __start_cc_report 05:59:08 INFO - PID 5024 | _x_x_mozilla_cycle_collect,384 05:59:08 INFO - PID 5024 | __end_cc_report 05:59:08 INFO - PID 5024 | __startTimestamp1502110748010__endTimestamp 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | ------- Summary: start ------- 05:59:08 INFO - PID 5024 | Number of tests: 6 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | [#0] dojo.html Cycles:165 Average:6162.67 Median:6433.74 stddev:726.80 (11.3%) stddev-sans-first:689.58 05:59:08 INFO - PID 5024 | Values: 3151.4 3171.1 3179.4 3199.9 3218.1 6165.4 6206.5 6221.8 6227.6 6230.5 6197.0 6202.1 6334.7 6341.7 6366.1 5695.5 5739.9 5782.8 5794.0 5846.9 5561.8 5639.9 5711.9 5725.7 5852.0 5548.8 5638.1 5648.1 5680.4 5695.5 5705.3 5714.8 5795.7 5806.3 5815.2 5553.3 5637.3 5653.7 5713.5 5715.0 6018.2 6172.4 6175.1 6182.8 6196.1 6654.3 6674.3 6676.6 6685.3 6751.3 6769.4 6803.8 6820.7 6829.9 6832.7 6168.0 6239.3 6301.2 6324.9 6338.1 6758.3 6873.0 6895.5 6953.2 6978.2 6520.3 6553.6 6559.0 6584.0 6601.3 6711.6 6713.4 6713.8 6720.5 6721.5 6728.7 6729.3 6730.6 6734.8 6749.3 6604.2 6654.0 6674.5 6767.6 6776.4 5344.9 5444.7 5459.7 5509.5 5513.6 4631.0 4637.7 4650.7 4672.9 4744.8 5804.2 5808.9 5811.5 5814.4 5823.1 6703.7 6790.6 6791.9 6796.8 6800.6 5747.8 5777.0 5815.7 5826.3 5853.4 5835.3 5919.9 5948.3 5950.4 6019.7 6442.9 6468.3 6471.1 6471.2 6478.6 6614.4 6647.1 6657.3 6710.2 6721.2 6501.2 6522.2 6537.5 6546.3 6610.7 6440.2 6626.4 6641.5 6708.8 6715.6 6632.9 6643.9 6654.1 6665.8 6732.8 6463.8 6475.8 6489.3 6492.4 6493.8 6477.2 6485.9 6488.4 6508.0 6510.3 5499.8 6424.7 6433.7 6459.1 6543.4 6538.9 6564.9 6602.4 6626.3 6643.9 6241.2 6340.4 6352.3 6433.6 6433.6 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | [#1] ext.html Cycles:180 Average:38435.83 Median:3605.07 stddev:53428.04 (1482.0%) stddev-sans-first:53503.36 05:59:08 INFO - PID 5024 | Values: 845.8 886.0 895.9 916.7 1167.9 31971.5 44003.8 44351.8 44383.3 44460.6 40978.4 43856.0 44324.3 44487.6 44601.8 7307.5 7938.3 7959.6 7962.2 7964.0 7801.8 7855.9 7864.7 7917.4 7918.3 7897.9 7980.2 7991.1 7992.6 8001.0 7873.0 7918.4 7921.8 7926.0 7941.1 7731.2 7784.8 7796.1 7805.0 7827.6 40906.0 41117.6 41130.8 41155.4 41236.2 3552.9 3584.9 3586.9 3603.0 3607.1 31581.5 31693.2 31776.8 31797.8 31818.2 4738.8 4760.9 4777.4 4806.7 4827.3 195279.0 195297.0 195792.0 195866.0 196047.0 49310.5 49426.0 49509.0 49648.0 49913.0 51684.5 51823.5 51937.7 51988.2 52038.2 15071.4 15260.2 16646.7 17202.2 17224.5 12617.1 12644.9 13924.4 14233.5 14333.5 13628.7 13736.2 13776.2 13795.4 13880.7 5239.4 5242.5 5243.6 5296.6 5312.3 989.9 1001.6 1027.7 1029.9 1032.1 23089.7 23301.0 23322.4 23469.3 23539.9 1119.2 1120.9 1137.0 1137.1 1157.8 12337.4 12340.7 12439.3 12464.1 12604.7 228416.0 230722.0 231060.0 231465.0 231677.8 54263.0 54315.7 54356.5 54441.5 54551.5 1470.1 1507.4 1521.8 1528.2 1539.2 22749.2 22812.7 22843.9 22927.5 22940.2 38837.6 39128.6 39140.2 39173.0 39205.2 189515.0 189885.0 190028.0 190108.0 190376.0 35837.5 36493.8 38178.0 38314.4 38452.4 46791.5 48604.8 48779.3 48883.5 49615.3 35149.0 35230.0 35256.5 35279.5 35468.6 34754.5 34971.7 35026.5 35279.6 35628.6 38135.4 39024.6 39099.6 39106.8 39153.0 33770.7 34162.7 34254.8 34357.0 34696.7 24299.9 24500.5 24566.0 25048.0 25173.0 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | [#2] jquery.html Cycles:180 Average:35876.12 Median:23528.71 stddev:85689.37 (364.2%) stddev-sans-first:85888.77 05:59:08 INFO - PID 5024 | Values: 578.7 586.5 590.6 601.6 603.1 22253.2 23154.8 23208.1 23280.9 23288.5 21393.0 23831.4 24858.8 27379.2 27472.0 6502.5 6615.7 6620.4 6634.4 6636.5 6490.7 6548.6 6573.6 6574.8 6599.2 5945.4 6213.5 6481.6 6505.6 6512.0 6359.4 6406.5 6407.9 6413.0 6433.0 5991.5 5993.8 5994.6 5998.3 5998.8 28736.4 29543.7 30038.4 30124.4 30415.4 1930.4 1976.1 1982.7 1983.4 1985.5 19509.5 20192.6 20209.9 20244.3 20262.0 2423.4 2447.6 2510.7 2517.7 2524.7 124745.0 130561.3 137127.0 139293.3 145613.0 14606.6 15008.3 15297.8 15364.0 15459.2 24235.6 24460.4 24619.1 24641.0 24651.4 10481.2 10495.3 10596.2 10704.0 10767.0 9837.0 9865.5 9872.3 9874.4 9979.8 9242.4 9282.2 9434.2 9441.4 9471.6 2595.6 2601.2 2685.2 2700.6 2744.9 953.8 972.7 985.8 992.0 998.8 19918.7 20010.6 20513.7 20715.8 20749.0 1033.7 1040.2 1042.0 1046.1 1048.0 10888.6 11449.1 13596.6 14043.9 14377.9 501833.0 503086.0 512331.0 512438.0 517991.0 120300.4 124778.0 125687.0 125987.0 126750.0 1247.3 1298.6 1311.2 1324.0 1330.0 20959.5 21411.7 21448.7 21603.4 21604.5 54416.5 55158.4 56561.0 56675.4 57498.4 70225.0 70815.0 71647.3 73045.3 73296.6 14757.9 15148.6 15306.2 15312.9 15370.8 23768.9 23883.3 23905.0 24049.0 24089.9 18975.7 19137.7 19154.9 19185.4 19188.7 16243.3 17008.0 17108.9 17542.6 17640.9 19294.7 19512.0 19617.9 19630.6 19705.0 14778.9 15099.5 15099.7 15122.5 15574.8 18801.9 18836.2 18981.7 18983.8 19002.9 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | [#3] mootools.html Cycles:180 Average:8781.39 Median:2558.38 stddev:5942.53 (232.3%) stddev-sans-first:5933.03 05:59:08 INFO - PID 5024 | Values: 1358.8 1416.7 1427.4 1429.1 1432.6 11861.3 13348.4 14005.6 14014.6 14020.9 11933.4 13137.3 14079.4 14100.2 14142.4 2630.3 2693.0 2694.6 2697.0 2698.1 2547.8 2615.6 2619.1 2625.0 2631.0 2634.7 2639.7 2645.7 2655.2 2657.2 2568.9 2581.2 2587.0 2592.1 2593.3 2339.0 2340.9 2341.0 2349.4 2355.9 13091.3 13423.3 13428.7 13437.5 13449.7 7385.9 7636.2 7662.0 7662.3 7666.7 4692.8 4912.7 4973.1 5084.3 5134.9 1770.1 1774.7 1806.3 1816.1 1842.1 22531.2 22609.7 22644.1 22672.3 22746.4 6686.0 6762.0 6994.0 7017.3 7033.7 17660.6 17764.6 17765.3 17778.9 17784.4 7504.3 7603.8 7730.3 7793.0 7881.2 6020.4 6203.4 6329.4 6362.3 7092.5 5381.7 5460.2 5503.7 5536.2 5691.2 1716.7 1722.4 1730.3 1735.5 1759.0 902.5 915.7 920.2 935.0 938.4 7886.3 8238.1 8252.4 8296.0 8298.5 731.7 734.7 741.4 743.5 747.8 4646.3 5640.2 5721.1 5803.7 5878.0 19022.5 19782.7 19802.4 19804.4 19829.9 18969.7 19339.2 19390.0 19400.0 19400.5 10580.8 10711.4 10853.7 10947.2 10952.1 8669.5 8777.2 8807.4 8844.5 8900.6 16395.0 16540.0 16550.3 16624.5 16686.9 17084.1 17208.7 17383.2 17397.2 17426.1 11506.8 11758.6 11807.5 11811.6 11825.3 12777.6 13111.3 13231.1 13259.7 13284.3 10658.6 10733.5 10890.1 10918.7 11101.2 10239.7 10414.5 10447.4 10595.2 10648.3 9424.3 9491.4 9629.4 9662.8 9676.5 7182.2 7453.7 7494.7 7513.1 7550.8 7466.5 7482.5 7518.5 7559.1 7570.8 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | [#4] prototype.html Cycles:180 Average:5516.98 Median:6090.27 stddev:1548.19 (25.4%) stddev-sans-first:1505.49 05:59:08 INFO - PID 5024 | Values: 470.9 487.2 496.2 504.6 511.3 6174.7 6207.8 6251.3 6275.4 6290.8 5814.7 6046.2 6070.6 6074.5 6074.5 4934.5 4935.7 4949.8 4950.1 4951.7 4856.9 4924.7 4934.6 4934.7 4945.6 4679.6 4880.9 4900.1 4900.2 4920.6 4821.5 4852.2 4897.6 4920.0 4938.7 4377.4 4379.0 4383.5 4384.3 4400.7 6078.6 6101.9 6106.5 6129.1 6162.9 5664.6 5681.3 5702.8 5720.0 5737.8 6378.0 6438.9 6510.7 6540.3 6574.1 4749.6 4781.6 4785.9 4827.3 4841.0 6810.1 6831.7 6881.6 6895.6 6950.0 4908.0 4948.2 4973.6 4996.0 5006.6 4946.8 4957.9 5008.1 5042.2 5061.4 5642.3 5693.2 5695.3 5704.7 5735.4 6367.4 6487.2 6545.9 6587.5 6617.0 1653.3 1697.7 1715.5 1745.8 1862.4 1404.4 1409.8 1434.4 1443.7 1446.8 5822.2 5833.8 5855.3 5860.6 5872.2 6681.9 6698.4 6721.2 6735.8 6763.7 5848.6 5861.3 5868.9 5894.4 5898.0 3595.5 3596.7 3632.5 3653.6 3659.2 6619.9 6622.4 6632.5 6668.8 6691.6 6950.1 6989.4 6994.1 7002.9 7057.6 6486.7 6511.0 6571.0 6601.6 6607.1 6555.3 6643.3 6680.8 6726.8 6767.0 6621.9 6707.3 6719.4 6720.3 6734.4 6489.7 6500.6 6507.9 6529.2 6627.8 4962.7 4965.7 4983.0 4984.2 5019.1 6757.6 6792.2 6826.0 6863.3 6903.4 6564.6 6604.6 6612.4 6612.5 6643.1 6505.5 6577.1 6587.9 6614.7 6687.6 6170.2 6279.8 6340.9 6407.6 6513.6 6594.5 6604.0 6608.3 6613.0 6617.2 6374.9 6381.6 6388.7 6430.5 6446.5 05:59:08 INFO - PID 5024 | 05:59:08 INFO - PID 5024 | [#5] yui.html Cycles:180 Average:22663.35 Median:20883.48 stddev:29038.61 (139.1%) stddev-sans-first:29074.04 05:59:08 INFO - PID 5024 | Values: 891.5 924.0 931.4 935.1 955.1 17863.3 18543.3 18547.4 18549.0 20749.9 21661.5 22557.7 22595.9 22674.9 22696.8 1024.8 1056.7 1061.8 1063.2 1063.3 1050.1 1056.5 1056.9 1057.0 1059.8 1005.5 1085.8 1095.8 1103.5 1104.3 1084.2 1085.5 1085.8 1086.0 1086.2 793.0 793.6 795.3 796.0 799.5 20107.6 20593.0 20802.0 20829.4 20937.6 21645.4 21929.8 22468.6 22499.0 22504.0 16923.0 17091.5 17227.0 17237.8 17330.7 3637.8 3719.6 3721.9 3727.9 3732.2 114602.0 114751.0 117223.0 117438.0 118159.4 16959.5 17277.0 17747.9 17828.7 17978.6 31535.2 32119.5 32259.4 32327.7 32444.2 7912.6 8229.4 8806.1 8927.6 9222.9 4279.3 4400.6 4412.1 4416.2 4419.5 5391.4 5410.0 5534.8 5543.9 5553.2 1100.6 1109.6 1112.5 1117.3 1118.7 679.8 687.2 698.5 712.3 720.4 12402.9 12419.9 12576.0 13092.2 13246.3 702.2 705.4 710.3 714.8 729.8 5668.5 5742.6 5764.5 5830.2 5847.2 96457.5 97325.5 98450.5 98797.0 98995.5 90485.1 91459.5 94832.5 96846.5 97329.0 75164.0 80363.0 80493.6 80654.6 84809.6 12532.9 12863.4 13173.8 13174.1 13339.3 35836.6 35909.3 35911.6 36401.8 37744.4 45816.8 46183.0 46215.3 46950.0 64800.6 16249.8 19768.5 19813.9 19968.5 20282.3 18432.7 20412.5 21363.9 21860.8 22306.1 19381.6 19651.8 19727.5 20017.1 20276.3 19721.5 19812.4 20057.8 20168.2 20405.1 19210.5 19219.5 19504.5 19555.8 19937.0 13314.7 13520.0 13622.9 14000.2 14855.6 13847.4 13938.1 13985.9 14024.9 14457.9 05:59:08 INFO - PID 5024 | -------- Summary: end -------- 05:59:08 INFO - PID 5024 | 05:59:08 INFO - TEST-INFO | 5024: exit 0 05:59:08 INFO - TEST-OK | dromaeo_css | took 1114236ms 05:59:08 INFO - TEST-START | kraken 05:59:08 INFO - Initialising browser for kraken test... 05:59:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58478/getInfo.html -profile /tmp/tmpTvuyOD/profile 05:59:08 INFO - TEST-INFO | started process 5398 (/builds/slave/test/build/application/firefox/firefox http://localhost:58478/getInfo.html) 05:59:15 INFO - TEST-INFO | 5398: exit 0 05:59:15 INFO - Browser initialized. 05:59:15 INFO - Running cycle 1/1 for kraken test... 05:59:15 INFO - TEST-INFO | started process 5623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvuyOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:16 INFO - PID 5623 | 05:59:16 INFO - PID 5623 | (/builds/slave/test/build/application/firefox/firefox:5678): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:59:16 INFO - PID 5623 | 05:59:26 INFO - PID 5623 | RSS: Main: 170991616 05:59:26 INFO - PID 5623 | 05:59:26 INFO - PID 5623 | serialization: Helvetica 05:59:26 INFO - PID 5623 | serialization: Arial 05:59:29 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:30 INFO - PID 5623 | RSS: Main: 177270784 05:59:30 INFO - PID 5623 | 05:59:30 INFO - PID 5623 | serialization: Helvetica 05:59:30 INFO - PID 5623 | serialization: Arial 05:59:32 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-dft) 05:59:33 INFO - PID 5623 | RSS: Main: 177086464 05:59:33 INFO - PID 5623 | 05:59:33 INFO - PID 5623 | serialization: Helvetica 05:59:33 INFO - PID 5623 | serialization: Arial 05:59:36 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-fft) 05:59:37 INFO - PID 5623 | RSS: Main: 172261376 05:59:37 INFO - PID 5623 | 05:59:37 INFO - PID 5623 | serialization: Helvetica 05:59:37 INFO - PID 5623 | serialization: Arial 05:59:39 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58478/tests/kraken/driver.html?testName=audio-oscillator) 05:59:40 INFO - PID 5623 | RSS: Main: 172912640 05:59:40 INFO - PID 5623 | 05:59:40 INFO - PID 5623 | serialization: Helvetica 05:59:40 INFO - PID 5623 | serialization: Arial 05:59:42 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58478/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:59:42 INFO - PID 5623 | RSS: Main: 173170688 05:59:42 INFO - PID 5623 | 05:59:42 INFO - PID 5623 | serialization: Helvetica 05:59:42 INFO - PID 5623 | serialization: Arial 05:59:46 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58478/tests/kraken/driver.html?testName=imaging-darkroom) 05:59:46 INFO - PID 5623 | RSS: Main: 176271360 05:59:46 INFO - PID 5623 | 05:59:46 INFO - PID 5623 | serialization: Helvetica 05:59:46 INFO - PID 5623 | serialization: Arial 05:59:50 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58478/tests/kraken/driver.html?testName=imaging-desaturate) 05:59:50 INFO - PID 5623 | RSS: Main: 175656960 05:59:50 INFO - PID 5623 | 05:59:50 INFO - PID 5623 | serialization: Helvetica 05:59:50 INFO - PID 5623 | serialization: Arial 05:59:53 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58478/tests/kraken/driver.html?testName=json-parse-financial) 05:59:54 INFO - PID 5623 | RSS: Main: 176451584 05:59:54 INFO - PID 5623 | 05:59:54 INFO - PID 5623 | serialization: Helvetica 05:59:54 INFO - PID 5623 | serialization: Arial 05:59:56 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58478/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:56 INFO - PID 5623 | RSS: Main: 176140288 05:59:56 INFO - PID 5623 | 05:59:56 INFO - PID 5623 | serialization: Helvetica 05:59:56 INFO - PID 5623 | serialization: Arial 05:59:58 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:59 INFO - PID 5623 | RSS: Main: 173461504 05:59:59 INFO - PID 5623 | 05:59:59 INFO - PID 5623 | serialization: Helvetica 05:59:59 INFO - PID 5623 | serialization: Arial 06:00:01 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:02 INFO - PID 5623 | RSS: Main: 173555712 06:00:02 INFO - PID 5623 | 06:00:02 INFO - PID 5623 | serialization: Helvetica 06:00:02 INFO - PID 5623 | serialization: Arial 06:00:04 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:05 INFO - PID 5623 | RSS: Main: 174202880 06:00:05 INFO - PID 5623 | 06:00:05 INFO - PID 5623 | serialization: Helvetica 06:00:05 INFO - PID 5623 | serialization: Arial 06:00:08 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:09 INFO - PID 5623 | RSS: Main: 173780992 06:00:09 INFO - PID 5623 | 06:00:09 INFO - PID 5623 | serialization: Helvetica 06:00:09 INFO - PID 5623 | serialization: Arial 06:00:11 INFO - PID 5623 | Cycle 1(1): loaded http://localhost:58478/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58478/tests/kraken/driver.html?testName=ai-astar) 06:00:11 INFO - PID 5623 | RSS: Main: 175448064 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | __start_tp_report 06:00:11 INFO - PID 5623 | _x_x_mozilla_page_load 06:00:11 INFO - PID 5623 | _x_x_mozilla_page_load_details 06:00:11 INFO - PID 5623 | |i|pagename|runs| 06:00:11 INFO - PID 5623 | |0;ai-astar;98;112;101;112;108;116;107;100;106;111 06:00:11 INFO - PID 5623 | |1;audio-beat-detection;150;122;138;176;131;161;155;117;181;120 06:00:11 INFO - PID 5623 | |2;audio-dft;167;162;162;162;162;168;178;162;161;164 06:00:11 INFO - PID 5623 | |3;audio-fft;74;80;74;186;76;75;78;75;159;75 06:00:11 INFO - PID 5623 | |4;audio-oscillator;78;78;127;78;84;79;133;85;83;127 06:00:11 INFO - PID 5623 | |5;imaging-gaussian-blur;113;114;114;119;117;117;115;115;117;118 06:00:11 INFO - PID 5623 | |6;imaging-darkroom;150;152;155;150;150;151;150;150;155;152 06:00:11 INFO - PID 5623 | |7;imaging-desaturate;94;94;95;94;97;98;94;94;94;94 06:00:11 INFO - PID 5623 | |8;json-parse-financial;54;54;63;54;53;53;53;53;53;57 06:00:11 INFO - PID 5623 | |9;json-stringify-tinderbox;55;55;55;61;57;58;54;65;55;56 06:00:11 INFO - PID 5623 | |10;stanford-crypto-aes;78;88;84;88;93;90;77;79;77;77 06:00:11 INFO - PID 5623 | |11;stanford-crypto-ccm;123;122;139;135;125;132;134;127;124;164 06:00:11 INFO - PID 5623 | |12;stanford-crypto-pbkdf2;174;176;172;181;174;173;173;175;174;170 06:00:11 INFO - PID 5623 | |13;stanford-crypto-sha256-iterative;66;67;69;69;76;71;65;69;68;67 06:00:11 INFO - PID 5623 | __end_tp_report 06:00:11 INFO - PID 5623 | __start_cc_report 06:00:11 INFO - PID 5623 | _x_x_mozilla_cycle_collect,987 06:00:11 INFO - PID 5623 | __end_cc_report 06:00:11 INFO - PID 5623 | __startTimestamp1502110811388__endTimestamp 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | ------- Summary: start ------- 06:00:11 INFO - PID 5623 | Number of tests: 14 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#0] ai-astar Cycles:10 Average:107.10 Median:111.50 stddev:5.92 (5.3%) stddev-sans-first:5.28 06:00:11 INFO - PID 5623 | Values: 98.0 112.0 101.0 112.0 108.0 116.0 107.0 100.0 106.0 111.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.50 stddev:23.14 (15.2%) stddev-sans-first:24.48 06:00:11 INFO - PID 5623 | Values: 150.0 122.0 138.0 176.0 131.0 161.0 155.0 117.0 181.0 120.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.00 stddev:5.20 (3.2%) stddev-sans-first:5.46 06:00:11 INFO - PID 5623 | Values: 167.0 162.0 162.0 162.0 162.0 168.0 178.0 162.0 161.0 164.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.00 stddev:41.28 (55.0%) stddev-sans-first:43.06 06:00:11 INFO - PID 5623 | Values: 74.0 80.0 74.0 186.0 76.0 75.0 78.0 75.0 159.0 75.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:78.50 stddev:23.52 (30.0%) stddev-sans-first:24.11 06:00:11 INFO - PID 5623 | Values: 78.0 78.0 127.0 78.0 84.0 79.0 133.0 85.0 83.0 127.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:117.00 stddev:1.97 (1.7%) stddev-sans-first:1.79 06:00:11 INFO - PID 5623 | Values: 113.0 114.0 114.0 119.0 117.0 117.0 115.0 115.0 117.0 118.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.50 stddev:2.01 (1.3%) stddev-sans-first:2.06 06:00:11 INFO - PID 5623 | Values: 150.0 152.0 155.0 150.0 150.0 151.0 150.0 150.0 155.0 152.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.48 (1.6%) stddev-sans-first:1.54 06:00:11 INFO - PID 5623 | Values: 94.0 94.0 95.0 94.0 97.0 98.0 94.0 94.0 94.0 94.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.00 stddev:3.16 (5.9%) stddev-sans-first:3.35 06:00:11 INFO - PID 5623 | Values: 54.0 54.0 63.0 54.0 53.0 53.0 53.0 53.0 53.0 57.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:56.50 stddev:3.45 (6.1%) stddev-sans-first:3.57 06:00:11 INFO - PID 5623 | Values: 55.0 55.0 55.0 61.0 57.0 58.0 54.0 65.0 55.0 56.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:86.00 stddev:6.23 (7.2%) stddev-sans-first:6.32 06:00:11 INFO - PID 5623 | Values: 78.0 88.0 84.0 88.0 93.0 90.0 77.0 79.0 77.0 77.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:133.00 stddev:12.48 (9.4%) stddev-sans-first:12.76 06:00:11 INFO - PID 5623 | Values: 123.0 122.0 139.0 135.0 125.0 132.0 134.0 127.0 124.0 164.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:2.90 (1.7%) stddev-sans-first:3.07 06:00:11 INFO - PID 5623 | Values: 174.0 176.0 172.0 181.0 174.0 173.0 173.0 175.0 174.0 170.0 06:00:11 INFO - PID 5623 | 06:00:11 INFO - PID 5623 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:3.09 (4.5%) stddev-sans-first:3.12 06:00:11 INFO - PID 5623 | Values: 66.0 67.0 69.0 69.0 76.0 71.0 65.0 69.0 68.0 67.0 06:00:11 INFO - PID 5623 | -------- Summary: end -------- 06:00:11 INFO - PID 5623 | 06:00:12 INFO - PID 5623 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:00:12 INFO - TEST-INFO | 5623: exit 0 06:00:12 INFO - TEST-OK | kraken | took 63524ms 06:00:12 INFO - SUITE-END | took 1177s 06:00:12 INFO - Completed test suite (00:19:38) 06:00:12 INFO - javascript benchmark 06:00:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8582.249033115431, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.401233765586, 3171.0962375722916, 3179.4118088153677, 3199.9040028799136, 3218.0667606394145, 6165.414285642868, 6206.534509911763, 6221.844453888655, 6227.5952063115865, 6230.5327100467475, 6197.0, 6202.06968954657, 6334.714937827797, 6341.651209183493, 6366.076918846765, 5695.468993269908, 5739.856503587402, 5782.768689252425, 5793.986052440806, 5846.912296315559, 5561.833145005636, 5639.943600564004, 5711.914321285184, 5725.742341594618, 5852.034414321632, 5548.77804887804, 5638.069718496443, 5648.068068768669, 5680.4319568043275, 5695.487406133447, 5705.315362156526, 5714.828555143311, 5795.710214489259, 5806.274215723035, 5815.244018277639, 5553.333599967989, 5637.3235211774845, 5653.660780353192, 5713.485786279213, 5715.028445164332, 6018.15745795589, 6172.4136207060255, 6175.073738939195, 6182.783602573933, 6196.101565273055, 6654.334566543307, 6674.2658307586125, 6676.599404035774, 6685.298043705389, 6751.25736169021, 6769.3907548320885, 6803.829904252384, 6820.727170913157, 6829.93170068298, 6832.658367081626, 6168.0439531872635, 6239.282482514478, 6301.212348456443, 6324.905126423016, 6338.080978258173, 6758.324167583301, 6873.037774711544, 6895.482838787111, 6953.165620125617, 6978.197507286625, 6520.315366886409, 6553.574017688835, 6558.967205163944, 6584.0, 6601.2738598754095, 6711.630860302633, 6713.429358504484, 6713.765018224339, 6720.495962802809, 6721.529492935545, 6728.697208625624, 6729.293424190488, 6730.629815360105, 6734.797956061326, 6749.257581666013, 6604.174478190226, 6654.0, 6674.466042716571, 6767.560108592926, 6776.356246156607, 5344.91982620261, 5444.700541470257, 5459.672419654754, 5509.531689806411, 5513.61404701667, 4630.976845115752, 4637.721736695809, 4650.67445278834, 4672.906541869143, 4744.810207591727, 5804.245448091721, 5808.912866307009, 5811.506021988093, 5814.360420353758, 5823.068309070529, 6703.698333574904, 6790.5925644461495, 6791.864162716718, 6796.76211332601, 6800.625965571842, 5747.770089196469, 5777.046787280052, 5815.738291776795, 5826.329972053183, 5853.414658534112, 5835.299764028344, 5919.881602367928, 5948.286205655262, 5950.404959504015, 6019.668918209453, 6442.871142577123, 6468.2561505427475, 6471.0940468334475, 6471.158749362647, 6478.578892372075, 6614.437772789174, 6647.135872336566, 6657.300983396867, 6710.194776626836, 6721.193456785217, 6501.1548498694865, 6522.15212022453, 6537.5096867736065, 6546.279909210079, 6610.702518386588, 6440.227172739301, 6626.370494802986, 6641.468682505291, 6708.798736037927, 6715.630640314829, 6632.867342653217, 6643.9335606645245, 6654.13496245485, 6665.766698165541, 6732.831679208059, 6463.838404039937, 6475.838104047248, 6489.253735820441, 6492.448141907991, 6493.772717954849, 6477.190351206099, 6485.935140648533, 6488.383603557654, 6508.0, 6510.316416776171, 5499.780008799603, 6424.678766061772, 6433.742650293936, 6459.128017717548, 6543.378379053982, 6538.869222615426, 6564.901526477202, 6602.438792702674, 6626.304238054935, 6643.9335606645245, 6241.188645476059, 6340.365963403623, 6352.301246862934, 6433.581817181868, 6433.613983161025], "value": 6108.828351519335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.8477474054667, 885.9955700221498, 895.8656201569763, 916.6929078758616, 1167.8773728758486, 31971.52042719358, 44003.77998110009, 44351.77824110875, 44383.33424998628, 44460.555394446084, 40978.38532422016, 43856.0, 44324.335134973, 44487.55512444874, 44601.776991115, 7307.4884758066955, 7938.2855543001115, 7959.602019899011, 7962.203779622049, 7963.960180199091, 7801.804954876116, 7855.921440785576, 7864.685412583518, 7917.406194535404, 7918.287354138127, 7897.921020789805, 7980.241877021674, 7991.120976692559, 7992.560409177493, 8000.959995200016, 7873.0, 7918.366530677532, 7921.801954951115, 7926.048874135083, 7941.126476087626, 7731.226877312224, 7784.766457006299, 7796.142424333319, 7804.9609751950875, 7827.569483678395, 40906.0, 41117.58882411168, 41130.79434602838, 41155.38266925998, 41236.1752764943, 3552.928941421183, 3584.9103772405897, 3586.8565257389673, 3603.027182660693, 3607.116256517144, 31581.526277105862, 31693.20766980844, 31776.841115794505, 31797.84101079503, 31818.204544886332, 4738.763061846894, 4760.880977975544, 4777.355057067321, 4806.687565308279, 4827.348307978448, 195279.0, 195297.0, 195792.0, 195866.02066989717, 196047.0, 49310.506894931306, 49426.0, 49509.0, 49648.0, 49913.0, 51684.48315516872, 51823.48176518187, 51937.7403112982, 51988.22017669738, 52038.21942670863, 15071.397144114331, 15260.236988150547, 16646.6670666586, 17202.22589983454, 17224.483265502055, 12617.116801823784, 12644.873551264554, 13924.373403196678, 14233.50182743599, 14333.498327558485, 13628.65928351799, 13736.175829450265, 13776.173429594257, 13795.379207935666, 13880.652983675489, 5239.423663397023, 5242.501962313574, 5243.606729495303, 5296.602754793329, 5312.256284120226, 989.9406035637885, 1001.5796056467228, 1027.7430642339416, 1029.897010298964, 1032.0608246495653, 23089.653655195187, 23301.0, 23322.416939576306, 23469.29592112205, 23539.882300588386, 1119.238917536067, 1120.9495572699086, 1136.9886301137049, 1137.1073707139856, 1157.8031734605138, 12337.383130843422, 12340.691482712824, 12439.253644781342, 12464.127511074319, 12604.684882878002, 228416.0, 230722.0, 231060.0, 231465.0, 231677.84161079087, 54263.0, 54315.72842135843, 54356.45643543514, 54441.45558544364, 54551.45448545464, 1470.0738534723057, 1507.366905899525, 1521.7945577347139, 1528.1900592685895, 1539.2073082362592, 22749.203777867697, 22812.65781013253, 22843.885780570992, 22927.541449171258, 22940.197093101662, 38837.6116238834, 39128.608713912494, 39140.21719565536, 39173.0, 39205.21589568136, 189515.0, 189885.0, 190028.0, 190108.0, 190376.0, 35837.46243806397, 36493.81753091217, 38178.0, 38314.42528362133, 38452.42321365126, 46791.532084678714, 48604.75697621489, 48779.26831097608, 48883.511164887896, 49615.25577116274, 35149.0, 35230.0, 35256.471152932216, 35279.47080793739, 35468.645313546534, 34754.478682820285, 34971.65028349684, 35026.474602881484, 35279.647203528664, 35628.64371356253, 38135.42796858105, 39024.609753903234, 39099.60900391074, 39106.804465978625, 39153.0, 33770.66229337675, 34162.65837341595, 34254.82872585621, 34357.0, 34696.653033469345, 24299.878500607385, 24500.509989799746, 24566.0, 25048.0, 25173.0], "value": 17643.848056620256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7279978410146, 586.5454272938472, 590.6013440927373, 601.5548494114357, 603.089335103993, 22253.2211372602, 23154.84225788712, 23208.071677132917, 23280.88359558204, 23288.534229315403, 21393.0, 23831.404214894636, 24858.751412485868, 27379.178624641292, 27472.0, 6502.479801615883, 6615.735370585171, 6620.437262832665, 6634.436072933782, 6636.502262330345, 6490.675466226693, 6548.574342667712, 6573.57271777333, 6574.835629109262, 6599.208095028604, 5945.405459454041, 6213.5339849511465, 6481.611103333815, 6505.60966342021, 6511.967440162793, 6359.395857393563, 6406.519511036691, 6407.935920640827, 6413.0380442933465, 6433.035044743279, 5991.460768530853, 5993.820185394445, 5994.55040871932, 5998.310194327621, 5998.790042348541, 28736.425271494663, 29543.704562954525, 30038.399232015458, 30124.397512049636, 30415.39169216603, 1930.4305229957197, 1976.1107501624183, 1982.682770756672, 1983.3752368004032, 1985.4738494299022, 19509.512262193417, 20192.596148077104, 20209.898950505154, 20244.291449799188, 20262.0, 2423.3699238198196, 2447.6328550717535, 2510.698716154055, 2517.710463296726, 2524.684414448194, 124745.0, 130561.34719326437, 137127.0, 139293.3035334817, 145613.0, 14606.551672714535, 15008.324625391884, 15297.847021529866, 15364.0, 15459.227038648023, 24235.636465453033, 24460.388490287885, 24619.13833015836, 24641.0, 24651.3837154069, 10481.161507079416, 10495.317804342692, 10596.205284603686, 10704.0, 10767.0, 9837.0, 9865.506724663737, 9872.259580531489, 9874.370728829663, 9979.750506237257, 9242.399244049115, 9282.164605185566, 9434.150926416656, 9441.433513989183, 9471.621135154655, 2595.5587550116147, 2601.2326363722746, 2685.207863680219, 2700.554408522572, 2744.8764805583796, 953.7520244736419, 972.6741541583649, 985.7929834734642, 992.012111312534, 998.8152191844532, 19918.701219481718, 20010.59978800445, 20513.692294615594, 20715.792842071387, 20749.0, 1033.6537260017828, 1040.167865707431, 1041.9684512332735, 1046.1212581431635, 1047.9738006549896, 10888.61889833852, 11449.084073274118, 13596.59210223695, 14043.859561404255, 14377.928110359591, 501833.0, 503086.0, 512331.0, 512438.0, 517991.0, 120300.3984980087, 124778.0, 125687.0, 125987.0, 126750.0, 1247.2765795838393, 1298.5844529750389, 1311.1739604049387, 1324.0, 1329.9534516291883, 20959.476013099793, 21411.67882481733, 21448.678269825654, 21603.35189944304, 21604.45988850291, 54416.45583544114, 55158.448415516934, 56561.0, 56675.433245667016, 57498.42501574931, 70225.0, 70815.0, 71647.28352716615, 73045.26954730597, 73296.63351683208, 14757.92621036888, 15148.621284467976, 15306.234688265766, 15312.923435382752, 15370.846291536942, 23768.8811555948, 23883.28350149498, 23905.0, 24049.0, 24089.879550602134, 18975.715364269272, 19137.712934306273, 19154.904225478782, 19185.424437266905, 19188.712169317194, 16243.269052892412, 17008.0, 17108.887922285012, 17542.561435964202, 17640.91179544094, 19294.7105793416, 19512.0, 19617.901910490928, 19630.607387852448, 19705.0, 14778.852211477748, 15099.54701358961, 15099.698006040038, 15122.54632361031, 15574.844251557339, 18801.90599046996, 18836.152373143515, 18981.715274271173, 18983.810161898204, 19002.904985474983], "value": 12309.247441341784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.836939567252, 1416.70249247658, 1427.4361627157273, 1429.0711037825413, 1432.5988723157507, 11861.347625880573, 13348.399322030507, 14005.649858753524, 14014.579562613126, 14020.859791402083, 11933.403329833516, 13137.343132843343, 14079.366428510715, 14100.224487653175, 14142.363593638285, 2630.302969713028, 2693.0439693908675, 2694.5688689809635, 2697.0, 2698.055680511825, 2547.821652484327, 2615.646887670169, 2619.148776647597, 2624.973750262492, 2630.986845065772, 2634.7101818799915, 2639.6700412448445, 2645.6957449893316, 2655.2034389683113, 2657.1762753546464, 2568.935776605581, 2581.2256323102993, 2586.974130258711, 2592.079811666869, 2593.286846117314, 2339.017612602711, 2340.9297721068224, 2340.9882950585306, 2349.3774149850306, 2355.9057637694473, 13091.279979601119, 13423.261720605362, 13428.664283392896, 13437.462501499927, 13449.663758406117, 7385.9261407385775, 7636.236376362375, 7661.961690191513, 7662.3487003604205, 7666.693332266703, 4692.788824502905, 4912.70523768575, 4973.1297023020825, 5084.262781896641, 5134.922976155361, 1770.0972504022911, 1774.6805574996495, 1806.2865168258595, 1816.1101060480269, 1842.0973722875694, 22531.211407600655, 22609.660855087186, 22644.094236230532, 22672.319830405115, 22746.43133921665, 6685.966570167118, 6762.0, 6993.965030174817, 7017.298270172942, 7033.683484243222, 17660.646787064186, 17764.644707105785, 17765.289388424317, 17778.91110544439, 17784.3775467858, 7504.287092726182, 7603.809904752315, 7730.265624765639, 7793.0, 7881.172476889844, 6020.367861374581, 6203.379662033761, 6329.3987071229085, 6362.2683391409655, 7092.503524753218, 5381.73091345439, 5460.180972854104, 5503.697296648643, 5536.2249285100115, 5691.231683722727, 1716.6566686662718, 1722.3971609936673, 1730.3078768492703, 1735.5400818783032, 1759.0211012610812, 902.5216635183364, 915.7481692534607, 920.1580553793204, 935.0182308575968, 938.3619138985418, 7886.329661978796, 8238.09380968093, 8252.381071419668, 8296.0, 8298.502089874626, 731.7000029987679, 734.6730704836403, 741.3994664321916, 743.5390058163865, 747.760716570703, 4646.3495110684535, 5640.238567793295, 5721.113227449752, 5803.6807975560905, 5877.970610146922, 19022.52443688891, 19782.70325945112, 19802.405927822187, 19804.40586782399, 19829.900850495655, 18969.715454268196, 19339.226430942887, 19390.0, 19400.0, 19400.514987125152, 10580.841287380541, 10711.410872401937, 10853.728656783485, 10947.178961577914, 10952.069074128629, 8669.479831210148, 8777.166169213915, 8807.383483156118, 8844.46933184011, 8900.554972251231, 16395.016299022096, 16540.0, 16550.255238514055, 16624.508853140975, 16686.91656541758, 17084.145792710562, 17208.655826883143, 17383.217755200792, 17397.21712522914, 17426.128693565526, 11506.827397588875, 11758.58844940423, 11807.527698891949, 11811.586594469496, 11825.290482571074, 12777.55278565283, 13111.27887966171, 13231.139975901535, 13259.734805303648, 13284.269365185008, 10658.62694805678, 10733.516991735234, 10890.128789696964, 10918.6724398265, 11101.222914395914, 10239.692809215736, 10414.479276036016, 10447.373157610567, 10595.15238780911, 10648.307859989076, 9424.340296179476, 9491.38306010107, 9629.422234665662, 9662.806743864943, 9676.516174191403, 7182.174049984319, 7453.701851926079, 7494.662740176815, 7513.098428188652, 7550.7734767957045, 7466.477346585687, 7482.513636613603, 7518.473706840468, 7559.055118110236, 7570.810729731801], "value": 6395.724909255637, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.8799256189671, 487.2350409856527, 496.15405733224844, 504.55851130261016, 511.2893078620718, 6174.660393678346, 6207.80298146455, 6251.34360892106, 6275.3684042149025, 6290.811275661726, 5814.709264536767, 6046.216366171979, 6070.605410648316, 6074.453299203071, 6074.48366888815, 4934.506549345073, 4935.703857768527, 4949.802007919688, 4950.133726597849, 4951.702897826124, 4856.9115280429405, 4924.655274130812, 4934.605231581483, 4934.703917764928, 4945.629077819178, 4679.578837904588, 4880.853574392774, 4900.0889653035165, 4900.206882077217, 4920.581750551208, 4821.517848215186, 4852.223644216943, 4897.559219670246, 4919.975400122994, 4938.654294199408, 4377.402248179392, 4379.0, 4383.495897971742, 4384.342348647697, 4400.713953593038, 6078.6048906820915, 6101.938980610182, 6106.542009349317, 6129.111278864584, 6162.8767424651705, 5664.603477756558, 5681.261436013292, 5702.800401985911, 5719.971400142973, 5737.770489180428, 6378.0, 6438.935610643881, 6510.739570417178, 6540.345965403421, 6574.112494813235, 4749.62003039756, 4781.6174706023785, 4785.904281914342, 4827.25177597473, 4840.975795121002, 6810.148731408574, 6831.69257383414, 6881.621510816954, 6895.620740859301, 6950.0, 4908.0, 4948.183549714328, 4973.602111831045, 4996.0, 5006.6495345325475, 4946.8127649364615, 4957.90084198314, 5008.123578373843, 5042.168042273057, 5061.392632884003, 5642.266505354278, 5693.231413759172, 5695.316562012585, 5704.71476426177, 5735.426457354315, 6367.363263673596, 6487.156669632917, 6545.9018114728315, 6587.505937054644, 6616.96691516549, 1653.2973486268288, 1697.6944150052861, 1715.5453804741753, 1745.8428741413334, 1862.366795289608, 1404.37505310136, 1409.753293173711, 1434.426229508205, 1443.682389874226, 1446.8263808343065, 5822.155787410802, 5833.82498525045, 5855.268091488564, 5860.648361098348, 5872.236609240771, 6681.899771503431, 6698.430633396216, 6721.22705888829, 6735.797926062226, 6763.695633696496, 5848.61983971049, 5861.325947516005, 5868.911966320508, 5894.351621321651, 5898.0, 3595.5146055282726, 3596.7122630189524, 3632.4572799040775, 3653.6251436566445, 3659.2315613720884, 6619.867602648016, 6622.403983641495, 6632.469402447792, 6668.799936001928, 6691.631960242136, 6950.096487456598, 6989.4408447324095, 6994.090768200102, 7002.894956575656, 7057.6118313492225, 6486.708098135689, 6511.0, 6571.0471981562405, 6601.636909969901, 6607.141071660653, 6555.311692272243, 6643.30245324234, 6680.766173183915, 6726.771149848199, 6766.988690032888, 6621.867562648817, 6707.29573394806, 6719.395254427125, 6720.327967203436, 6734.427573656294, 6489.707963141765, 6500.609963402211, 6507.902381464187, 6529.249136349191, 6627.768028118992, 4962.652614316963, 4965.677230979974, 4982.950170498249, 4984.1526940420945, 5019.146745053276, 6757.594544327356, 6792.218894827158, 6825.996561512919, 6863.347981941708, 6903.413209877217, 6564.606123632598, 6604.636744979072, 6612.371824676648, 6612.471002319707, 6643.136392268974, 6505.543702563759, 6577.053767739319, 6587.934120658732, 6614.70233839488, 6687.598744075371, 6170.228721409824, 6279.843003924939, 6340.873182536231, 6407.615543067431, 6513.641749703812, 6594.538382313192, 6603.966980165068, 6608.281846719791, 6612.966935165294, 6617.239017512855, 6374.852526545266, 6381.553291269566, 6388.68056597159, 6430.517711171775, 6446.5165112615805], "value": 5068.824813400545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.5319457284925, 923.9676611318605, 931.436480929038, 935.0742764662981, 955.1260596554154, 17863.285468581256, 18543.258269669215, 18547.35084272051, 18548.99999999998, 20749.896250518763, 21661.45846353842, 22557.66163507549, 22595.887020564915, 22674.88662556685, 22696.773032269713, 1024.841149621808, 1056.6988408303635, 1061.8247989081792, 1063.186662203415, 1063.2875973098044, 1050.144132531988, 1056.5087234435987, 1056.9048785609293, 1057.0328149742977, 1059.7986382587321, 1005.4771518810214, 1085.8262677971527, 1095.8301463273165, 1103.5034234594425, 1104.34843442369, 1084.1976937066554, 1085.4572713643179, 1085.782843431313, 1086.044281032694, 1086.169080653297, 792.9841403171962, 793.6190628498354, 795.316028215734, 795.996020019902, 799.532273619933, 20107.59784804296, 20593.0, 20802.0, 20829.37511874631, 20937.5812483751, 21645.350639480683, 21929.780702192933, 22468.55062898733, 22499.0, 22504.0, 16923.0, 17091.48725538236, 17227.0, 17237.827621723747, 17330.74003889943, 3637.8362973665985, 3719.6466335698337, 3721.888343349704, 3727.869524566627, 3732.1602639406187, 114602.0, 114751.0, 117223.0, 117437.99999999914, 118159.4092029543, 16959.491215263562, 17277.049762263196, 17747.870255569156, 17828.732569011474, 17978.5505362367, 31535.21161970969, 32119.51820722691, 32259.35481290408, 32327.676723232937, 32444.188895277806, 7912.643931023118, 8229.423940324119, 8806.119388061143, 8927.553622318988, 9222.907770922338, 4279.293916503742, 4400.647948164204, 4412.139632771643, 4416.205083085076, 4419.535948725337, 5391.353037635509, 5410.026195284808, 5534.75093620788, 5543.916841247385, 5553.16702494629, 1100.5652767156928, 1109.5617231193633, 1112.5438570186184, 1117.2681893359863, 1118.725912151512, 679.8470344172522, 687.1582311668167, 698.4796326736512, 712.3339677401646, 720.4092644031844, 12402.875971240353, 12419.875801242053, 12575.993920486339, 13092.214467132002, 13246.271455069871, 702.1784512120729, 705.4427002667835, 710.3393843725282, 714.7855643306987, 729.7518843593203, 5668.461496157858, 5742.569307301969, 5764.538836893039, 5830.240632108221, 5847.181394604759, 96457.51771241239, 97325.51337243269, 98450.50774746224, 98797.0, 98995.50502247443, 90485.09514904898, 91459.54270228607, 94832.52583737037, 96846.51576742213, 97329.0, 75164.0, 80363.0, 80493.59753201196, 80654.59672701599, 84809.57595212109, 12532.874671253536, 12863.356832158168, 13173.802392963922, 13174.143680660727, 13339.333033348488, 35836.566537338214, 35909.28181436409, 35911.64088359083, 36401.817990909876, 37744.433833491974, 45816.77091614521, 46183.0, 46215.3067703978, 46950.0, 64800.59128454623, 16249.756253655969, 19768.505787355432, 19813.900930495256, 19968.50078748043, 20282.290119845733, 18432.723509147105, 20412.489687757923, 21363.89318053462, 21860.78139218651, 22306.10775568959, 19381.612367752285, 19651.803481965, 19727.506812329808, 20017.099230534954, 20276.290329838386, 19721.506962326057, 19812.405627831187, 20057.799422006177, 20168.193272268945, 20405.081771320623, 19210.519737006685, 19219.51951201231, 19504.512387190432, 19555.8044419554, 19937.0, 13314.733705326033, 13520.0, 13622.93188534051, 14000.159990400609, 14855.628609284422, 13847.376868040761, 13938.094023888414, 13985.860141398456, 14024.929875350557, 14457.85542144565], "value": 9289.646539525374, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 112.0, 101.0, 112.0, 108.0, 116.0, 107.0, 100.0, 106.0, 111.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 138.0, 176.0, 131.0, 161.0, 155.0, 117.0, 181.0, 120.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 162.0, 162.0, 162.0, 168.0, 178.0, 162.0, 161.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 74.0, 186.0, 76.0, 75.0, 78.0, 75.0, 159.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 127.0, 78.0, 84.0, 79.0, 133.0, 85.0, 83.0, 127.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 119.0, 117.0, 117.0, 115.0, 115.0, 117.0, 118.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 155.0, 150.0, 150.0, 151.0, 150.0, 150.0, 155.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 97.0, 98.0, 94.0, 94.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 63.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 57.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 61.0, 57.0, 58.0, 54.0, 65.0, 55.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 88.0, 84.0, 88.0, 93.0, 90.0, 77.0, 79.0, 77.0, 77.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 139.0, 135.0, 125.0, 132.0, 134.0, 127.0, 124.0, 164.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 172.0, 181.0, 174.0, 173.0, 173.0, 175.0, 174.0, 170.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 69.0, 76.0, 71.0, 65.0, 69.0, 68.0, 67.0], "value": 68.7, "unit": "score"}]}]} 06:00:12 INFO - Return code: 0 06:00:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:12 INFO - # TBPL SUCCESS # 06:00:12 INFO - Running post-action listener: _package_coverage_data 06:00:12 INFO - Running post-action listener: _resource_record_post_action 06:00:12 INFO - [mozharness: 2017-08-07 13:00:12.660014Z] Finished run-tests step (success) 06:00:12 INFO - Running post-run listener: _resource_record_post_run 06:00:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 442970112; Read time: 16; Write time: 520612 06:00:12 INFO - TinderboxPrint: CPU usage
13.2% 06:00:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:00:12 INFO - TinderboxPrint: I/O write bytes / time
442,970,112 / 520,612 06:00:12 INFO - TinderboxPrint: CPU idle
8,275.6 (86.8%) 06:00:12 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 06:00:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:00:12 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 120000512; Read time: 0; Write time: 178504 06:00:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:00:12 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 321847296; Read time: 0; Write time: 342064 06:00:13 INFO - Running post-run listener: _upload_blobber_files 06:00:13 INFO - Blob upload gear active. 06:00:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:13 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 06:00:13 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'] 06:00:13 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 06:00:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:14 INFO - (blobuploader) - INFO - Done attempting. 06:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:15 INFO - (blobuploader) - INFO - Done attempting. 06:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:16 INFO - (blobuploader) - INFO - Done attempting. 06:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:22 INFO - (blobuploader) - INFO - Done attempting. 06:00:22 INFO - (blobuploader) - INFO - Iteration through files over. 06:00:22 INFO - Return code: 0 06:00:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:00:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:00:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb878c73f703ceea3d53322ac7e8c8ccb29be43735d8798dbbd30bb89ba86cceefe8c1b65456520585859f653c1987f5b8ca887ff7c09c1d2d9ee322cdf476b6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07835019ad1094bc1fcd6eb6bbb32cbf46a63ca441ffe237967eb149cbab0a38f3dc27e9fc4a00b927bff6b194527b31ae6c47a5df90949f5348c91424999553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6870f75a1001e9b9cdeed11592487a55ead88d67e768333fe701fbac81ba26259bdf2e37c6595a57dcc7f060cec630f16a37561b474ef9d51c3d3bcecd24bf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229b8d625207349649b0185ab17b7ff9c74b6daa87aa10be65cdf0c3bf6cba9eb3ca1ecb2251c0e24298a842ec7d091b6843253e79c3f778b4ed583ff7f4006d"} 06:00:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:00:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:00:22 INFO - Contents: 06:00:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb878c73f703ceea3d53322ac7e8c8ccb29be43735d8798dbbd30bb89ba86cceefe8c1b65456520585859f653c1987f5b8ca887ff7c09c1d2d9ee322cdf476b6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07835019ad1094bc1fcd6eb6bbb32cbf46a63ca441ffe237967eb149cbab0a38f3dc27e9fc4a00b927bff6b194527b31ae6c47a5df90949f5348c91424999553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6870f75a1001e9b9cdeed11592487a55ead88d67e768333fe701fbac81ba26259bdf2e37c6595a57dcc7f060cec630f16a37561b474ef9d51c3d3bcecd24bf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229b8d625207349649b0185ab17b7ff9c74b6daa87aa10be65cdf0c3bf6cba9eb3ca1ecb2251c0e24298a842ec7d091b6843253e79c3f778b4ed583ff7f4006d"} 06:00:22 INFO - Running post-run listener: copy_logs_to_upload_dir 06:00:22 INFO - Copying logs to upload dir... 06:00:22 INFO - mkdir: /builds/slave/test/build/upload/logs 06:00:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.279119 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-07 06:00:23.646601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 06:00:23.653963) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb878c73f703ceea3d53322ac7e8c8ccb29be43735d8798dbbd30bb89ba86cceefe8c1b65456520585859f653c1987f5b8ca887ff7c09c1d2d9ee322cdf476b6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07835019ad1094bc1fcd6eb6bbb32cbf46a63ca441ffe237967eb149cbab0a38f3dc27e9fc4a00b927bff6b194527b31ae6c47a5df90949f5348c91424999553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6870f75a1001e9b9cdeed11592487a55ead88d67e768333fe701fbac81ba26259bdf2e37c6595a57dcc7f060cec630f16a37561b474ef9d51c3d3bcecd24bf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229b8d625207349649b0185ab17b7ff9c74b6daa87aa10be65cdf0c3bf6cba9eb3ca1ecb2251c0e24298a842ec7d091b6843253e79c3f778b4ed583ff7f4006d"} build_url:https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/CTkm8jlKQvKlvnvlEGpMow/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb878c73f703ceea3d53322ac7e8c8ccb29be43735d8798dbbd30bb89ba86cceefe8c1b65456520585859f653c1987f5b8ca887ff7c09c1d2d9ee322cdf476b6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07835019ad1094bc1fcd6eb6bbb32cbf46a63ca441ffe237967eb149cbab0a38f3dc27e9fc4a00b927bff6b194527b31ae6c47a5df90949f5348c91424999553", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6870f75a1001e9b9cdeed11592487a55ead88d67e768333fe701fbac81ba26259bdf2e37c6595a57dcc7f060cec630f16a37561b474ef9d51c3d3bcecd24bf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/229b8d625207349649b0185ab17b7ff9c74b6daa87aa10be65cdf0c3bf6cba9eb3ca1ecb2251c0e24298a842ec7d091b6843253e79c3f778b4ed583ff7f4006d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 06:00:23.681412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 06:00:23.681753) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502109561.741796-1490036929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 06:00:23.763409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 06:00:23.766722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 06:00:23.767009) ========= ========= Total master_lag: 0.66 =========