builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1502735286.77 results: success (0) revision: 8638a6d915f3698ee2a92dae386609d40f47383f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.769595) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.769951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.770216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.793044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.793327) ========= 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=1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 11:28:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.3M=0s 2017-08-14 11:28:06 (37.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.917727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.918031) ========= 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=1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020914 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.970378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:06.973743) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8638a6d915f3698ee2a92dae386609d40f47383f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8638a6d915f3698ee2a92dae386609d40f47383f --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=1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 11:28:07,002 truncating revision to first 12 chars 2017-08-14 11:28:07,002 Setting DEBUG logging. 2017-08-14 11:28:07,002 attempt 1/10 2017-08-14 11:28:07,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8638a6d915f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 11:28:07,437 unpacking tar archive at: mozilla-beta-8638a6d915f3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.788479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:07.776319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:07.779609) ========= script_repo_revision: 8638a6d915f3698ee2a92dae386609d40f47383f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:07.779956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:07.780211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 11:28:07.791695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-08-14 11:28:07.791957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:28:07 INFO - MultiFileLogger online at 20170814 11:28:07 in /builds/slave/test 11:28:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 11:28:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:28:07 INFO - {'append_to_log': False, 11:28:07 INFO - 'base_work_dir': '/builds/slave/test', 11:28:07 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:28:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:28:07 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:28:07 INFO - 'buildbot_json_path': 'buildprops.json', 11:28:07 INFO - 'code_coverage': False, 11:28:07 INFO - 'config_files': ('talos/linux_config.py',), 11:28:07 INFO - 'default_actions': ('clobber', 11:28:07 INFO - 'read-buildbot-config', 11:28:07 INFO - 'download-and-extract', 11:28:07 INFO - 'populate-webroot', 11:28:07 INFO - 'create-virtualenv', 11:28:07 INFO - 'install', 11:28:07 INFO - 'setup-mitmproxy', 11:28:07 INFO - 'run-tests'), 11:28:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:28:07 INFO - 'disable_ccov_upload': False, 11:28:07 INFO - 'download_minidump_stackwalk': True, 11:28:07 INFO - 'download_symbols': 'ondemand', 11:28:07 INFO - 'enable_stylo': False, 11:28:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:28:07 INFO - 'tooltool.py': '/tools/tooltool.py', 11:28:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:28:07 INFO - '/tools/misc-python/virtualenv.py')}, 11:28:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:28:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:28:07 INFO - 'gecko_profile': False, 11:28:07 INFO - 'gecko_profile_interval': 0, 11:28:07 INFO - 'installer_path': 'installer.exe', 11:28:07 INFO - 'log_level': 'info', 11:28:07 INFO - 'log_name': 'talos', 11:28:07 INFO - 'log_to_console': True, 11:28:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:28:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:28:07 INFO - 'opt_config_files': (), 11:28:07 INFO - 'pip_index': False, 11:28:07 INFO - 'suite': 'dromaeojs-e10s', 11:28:07 INFO - 'system_bits': '32', 11:28:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:28:07 INFO - 'title': 'talos-linux64-ix-027', 11:28:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:28:07 INFO - 'use_talos_json': True, 11:28:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:28:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:28:07 INFO - 'work_dir': 'build'} 11:28:07 INFO - [mozharness: 2017-08-14 18:28:07.927808Z] Running clobber step. 11:28:07 INFO - Running pre-action listener: _resource_record_pre_action 11:28:07 INFO - Running main action method: clobber 11:28:07 INFO - rmtree: /builds/slave/test/build 11:28:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:28:08 INFO - Running post-action listener: _resource_record_post_action 11:28:08 INFO - [mozharness: 2017-08-14 18:28:08.953108Z] Finished clobber step (success) 11:28:08 INFO - [mozharness: 2017-08-14 18:28:08.953212Z] Running read-buildbot-config step. 11:28:08 INFO - Running pre-action listener: _resource_record_pre_action 11:28:08 INFO - Running main action method: read_buildbot_config 11:28:08 INFO - Using buildbot properties: 11:28:08 INFO - { 11:28:08 INFO - "project": "", 11:28:08 INFO - "product": "firefox", 11:28:08 INFO - "who": "ryanvm@gmail.com", 11:28:08 INFO - "installer_path": "public/build/target.tar.bz2", 11:28:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:28:08 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:28:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:28:08 INFO - "stage_platform": "linux64", 11:28:08 INFO - "basedir": "/builds/slave/test", 11:28:08 INFO - "buildnumber": 50, 11:28:08 INFO - "platform": "ubuntu64_hw", 11:28:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:28:08 INFO - "slavebuilddir": "test", 11:28:08 INFO - "taskId": "H8SsYBxJTxmlJDcwOLfnvA", 11:28:08 INFO - "branch": "mozilla-beta", 11:28:08 INFO - "script_repo_revision": "production", 11:28:08 INFO - "revision": "8638a6d915f3698ee2a92dae386609d40f47383f", 11:28:08 INFO - "slavename": "talos-linux64-ix-027", 11:28:08 INFO - "repo_path": "releases/mozilla-beta" 11:28:08 INFO - } 11:28:08 INFO - Finding installer, test and symbols from parent task. 11:28:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H8SsYBxJTxmlJDcwOLfnvA'}, attempt #1 11:28:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H8SsYBxJTxmlJDcwOLfnvA'}, attempt #1 11:28:09 INFO - Task dependencies: Kuf16ZkASTackq3doCbfzg 11:28:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg'}, attempt #1 11:28:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2 11:28:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.test_packages.json 11:28:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.crashreporter-symbols.zip 11:28:10 INFO - Running post-action listener: _resource_record_post_action 11:28:10 INFO - [mozharness: 2017-08-14 18:28:10.337334Z] Finished read-buildbot-config step (success) 11:28:10 INFO - [mozharness: 2017-08-14 18:28:10.337557Z] Running download-and-extract step. 11:28:10 INFO - Running pre-action listener: _resource_record_pre_action 11:28:10 INFO - Running main action method: download_and_extract 11:28:10 INFO - mkdir: /builds/slave/test/build/tests 11:28: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')]} 11:28:10 INFO - trying https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.test_packages.json 11:28:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:28:10 INFO - Downloaded 989 bytes. 11:28:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:28:10 INFO - Using the following test package requirements: 11:28:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:28:10 INFO - u'common': [u'target.common.tests.zip'], 11:28:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:28:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:28:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:28:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:28:10 INFO - u'mozbase': [u'target.common.tests.zip'], 11:28:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:28:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:28:10 INFO - u'web-platform': [u'target.common.tests.zip', 11:28:10 INFO - u'target.web-platform.tests.tar.gz'], 11:28:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:28:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:28:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.common.tests.zip 11:28:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:28:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.common.tests.zip into memory 11:28:12 INFO - Content-Length response header: 72817176 11:28:12 INFO - Bytes received: 72817176 11:28:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:28:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.common.tests.zip 11:28:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:28:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.common.tests.zip into memory 11:28:25 INFO - Content-Length response header: 72817176 11:28:25 INFO - Bytes received: 72817176 11:28:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.talos.tests.zip 11:28:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:28:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.talos.tests.zip into memory 11:28:38 INFO - Content-Length response header: 14496472 11:28:38 INFO - Bytes received: 14496472 11:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:38 INFO - trying https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2 11:28:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:28:40 INFO - Downloaded 53836918 bytes. 11:28:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2 11:28:40 INFO - mkdir: /builds/slave/test/properties 11:28:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:28:40 INFO - Writing to file /builds/slave/test/properties/build_url 11:28:40 INFO - Contents: 11:28:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2 11:28:40 INFO - Running post-action listener: _resource_record_post_action 11:28:40 INFO - Running post-action listener: set_extra_try_arguments 11:28:40 INFO - [mozharness: 2017-08-14 18:28:40.027430Z] Finished download-and-extract step (success) 11:28:40 INFO - [mozharness: 2017-08-14 18:28:40.027528Z] Running populate-webroot step. 11:28:40 INFO - Running pre-action listener: _resource_record_pre_action 11:28:40 INFO - Running main action method: populate_webroot 11:28:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:28:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:28:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:28:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:28:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:28:40 INFO - 'tests': ['damp', 'tps']}, 11:28:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:28:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:28:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:28:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:28:40 INFO - 'other-e10s': {'tests': ['a11yr', 11:28:40 INFO - 'ts_paint', 11:28:40 INFO - 'tpaint', 11:28:40 INFO - 'sessionrestore', 11:28:40 INFO - 'sessionrestore_many_windows', 11:28:40 INFO - 'sessionrestore_no_auto_restore', 11:28:40 INFO - 'tabpaint']}, 11:28:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:28:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:28:40 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:40 INFO - 'talos_options': ['--mitmproxy', 11:28:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:40 INFO - '--firstNonBlankPaint'], 11:28:40 INFO - 'tests': ['quantum_pageload_google', 11:28:40 INFO - 'quantum_pageload_youtube', 11:28:40 INFO - 'quantum_pageload_amazon', 11:28:40 INFO - 'quantum_pageload_facebook']}, 11:28:40 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:40 INFO - 'talos_options': ['--stylo', 11:28:40 INFO - '--mitmproxy', 11:28:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:40 INFO - '--firstNonBlankPaint'], 11:28:40 INFO - 'tests': ['quantum_pageload_google', 11:28:40 INFO - 'quantum_pageload_youtube', 11:28:40 INFO - 'quantum_pageload_amazon', 11:28:40 INFO - 'quantum_pageload_facebook']}, 11:28:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:28:40 INFO - 'tsvgr_opacity', 11:28:40 INFO - 'tart', 11:28:40 INFO - 'tscrollx', 11:28:40 INFO - 'cart', 11:28:40 INFO - 'tsvg_static']}, 11:28:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:28:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:28:40 INFO - 'talos_options': ['--stylo', 11:28:40 INFO - '--stylo-threads=1', 11:28:40 INFO - '--mitmproxy', 11:28:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:28:40 INFO - '--firstNonBlankPaint'], 11:28:40 INFO - 'tests': ['tp6_google', 11:28:40 INFO - 'tp6_youtube', 11:28:40 INFO - 'tp6_amazon', 11:28:40 INFO - 'tp6_facebook']}, 11:28:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:28:40 INFO - 'talos_options': ['--xperf_path', 11:28:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:28:40 INFO - 'tests': ['tp5n']}}} 11:28:40 INFO - Running post-action listener: _resource_record_post_action 11:28:40 INFO - [mozharness: 2017-08-14 18:28:40.036260Z] Finished populate-webroot step (success) 11:28:40 INFO - [mozharness: 2017-08-14 18:28:40.036352Z] Running create-virtualenv step. 11:28:40 INFO - Running pre-action listener: _resource_record_pre_action 11:28:40 INFO - Running main action method: create_virtualenv 11:28:40 INFO - Creating virtualenv /builds/slave/test/build/venv 11:28:40 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 11:28:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:28:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:28:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:28:40 INFO - Using real prefix '/usr' 11:28:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:28:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:28:42 INFO - Installing pip.................done. 11:28:42 INFO - Return code: 0 11:28:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:28:42 INFO - Reading from file tmpfile_stdout 11:28:42 INFO - Output received: 11:28:42 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) 11:28:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:28:42 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')]} 11:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:42 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')]} 11:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:42 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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:42 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 11:28:42 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 11:28:42 INFO - Using env: {'DISPLAY': ':0', 11:28:42 INFO - 'HOME': '/home/cltbld', 11:28:42 INFO - 'LANG': 'en_US.UTF-8', 11:28:42 INFO - 'LANGUAGE': 'en_US:en', 11:28:42 INFO - 'LOGNAME': 'cltbld', 11:28:42 INFO - 'MAIL': '/var/mail/cltbld', 11:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:42 INFO - 'MOZ_NO_REMOTE': '1', 11:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:42 INFO - 'NO_EM_RESTART': '1', 11:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:42 INFO - 'PWD': '/builds/slave/test', 11:28:42 INFO - 'SHELL': '/bin/bash', 11:28:42 INFO - 'SHLVL': '1', 11:28:42 INFO - 'TERM': 'linux', 11:28:42 INFO - 'TMOUT': '86400', 11:28:42 INFO - 'USER': 'cltbld', 11:28:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:42 INFO - '_': '/tools/buildbot/bin/python'} 11:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:43 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 11:28:43 INFO - Cleaning up... 11:28:43 INFO - Return code: 0 11:28:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:28:43 INFO - Using env: {'DISPLAY': ':0', 11:28:43 INFO - 'HOME': '/home/cltbld', 11:28:43 INFO - 'LANG': 'en_US.UTF-8', 11:28:43 INFO - 'LANGUAGE': 'en_US:en', 11:28:43 INFO - 'LOGNAME': 'cltbld', 11:28:43 INFO - 'MAIL': '/var/mail/cltbld', 11:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:43 INFO - 'MOZ_NO_REMOTE': '1', 11:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:43 INFO - 'NO_EM_RESTART': '1', 11:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:43 INFO - 'PWD': '/builds/slave/test', 11:28:43 INFO - 'SHELL': '/bin/bash', 11:28:43 INFO - 'SHLVL': '1', 11:28:43 INFO - 'TERM': 'linux', 11:28:43 INFO - 'TMOUT': '86400', 11:28:43 INFO - 'USER': 'cltbld', 11:28:43 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:43 INFO - '_': '/tools/buildbot/bin/python'} 11:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:43 INFO - Downloading/unpacking psutil>=3.1.1 11:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:28:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:44 INFO - Installing collected packages: psutil 11:28:44 INFO - Running setup.py install for psutil 11:28:44 INFO - building 'psutil._psutil_linux' extension 11:28:44 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 11:28:44 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 11:28:44 INFO - building 'psutil._psutil_posix' extension 11:28:44 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 11:28:44 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 11:28:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:28:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:28:44 INFO - Successfully installed psutil 11:28:44 INFO - Cleaning up... 11:28:45 INFO - Return code: 0 11:28:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:28:45 INFO - Using env: {'DISPLAY': ':0', 11:28:45 INFO - 'HOME': '/home/cltbld', 11:28:45 INFO - 'LANG': 'en_US.UTF-8', 11:28:45 INFO - 'LANGUAGE': 'en_US:en', 11:28:45 INFO - 'LOGNAME': 'cltbld', 11:28:45 INFO - 'MAIL': '/var/mail/cltbld', 11:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:45 INFO - 'MOZ_NO_REMOTE': '1', 11:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:45 INFO - 'NO_EM_RESTART': '1', 11:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:45 INFO - 'PWD': '/builds/slave/test', 11:28:45 INFO - 'SHELL': '/bin/bash', 11:28:45 INFO - 'SHLVL': '1', 11:28:45 INFO - 'TERM': 'linux', 11:28:45 INFO - 'TMOUT': '86400', 11:28:45 INFO - 'USER': 'cltbld', 11:28:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:45 INFO - '_': '/tools/buildbot/bin/python'} 11:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:28:46 INFO - Installing collected packages: mozsystemmonitor 11:28:46 INFO - Running setup.py install for mozsystemmonitor 11:28:46 INFO - Successfully installed mozsystemmonitor 11:28:46 INFO - Cleaning up... 11:28:46 INFO - Return code: 0 11:28:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:28:46 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')]} 11:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:46 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')]} 11:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:46 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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:46 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 11:28:46 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 11:28:46 INFO - Using env: {'DISPLAY': ':0', 11:28:46 INFO - 'HOME': '/home/cltbld', 11:28:46 INFO - 'LANG': 'en_US.UTF-8', 11:28:46 INFO - 'LANGUAGE': 'en_US:en', 11:28:46 INFO - 'LOGNAME': 'cltbld', 11:28:46 INFO - 'MAIL': '/var/mail/cltbld', 11:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:46 INFO - 'MOZ_NO_REMOTE': '1', 11:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:46 INFO - 'NO_EM_RESTART': '1', 11:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:46 INFO - 'PWD': '/builds/slave/test', 11:28:46 INFO - 'SHELL': '/bin/bash', 11:28:46 INFO - 'SHLVL': '1', 11:28:46 INFO - 'TERM': 'linux', 11:28:46 INFO - 'TMOUT': '86400', 11:28:46 INFO - 'USER': 'cltbld', 11:28:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:46 INFO - '_': '/tools/buildbot/bin/python'} 11:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:46 INFO - Downloading/unpacking jsonschema==2.5.1 11:28:46 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 11:28:46 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 11:28:46 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 11:28:46 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 11:28:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:28:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:47 INFO - Downloading functools32-3.2.3-2.tar.gz 11:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:28:48 INFO - warning: no files found matching '*.txt' 11:28:48 INFO - no previously-included directories found matching 'build' 11:28:48 INFO - no previously-included directories found matching 'dist' 11:28:48 INFO - no previously-included directories found matching '.git*' 11:28:48 INFO - Installing collected packages: jsonschema, functools32 11:28:48 INFO - Running setup.py install for functools32 11:28:48 INFO - warning: no files found matching '*.txt' 11:28:48 INFO - no previously-included directories found matching 'build' 11:28:48 INFO - no previously-included directories found matching 'dist' 11:28:48 INFO - no previously-included directories found matching '.git*' 11:28:48 INFO - Successfully installed jsonschema functools32 11:28:48 INFO - Cleaning up... 11:28:48 INFO - Return code: 0 11:28:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:28:48 INFO - Using env: {'DISPLAY': ':0', 11:28:48 INFO - 'HOME': '/home/cltbld', 11:28:48 INFO - 'LANG': 'en_US.UTF-8', 11:28:48 INFO - 'LANGUAGE': 'en_US:en', 11:28:48 INFO - 'LOGNAME': 'cltbld', 11:28:48 INFO - 'MAIL': '/var/mail/cltbld', 11:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:48 INFO - 'MOZ_NO_REMOTE': '1', 11:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:48 INFO - 'NO_EM_RESTART': '1', 11:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:48 INFO - 'PWD': '/builds/slave/test', 11:28:48 INFO - 'SHELL': '/bin/bash', 11:28:48 INFO - 'SHLVL': '1', 11:28:48 INFO - 'TERM': 'linux', 11:28:48 INFO - 'TMOUT': '86400', 11:28:48 INFO - 'USER': 'cltbld', 11:28:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:48 INFO - '_': '/tools/buildbot/bin/python'} 11:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:28:48 INFO - Cleaning up... 11:28:48 INFO - Return code: 0 11:28:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:28:48 INFO - Using env: {'DISPLAY': ':0', 11:28:48 INFO - 'HOME': '/home/cltbld', 11:28:48 INFO - 'LANG': 'en_US.UTF-8', 11:28:48 INFO - 'LANGUAGE': 'en_US:en', 11:28:48 INFO - 'LOGNAME': 'cltbld', 11:28:48 INFO - 'MAIL': '/var/mail/cltbld', 11:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:48 INFO - 'MOZ_NO_REMOTE': '1', 11:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:48 INFO - 'NO_EM_RESTART': '1', 11:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:48 INFO - 'PWD': '/builds/slave/test', 11:28:48 INFO - 'SHELL': '/bin/bash', 11:28:48 INFO - 'SHLVL': '1', 11:28:48 INFO - 'TERM': 'linux', 11:28:48 INFO - 'TMOUT': '86400', 11:28:48 INFO - 'USER': 'cltbld', 11:28:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:48 INFO - '_': '/tools/buildbot/bin/python'} 11:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:49 INFO - Downloading blobuploader-1.2.4.tar.gz 11:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:28:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:28:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:50 INFO - Downloading docopt-0.6.1.tar.gz 11:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:28:50 INFO - Installing collected packages: blobuploader, requests, docopt 11:28:50 INFO - Running setup.py install for blobuploader 11:28:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:28:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:28:50 INFO - Running setup.py install for requests 11:28:50 INFO - Running setup.py install for docopt 11:28:50 INFO - Successfully installed blobuploader requests docopt 11:28:50 INFO - Cleaning up... 11:28:50 INFO - Return code: 0 11:28:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:50 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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:50 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 11:28:50 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 11:28:50 INFO - Using env: {'DISPLAY': ':0', 11:28:50 INFO - 'HOME': '/home/cltbld', 11:28:50 INFO - 'LANG': 'en_US.UTF-8', 11:28:50 INFO - 'LANGUAGE': 'en_US:en', 11:28:50 INFO - 'LOGNAME': 'cltbld', 11:28:50 INFO - 'MAIL': '/var/mail/cltbld', 11:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:50 INFO - 'MOZ_NO_REMOTE': '1', 11:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:50 INFO - 'NO_EM_RESTART': '1', 11:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:50 INFO - 'PWD': '/builds/slave/test', 11:28:50 INFO - 'SHELL': '/bin/bash', 11:28:50 INFO - 'SHLVL': '1', 11:28:50 INFO - 'TERM': 'linux', 11:28:50 INFO - 'TMOUT': '86400', 11:28:50 INFO - 'USER': 'cltbld', 11:28:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:50 INFO - '_': '/tools/buildbot/bin/python'} 11:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:51 INFO - Running setup.py (path:/tmp/pip-tBxHcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:51 INFO - Running setup.py (path:/tmp/pip-CDrwYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:51 INFO - Running setup.py (path:/tmp/pip-pOtYR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:51 INFO - Running setup.py (path:/tmp/pip-tfHQP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:51 INFO - Running setup.py (path:/tmp/pip-uDiAns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:51 INFO - Running setup.py (path:/tmp/pip-oITQbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:51 INFO - Running setup.py (path:/tmp/pip-CfOaJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:51 INFO - Running setup.py (path:/tmp/pip-_6vjd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:51 INFO - Running setup.py (path:/tmp/pip-wJClKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:51 INFO - Running setup.py (path:/tmp/pip-yCz9E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:51 INFO - Running setup.py (path:/tmp/pip-6XlNl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:51 INFO - Running setup.py (path:/tmp/pip-5O9xHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:51 INFO - Running setup.py (path:/tmp/pip-4zJe06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:52 INFO - Running setup.py (path:/tmp/pip-iLgsQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:52 INFO - Running setup.py (path:/tmp/pip-TZ5Y9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:52 INFO - Running setup.py (path:/tmp/pip-3HqqbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:52 INFO - Running setup.py (path:/tmp/pip-HVOJHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:28:52 INFO - Running setup.py install for manifestparser 11:28:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:28:52 INFO - Running setup.py install for mozcrash 11:28:52 INFO - Running setup.py install for mozdebug 11:28:52 INFO - Running setup.py install for mozdevice 11:28:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:28:52 INFO - Running setup.py install for mozfile 11:28:52 INFO - Running setup.py install for mozhttpd 11:28:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:28:52 INFO - Running setup.py install for mozinfo 11:28:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Running setup.py install for mozInstall 11:28:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Running setup.py install for mozleak 11:28:53 INFO - Running setup.py install for mozlog 11:28:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Running setup.py install for moznetwork 11:28:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Running setup.py install for mozprocess 11:28:53 INFO - Running setup.py install for mozprofile 11:28:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Running setup.py install for mozrunner 11:28:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:28:53 INFO - Running setup.py install for mozscreenshot 11:28:53 INFO - Running setup.py install for moztest 11:28:54 INFO - Running setup.py install for mozversion 11:28:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:28:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:28:54 INFO - Cleaning up... 11:28:54 INFO - Return code: 0 11:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:54 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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:54 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 11:28:54 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 11:28:54 INFO - Using env: {'DISPLAY': ':0', 11:28:54 INFO - 'HOME': '/home/cltbld', 11:28:54 INFO - 'LANG': 'en_US.UTF-8', 11:28:54 INFO - 'LANGUAGE': 'en_US:en', 11:28:54 INFO - 'LOGNAME': 'cltbld', 11:28:54 INFO - 'MAIL': '/var/mail/cltbld', 11:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:54 INFO - 'MOZ_NO_REMOTE': '1', 11:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:54 INFO - 'NO_EM_RESTART': '1', 11:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:54 INFO - 'PWD': '/builds/slave/test', 11:28:54 INFO - 'SHELL': '/bin/bash', 11:28:54 INFO - 'SHLVL': '1', 11:28:54 INFO - 'TERM': 'linux', 11:28:54 INFO - 'TMOUT': '86400', 11:28:54 INFO - 'USER': 'cltbld', 11:28:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:54 INFO - '_': '/tools/buildbot/bin/python'} 11:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:28:54 INFO - Running setup.py (path:/tmp/pip-p1ZHLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:28:54 INFO - Running setup.py (path:/tmp/pip-egkMbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:28:54 INFO - Running setup.py (path:/tmp/pip-CFLDdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:28:54 INFO - Running setup.py (path:/tmp/pip-Yw_eGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:28:54 INFO - Running setup.py (path:/tmp/pip-XDvwNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:28:54 INFO - Running setup.py (path:/tmp/pip-RjzcdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:28:54 INFO - Running setup.py (path:/tmp/pip-FUrA3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:28:54 INFO - Running setup.py (path:/tmp/pip-pqx_iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:28:54 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)) 11:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:28:54 INFO - Running setup.py (path:/tmp/pip-j6vCP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:28:55 INFO - Running setup.py (path:/tmp/pip-MkHOjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:28:55 INFO - Running setup.py (path:/tmp/pip-4tTW7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:28:55 INFO - Running setup.py (path:/tmp/pip-Ilnqr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:28:55 INFO - Running setup.py (path:/tmp/pip-9CU2tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:28:55 INFO - Running setup.py (path:/tmp/pip-6ebofH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:55 INFO - Running setup.py (path:/tmp/pip-Y9GDR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:28:55 INFO - Running setup.py (path:/tmp/pip-cPlupa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:28:55 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)) 11:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:28:55 INFO - Running setup.py (path:/tmp/pip-XYSWat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 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)) 11:28:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:56 INFO - Downloading blessings-1.6.tar.gz 11:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:28:56 INFO - Installing collected packages: blessings 11:28:56 INFO - Running setup.py install for blessings 11:28:56 INFO - Successfully installed blessings 11:28:56 INFO - Cleaning up... 11:28:56 INFO - Return code: 0 11:28:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:28:57 INFO - Reading from file tmpfile_stdout 11:28:57 INFO - Current package versions: 11:28:57 INFO - argparse == 1.2.1 11:28:57 INFO - blessings == 1.6 11:28:57 INFO - blobuploader == 1.2.4 11:28:57 INFO - docopt == 0.6.1 11:28:57 INFO - functools32 == 3.2.3-2 11:28:57 INFO - jsonschema == 2.5.1 11:28:57 INFO - manifestparser == 1.1 11:28:57 INFO - mozInstall == 1.13 11:28:57 INFO - mozcrash == 1.0 11:28:57 INFO - mozdebug == 0.1 11:28:57 INFO - mozdevice == 0.51 11:28:57 INFO - mozfile == 1.2 11:28:57 INFO - mozhttpd == 0.7 11:28:57 INFO - mozinfo == 0.10 11:28:57 INFO - mozleak == 0.1 11:28:57 INFO - mozlog == 3.5 11:28:57 INFO - moznetwork == 0.27 11:28:57 INFO - mozprocess == 0.25 11:28:57 INFO - mozprofile == 0.28 11:28:57 INFO - mozrunner == 6.13 11:28:57 INFO - mozscreenshot == 0.1 11:28:57 INFO - mozsystemmonitor == 0.3 11:28:57 INFO - moztest == 0.8 11:28:57 INFO - mozversion == 1.4 11:28:57 INFO - psutil == 3.1.1 11:28:57 INFO - requests == 1.2.3 11:28:57 INFO - wsgiref == 0.1.2 11:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28:57 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 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28:57 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 11:28:57 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 11:28:57 INFO - Using env: {'DISPLAY': ':0', 11:28:57 INFO - 'HOME': '/home/cltbld', 11:28:57 INFO - 'LANG': 'en_US.UTF-8', 11:28:57 INFO - 'LANGUAGE': 'en_US:en', 11:28:57 INFO - 'LOGNAME': 'cltbld', 11:28:57 INFO - 'MAIL': '/var/mail/cltbld', 11:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:57 INFO - 'MOZ_NO_REMOTE': '1', 11:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:57 INFO - 'NO_EM_RESTART': '1', 11:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:57 INFO - 'PWD': '/builds/slave/test', 11:28:57 INFO - 'SHELL': '/bin/bash', 11:28:57 INFO - 'SHLVL': '1', 11:28:57 INFO - 'TERM': 'linux', 11:28:57 INFO - 'TMOUT': '86400', 11:28:57 INFO - 'USER': 'cltbld', 11:28:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:57 INFO - '_': '/tools/buildbot/bin/python'} 11:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 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)) 11:28:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:28:58 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)) 11:28:58 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)) 11:28:58 INFO - Installing collected packages: simplejson 11:28:58 INFO - Running setup.py install for simplejson 11:28:58 INFO - building 'simplejson._speedups' extension 11:28:58 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 11:28:59 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 11:28:59 INFO - Successfully installed simplejson 11:28:59 INFO - Cleaning up... 11:28:59 INFO - Return code: 0 11:28:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:28: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')]} 11:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:28: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')]} 11:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:28: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2739a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28dceb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, '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': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', '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 11:28: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', 'jsonschema'] in /builds/slave/test/build 11:28: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 jsonschema 11:28:59 INFO - Using env: {'DISPLAY': ':0', 11:28:59 INFO - 'HOME': '/home/cltbld', 11:28:59 INFO - 'LANG': 'en_US.UTF-8', 11:28:59 INFO - 'LANGUAGE': 'en_US:en', 11:28:59 INFO - 'LOGNAME': 'cltbld', 11:28:59 INFO - 'MAIL': '/var/mail/cltbld', 11:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:59 INFO - 'MOZ_NO_REMOTE': '1', 11:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:28:59 INFO - 'NO_EM_RESTART': '1', 11:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:59 INFO - 'PWD': '/builds/slave/test', 11:28:59 INFO - 'SHELL': '/bin/bash', 11:28:59 INFO - 'SHLVL': '1', 11:28:59 INFO - 'TERM': 'linux', 11:28:59 INFO - 'TMOUT': '86400', 11:28:59 INFO - 'USER': 'cltbld', 11:28:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:59 INFO - '_': '/tools/buildbot/bin/python'} 11:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:28:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:28:59 INFO - Cleaning up... 11:28:59 INFO - Return code: 0 11:28:59 INFO - Running post-action listener: _resource_record_post_action 11:28:59 INFO - Running post-action listener: _start_resource_monitoring 11:28:59 INFO - Starting resource monitoring. 11:28:59 INFO - [mozharness: 2017-08-14 18:28:59.895694Z] Finished create-virtualenv step (success) 11:28:59 INFO - [mozharness: 2017-08-14 18:28:59.896211Z] Running install step. 11:28:59 INFO - Running pre-action listener: _resource_record_pre_action 11:28:59 INFO - Running main action method: install 11:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:00 INFO - Reading from file tmpfile_stdout 11:29:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:29:00 INFO - Reading from file tmpfile_stdout 11:29:00 INFO - Output received: 11:29:00 INFO - Usage: mozinstall [options] installer 11:29:00 INFO - Options: 11:29:00 INFO - -h, --help show this help message and exit 11:29:00 INFO - -d DEST, --destination=DEST 11:29:00 INFO - Directory to install application into. [default: 11:29:00 INFO - "/builds/slave/test"] 11:29:00 INFO - --app=APP Application being installed. [default: firefox] 11:29:00 INFO - mkdir: /builds/slave/test/build/application 11:29:00 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'] 11:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:29:14 INFO - Reading from file tmpfile_stdout 11:29:14 INFO - Output received: 11:29:14 INFO - /builds/slave/test/build/application/firefox/firefox 11:29:14 INFO - Running post-action listener: _resource_record_post_action 11:29:14 INFO - [mozharness: 2017-08-14 18:29:14.926637Z] Finished install step (success) 11:29:14 INFO - [mozharness: 2017-08-14 18:29:14.926897Z] Running setup-mitmproxy step. 11:29:14 INFO - Running pre-action listener: _resource_record_pre_action 11:29:14 INFO - Running main action method: setup_mitmproxy 11:29:14 INFO - Skipping: mitmproxy is not required 11:29:14 INFO - Running post-action listener: _resource_record_post_action 11:29:14 INFO - [mozharness: 2017-08-14 18:29:14.928038Z] Finished setup-mitmproxy step (success) 11:29:14 INFO - [mozharness: 2017-08-14 18:29:14.928259Z] Running run-tests step. 11:29:14 INFO - Running pre-action listener: _resource_record_pre_action 11:29:14 INFO - Running pre-action listener: _set_gcov_prefix 11:29:14 INFO - Running main action method: run_tests 11:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:29:14 INFO - Python 2.7.3 11:29:14 INFO - Return code: 0 11:29:14 INFO - grabbing minidump binary from tooltool 11:29:14 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')]} 11:29:14 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 0x28da050>, '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 0x28daf50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28db3e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:29:14 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 11:29:14 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 11:29:14 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 11:29:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:29:15 INFO - Return code: 0 11:29:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:29:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:29:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:29:15 INFO - ENV: RUST_BACKTRACE is now 1 11:29:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:29:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 11:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 11:29:15 INFO - Using env: {'DISPLAY': ':0', 11:29:15 INFO - 'HOME': '/home/cltbld', 11:29:15 INFO - 'LANG': 'en_US.UTF-8', 11:29:15 INFO - 'LANGUAGE': 'en_US:en', 11:29:15 INFO - 'LOGNAME': 'cltbld', 11:29:15 INFO - 'MAIL': '/var/mail/cltbld', 11:29:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:29:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:15 INFO - 'MOZ_NO_REMOTE': '1', 11:29:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:15 INFO - 'NO_EM_RESTART': '1', 11:29:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:15 INFO - 'PWD': '/builds/slave/test', 11:29:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:29:15 INFO - 'RUST_BACKTRACE': '1', 11:29:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:29:15 INFO - 'SHELL': '/bin/bash', 11:29:15 INFO - 'SHLVL': '1', 11:29:15 INFO - 'TERM': 'linux', 11:29:15 INFO - 'TMOUT': '86400', 11:29:15 INFO - 'USER': 'cltbld', 11:29:15 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219', 11:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:15 INFO - '_': '/tools/buildbot/bin/python'} 11:29:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 11:29:15 INFO - mozversion application_buildid: 20170814172121 11:29:15 INFO - mozversion application_changeset: 8638a6d915f3698ee2a92dae386609d40f47383f 11:29:15 INFO - mozversion application_display_name: Firefox 11:29:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:29:15 INFO - mozversion application_name: Firefox 11:29:15 INFO - mozversion application_remotingname: firefox 11:29:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:29:15 INFO - mozversion application_vendor: Mozilla 11:29:15 INFO - mozversion application_version: 56.0 11:29:15 INFO - mozversion platform_buildid: 20170814172121 11:29:15 INFO - mozversion platform_changeset: 8638a6d915f3698ee2a92dae386609d40f47383f 11:29:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:29:15 INFO - mozversion platform_version: 56.0 11:29:15 INFO - using testdate: 1502735355 11:29:15 INFO - actual date: 1502735355 11:29:15 INFO - starting webserver on 'localhost:55802' 11:29:15 INFO - SUITE-START | Running 2 tests 11:29:15 INFO - TEST-START | dromaeo_css 11:29:15 INFO - Initialising browser for dromaeo_css test... 11:29:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55802/getInfo.html -profile /tmp/tmpRoc2I1/profile 11:29:15 INFO - TEST-INFO | started process 29500 (/builds/slave/test/build/application/firefox/firefox http://localhost:55802/getInfo.html) 11:29:20 INFO - TEST-INFO | 29500: exit 0 11:29:20 INFO - Browser initialized. 11:29:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:29:20 INFO - TEST-INFO | started process 29670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRoc2I1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:20 INFO - PID 29670 | 1502735360808 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 11:29:31 INFO - PID 29670 | RSS: Main: 139472896 11:29:31 INFO - PID 29670 | 11:32:29 INFO - PID 29670 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55802/tests/dromaeo/cssquery-ext.html) 11:32:30 INFO - PID 29670 | RSS: Main: 149729280 11:32:30 INFO - PID 29670 | 11:35:32 INFO - PID 29670 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-ext.html (next: http://localhost:55802/tests/dromaeo/cssquery-jquery.html) 11:35:32 INFO - PID 29670 | RSS: Main: 148381696 11:35:32 INFO - PID 29670 | 11:38:34 INFO - PID 29670 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55802/tests/dromaeo/cssquery-mootools.html) 11:38:35 INFO - PID 29670 | RSS: Main: 150220800 11:38:35 INFO - PID 29670 | 11:41:36 INFO - PID 29670 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55802/tests/dromaeo/cssquery-prototype.html) 11:41:37 INFO - PID 29670 | RSS: Main: 149495808 11:41:37 INFO - PID 29670 | 11:44:40 INFO - PID 29670 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55802/tests/dromaeo/cssquery-yui.html) 11:44:40 INFO - PID 29670 | RSS: Main: 152780800 11:44:40 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | Cycle 1(1): loaded http://localhost:55802/tests/dromaeo/cssquery-yui.html (next: http://localhost:55802/tests/dromaeo/cssquery-dojo.html) 11:47:42 INFO - PID 29670 | RSS: Main: 155774976 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | __start_tp_report 11:47:42 INFO - PID 29670 | _x_x_mozilla_page_load 11:47:42 INFO - PID 29670 | _x_x_mozilla_page_load_details 11:47:42 INFO - PID 29670 | |i|pagename|runs| 11:47:42 INFO - PID 29670 | |0;dojo.html;3513.156842357835;3529.5058691783156;3545.379558577248;3545.574531056274;3545.8936231913044;6178.474829639486;6216.254049514059;6228.346023667517;6277.686115694214;6287.622742635439;6191.380861913818;6220.844478888019;6252.718627661743;6283.434490895818;6303.968480157593;5430.104032834578;5570.637908535952;5579.079451890433;5586;5588.692621905793;5499.862503437426;5501.834944951658;5529.778808847641;5562.471565201299;5570.359408668014;5320.707361095138;5477.5070243678065;5511.559075273968;5524.088525393306;5616.831495055155;5429.918551221695;5500.119980803052;5523.944760552383;5550.250716153308;5567.053600887818;5454.645448045904;5513.669179849182;5515.365732940723;5536.031194540939;5549.0289199390345;6106.664133472657;6107.633541987495;6217.720202590895;6221.564490485668;6229.937700623026;6650.5344625876205;6669.899951500732;6792.45660347176;6816.488763342769;6834.009068685063;6860.794176174722;6931.168259808805;6945.756898508528;6955.65221738911;6962;6283.654399008098;6304.527160462938;6357.65032923189;6392.169018027626;6423.550351475398;6887.104676392037;6896.3103689631635;6903.5512691675885;6909.827254318682;6920;6483.7082331295205;6487.3836985486305;6611.834704132339;6625.238097618739;6628.4697224221945;6779.559328643622;6802.183737951378;6822.863542729117;6875.518713689994;6882.139732533434;6695.196576410862;6728.3271672832325;6789.830254243683;6794.184697836193;6815.2162501312;6616.470682345401;6664.733410663519;6705.530612857151;6765.594064356154;6765.763198288037;4903.632227582945;4904.6321525885705;4905.8037678492465;4906.435759887588;5000.62495312853;4490.820367185342;4517.751523666164;4549.158405694957;4554.658400619966;4574;6438.54930154894;6443.452306553995;6495.8700825983215;6505.154329937172;6545.280019197884;6704.66476676174;6800.625965571941;6865;6880.105586273852;6889.104416425833;6331.113644089831;6351.9682401588625;6356.046593011085;6374.617522948638;6443;5736.110902810071;5736.6558006519745;5745.540356771448;5746.281714785652;5751.1373294006235;6923.653817309215;6941.757038503729;6993.160820701447;7006.614636195059;7018.438524917994;6795.048693183057;6804.21751498584;6818.795436136924;6875.724971001104;6881.793546193722;6885.414739747178;6890.655467226518;6982.895256571257;6991.825204369931;7042.894356584758;6676.0987266718375;6758.391744742997;6763.188417389944;6780.72877084911;6806.76176333826;6848.520603557902;6856.794296171123;6860.279670634711;6919.861602768017;6939.340762627542;6487.935120648922;6511.413972742476;6660.666966651551;6706.6646667665445;6717.798466046026;6634.137562116894;6637.070810086495;6649.202095748541;6661.134052573135;6667.699953502007;6527.5757075789925;6660.666966651551;6678;6691.0967019451755;6703.966480167568;6626.271110177973;6645.235797883305;6645.966770166118;6678.732850686112;6731.730730770714;6406.871862562816;6499.090127382265;6503.414692677682;6556;6563.343665633399 11:47:42 INFO - PID 29670 | |1;ext.html;888.1429420609111;926.2913870888772;952.7570469530269;970.7427531704095;992.2756387836874;44371.77814110929;45004.774976125074;45036.09927801446;45097.323540146885;45127.32309015359;41039;41129;41427;41536;41674.583254167446;7249.492535522516;7358.374538164236;7376.557406555597;7381.630918454082;7395.149557800868;7217.530860494051;7273.272672732737;7298.124225092996;7312.780616581511;7313.232110628387;7739.342155916754;7914.3668506519625;7932.048154221501;7932.365410767154;7937.2459616336355;7789.065312162548;7819.6481158348015;7864.056313242419;7868.409869259828;7875.015623047119;7838.255365740246;7913.6438860250855;7920.049594048751;7923.960380198062;7925.682972681086;41705.165896681894;41949.58050419487;41968.370474442905;41972.37041444381;42149.78925105386;3486.494458303557;3533.1873669056263;3542.4332106863035;3549.716022718176;3549.804760738158;33672.326553468796;33725.83137084299;33735;33743.66256337454;33789;5007.324011258506;5029.673071250357;5050.267711181895;5064.797408103672;5069.670471419346;215924;219388;219558;221853;222339;55384;55551.72224138934;55794.442055578926;55830.162547561005;55888;58349.416505835245;58354.7082264586;58429;58437.70781146067;58465.415345846;16375.42686005984;16504.917475412545;16510.17449127539;16511.669766604842;16638.584035399213;13292.268925209206;13315.06794524374;13322.933385333012;13326.533571324957;13327.666808329675;15822.60443488922;15945.20273986296;16101.19494025294;16196.514104576881;16266.75599866003;6021.939780602225;6025.849353766191;6111.51107911366;6183.5671502994355;6275.905861412082;1100.3178029621527;1105.9170562207867;1107.2194103157256;1114.793763153819;1125.7185703574107;25451.74548254531;25470;25828.483430331664;25850.74149258521;25933.22200333993;1179.2393905930626;1202;1223.614561413152;1224.2348532167396;1239.603326935372;13578.388972496261;13751.518696845562;13986;13991.039435454482;14042;275851;278033;278919;279415;281376;56627.71686141543;57036;57355;57704;57873;1541.129261966985;1551.9379224831107;1591.9442819501494;1611.798525184352;1613.9757903631455;24891.50216995686;24946.12688555892;24957.505949166767;24985;25239.873800630878;40769.388459172544;40910.79544602377;40977.38533921934;41009.38485922654;41015.1796964065;216259;217127;217659;218790;220103;37475.625243747214;41113.79443102765;41730.1653966925;41894;42170.78914605407;51241;51825.74087129691;51840.481595185076;52001.7399912998;52067.47932520627;33955.66044339525;34290.82854585711;34541.30917381689;34649.133771655914;34840;37403.625963740014;37774.811125944194;37934;38058.61941380551;38083.90538520297;41776.37335440032;43649.56350436582;43783.562164377945;43965;44010;35953.64046359608;36057.459138113474;36147;36265.637343627284;36734.44898326474;27077.323066923484;27275.045373411835;27678.5848212281;27954.720452795213;28026.859865700542 11:47:42 INFO - PID 29670 | |2;jquery.html;599.2030599302927;602.3885755957704;602.4427404650697;611.4466407900849;611.7247238742561;24206;24737.13420030297;25619.74380256197;25642.743572564268;25672.101476448304;27354;27818.443631127364;27878.163655090328;27898.3025424364;27900.860495697543;6368.29948705642;6532.836679083013;6533.411992920636;6559.278479367265;6571.835704107411;4465.441819772528;4662.254039353704;6165.845853853644;6327.082573026908;6397.072424498445;6328.936710632881;6338.556301058905;6365.713542890581;6372.362763723614;6381.8085457436355;6352.1107045013505;6366.681665916685;6372.107904893319;6372.84067898304;6374.872502549946;5855.736491857877;5924.170616113747;5932.7330270137945;5938.168656388109;5946.256717910262;32489.6751032489;32915.177120571934;33310.00069997904;33692.83153584241;33804;2324.941876453085;2347.460084180648;2358.7287461941924;2364.290712786157;2365.1958334166466;20574.897125514428;20978;20999.47501312464;21000.789992100035;21003;2377.7978871795917;2437.0617312334703;2460.2373264288126;2505.110685706566;2515.421453065787;157060;164484.17757911253;164885;165280;165346;16455.177241137895;16879.24043418049;16881.15594220284;17048.744268835977;17220.1389930503;26049.869750651127;26114.477710446066;26148.477030459286;26163.476730465285;26189.607155892678;9920.255980801468;10128.898711012796;10248.23138264633;10377.688669339781;10414.271001029856;8419.579021049045;9094.772630684285;9159.90840091604;9178.586963586655;9185.173334399937;9204.447733136034;10297.734498410338;10322.432266225429;10379.11777498921;10440.895591043993;2946.8673909674117;2975.8809647614285;3033.165879383143;3042.6653068162486;3130.733887619532;1050.616524968381;1069.2675517270695;1071.9571217151383;1072.570971611346;1077.1382893685177;25352.492950141263;27048;27251.199040767307;27400;28011.439771204463;1114.0753174865006;1120.047959234644;1124.4714983957526;1125.1055410948316;1137.3062431916524;12035;12366.62900112998;12459.875401245872;12563.623091307276;12608.81086783699;565229;568079;577815;579901;584994;129697.35151324183;132659;134244;136638;138359.30820346036;1342.5703774792169;1348.9190648561118;1349.1163288046541;1351.574254109952;1371.91082579632;20057;20075;20395;20500.872452015283;20561.691574626093;63114;63285.683571583686;63551.682241588496;64489;64790;81057.59471202607;81175.18824811676;81399;81554.59222703849;82742.17257827586;15560.688786224438;15694.058356498646;15879.761803573187;15886.126263055181;16028.439004634782;24880.62679059852;24929.626055608816;25009.499810003334;25035.374115647253;25250.873745631154;18816.52958676044;19095.23619055278;19330.4200873974;19376.709349359488;19429.51426214356;16563.83436165671;17046.573835654206;17195.570110747332;17584.120793959995;17621.823781762017;20672.759634421982;20777.68833467469;20973.685394718785;21024.474388140417;21188.78811211868;15594.610134746723;15604;15625.68748625044;15630.9218453907;15706.136162511171;20174.89912550428;20362.694559581916;20497.69253461229;20623.79376206219;20638.38084857457 11:47:42 INFO - PID 29670 | |3;mootools.html;1416.490063577112;1437.6405898525368;1472.0431719382407;1489.605254607529;1495.200067963639;15349.846501534981;16040;16050.518484445485;16069.357225710957;16285.348586056572;16261.430849920254;16394.754078688828;16495.257713402894;16502;16506.83493165068;2999.7150270724246;3043.193553708269;3109.937801243974;3111.626604807415;3113.5485354623565;2900.05748131858;2968.1540760883154;3000.354923691406;3005.5341422079505;3006.353633968696;2994.4609970205356;3003.564483149942;3031.1058237819784;3033.5449682547574;3035.195673146618;2946.6758656547763;2953.114065780268;2973.895913643034;2975.821450712964;2976.3154474470775;2847.2027832207013;2856.3573196030934;2856.4001559672492;2880.683124856264;2881.2508747725533;15182.544523664308;15465;15467.922660386626;15484.225788710632;15489.07065576069;8582.055973842873;8843.955780221058;8886.066962968924;8890.244329232022;8898.288136949028;5192.55863251624;5378.650387724824;5508.504234618904;5512.062949298629;5513.3108361454815;1860.395371504253;1877.2115711401245;1891.886486810782;1897.9905100474548;1899.2972600137898;27517;27530.724692753018;27847;27875.303117422023;27878.442431151467;7459.701611935462;7462.664180111908;7495.550266983998;7701.768946931601;7709.4603377763015;18353.449396518125;18528.258869645062;18533.907330463262;18569.25722971093;18578.907105464386;8516.8722469163;8647.697330593399;8682.739517814476;8682.91317086821;8687.522186279815;7823.413244006609;7893.13175550689;8084.231997960184;8110.270075693216;8114.756557303291;5787;5912.3496415394275;5949.762009519571;5968.761249550056;6054.091886217015;1680.6050578114134;1690.7632931389614;1701.140923833456;1701.7111984380988;1704.7783788107715;962.6919385796477;979.2313034268066;987.4322264697828;1005.9144972677258;1007.078523151323;9292.488913109844;9518.428894266366;10127.64553240633;10180.389176649425;10222.693319200436;1048.5648455890873;1091.7161538000178;1096.550414330121;1097.1003776903024;1101.7025403141106;5608.3247323730275;5627;5758.395368486333;5830.825075247664;5915.822525324247;22563.661545076837;22902.541949160925;23067.76932230656;23119.768802311763;23348.299551013497;23124.421889452897;23306.7669323308;23350.416239593807;23405.06379744791;23428.882855585955;11454;11944.940275298568;12054;12057.397130143458;12262.080343974238;9144.771380715536;9306.44161350294;9496.952515237379;9500.144986951207;9784.559694813894;19287;19911.303104391278;20011.09950052222;20443.38669839907;20467.181312747325;20511.38465846027;20529.486762830453;20626.381208563766;20799.06404211784;20965.37103886886;12070.215435996632;12338.938305308417;12758.298293593942;13027.08810383264;13220.801687974496;15091.396344146551;15234.771478428054;15240.847591523943;15243.161626110226;15250;11308;11348.943255283672;11513.712157196138;11607.419629018685;11630.825537617111;11584.536618535165;11599;11619;11786.174967752175;11981.161318707607;9828.950855245677;10344.431056291976;10426.530806113591;10622.946885265525;10628.25602207838;8171.591420429074;8188.877166842383;8191.262786349257;8225.876611850947;8316.209960053786;8255.834883302421;8295.419320647497;8368.83262334762;8381.371397145116;8398.706045288385 11:47:42 INFO - PID 29670 | |4;prototype.html;528.3448523830449;548.1366847215635;558.9245451863998;561.8876224755048;567.809783722453;6197.380261973801;6214.184007394271;6226.3462336454695;6233.1273621693;6257.5619706620555;6145.754169833202;6160.445559899608;6160.507159427246;6174.634824020908;6177.629342239457;4943.752812359386;4949.133901567211;4951.777170027357;4954.529319714621;4979.576735977446;4708.411448568929;4910.582600478946;4921.753912304388;4930.126551910269;4968.229924361712;4775.641826863;4814.229723244282;4816.109019831342;4817.108834865544;4819.566239038486;4736.5026672199265;4754.690945088558;4789.760511974388;4793.976030119845;4821.108095002436;4335.84824531143;4337.327714204303;4340.631046361063;4341.131773645252;4356.71681340715;5911.615744976606;5920.585559010871;5928.970355148197;5959.612625179349;5973.924693555158;5663.773449062032;5774.595778295521;5776.566757493205;5784.421557844224;5790.160426738142;6378.904316435257;6447.583405367292;6511.38141876521;6532.804015879484;6567.799787071337;4892.2661600760175;4912.680675756064;4973.452920178777;4975.253711943237;4989.55094041538;6478.611283322968;6637.634930078843;6774.187097548276;6798.76204332846;6846.349596788297;5087.821926232564;5099.286099946011;5109.923351149736;5112.923306150411;5158.045761534128;5185.870353241124;5193.272941788153;5199.974000129975;5200.739963001834;5233.869153271199;5636.887262254732;5689.487946084872;5698.373178950312;5700.429957004267;5753.712314384264;6507.837304067436;6528.281888992207;6531.640759758164;6571.507136964651;6611.107500487469;1785.5625371783997;1786.580153663888;1793.175139435848;1793.2378739035858;1800.774903137108;1226.2397313665585;1239.5971309324505;1264.607971528829;1272.63729836996;1277.208130958793;6174.567780255429;6195.1636529068;6195.628262304276;6207.844803879939;6225.420383279542;6605.504587155982;6609.405153536205;6643.236027856762;6694.765683201064;6702.39678428934;6082.665453400017;6085.6044357117535;6118.632882027093;6145.231846019247;6168.568200225941;3495.632958539368;3542.5748910130433;3545.503629491873;3564.413835843077;3568.7145028397667;6521.967390163114;6768.7292508299115;6783.796486105425;6819.283975182633;6868.484863635247;6801.557898736566;6818.352256535622;6834.931650683529;6847.897281540781;6848.767221900106;6716.447749855024;6771.796846094625;6820.829479262959;6832.282610325944;6854.108965834509;6556.868862622816;6580.144581204604;6598.868022639616;6610.933890661032;6614;6496.805095847132;6507.707153178024;6553.115329430466;6591.472682185509;6593.670316484253;6612.338766123349;6700.631465269457;6759.493038022069;6764.289749576224;6771.28901465339;5108.821191258288;5122.282880396673;5136.357955255593;5138.563222126161;5148.6910785353;6337.429631333202;6390.90413643805;6611.404973552403;6681.728212407805;6735.393814556714;6382.87234255303;6400.751853388544;6409.647469389229;6486.481081513562;6560.901586476111;6339.936600634119;6390.808275751735;6400.967995159995;6461.515386346136;6565.606063636197;6399.304618889099;6404.903926441014;6412.9679351602945;6507.234425369104;6544.345565443608;6517.771877984248;6532.5753826001155;6535.673216339259;6553.639549824806;6581.934180658132;6369.20384951881;6392.616443013434;6409.871802563829;6422.6467544285515;6433.774817881352 11:47:42 INFO - PID 29670 | |5;yui.html;946.0303189231038;948.8471507118849;952.7665721898136;975.2295686407738;983.1544871410586;19888.20447182113;20473.897630511827;20544.69182962255;20548.48628784281;21020.264290749827;22045.669314960287;22351.77648223517;22426.43933901653;22497.21259755909;22498.88750556245;1058.8570542976677;1058.9894101058967;1061.400308825515;1062.8830828608848;1063.702163394247;1044.7544826965657;1086.1907878630432;1090.3893819461086;1090.841827934949;1096.9945150274239;1154.2382027861613;1154.5381847261121;1156.6125348008427;1158.0041164598438;1161.6689243565586;1139.242403801471;1145.1468655851402;1145.2384164530577;1147.5753971030688;1155.029774989009;845.1337379186383;847.635516727813;848.1094850407048;848.6393282854824;849.5157760076759;17008.744868826976;17357.218925148398;20601.278955236645;20701.585968280702;20815.5836883263;21441.571168576542;21728.89135554328;21742.130314787388;22088.88955555228;22178;16820.32718691251;16892.239849206693;16966.151692415453;17059;17363.826361736472;3661.8901432957055;3684.392075307571;3721.5162028936334;3722.1997270586953;3753.6997040236715;143252.2837385817;143259.28370358187;145079.2746036284;145249;145389;15371.385144594315;15877.920610396874;15985.760213596805;16002.439914603166;16055.438059667855;30685.539716904263;32059.51910721341;32176;32240.19399514984;32283.51574726381;8566.571671416405;8569.871451928226;8613.870791938127;8646.567671616394;8668.133186681282;4267.5732426757695;4314.115606300701;4364.236258654722;4379.759113248738;4387.956120438818;5741.081426971748;5826.533877289807;5836.591438599342;5846.619969701956;5879.323877754027;1049.8530205771199;1062.0759938853248;1072.0458791675414;1082.7076689293847;1083.6748975307376;734.6804140199031;744.6090802328713;747.3684736397735;766.1151370167465;773.3156156801272;12720.491180352683;12799.744005119845;12934;12996.285204313854;13231.073824832361;748.831512909591;756.5007095317064;759.4607828441758;760.7945854619222;762.6415584675194;5745.224394706661;5756;5839.824805255849;5945.048792193228;6021.759129634853;127640;128163.35918320535;128416;129285;135636.32181839028;111373;112078;114062.4296878527;114600;115749;97639.51180244054;98056.50971745096;98625;100934.49532752289;103073;11156.206889657555;11223.38271395081;11502.82745758831;11702.35637039971;11732.824007639721;48843.5115648839;48888.511114888395;49672;50034.99930001307;50999.2350114756;78549;81893.59053204935;82232.58883705543;84115;85505.57247213973;18397.448076557725;18422;18652.160652770388;18879.150438230587;18946.810531894505;21515.784842152003;22101.66847497257;22146.114155433603;22395.552088957804;22405.21581744631;19911.900440498284;20010.499737506678;21010.2646407375;21294.148234071083;21422.678659820427;20835.27076552374;21403.250886219532;21534.030968606763;21710.67433988523;21744.782552174907;20557;20946.47633809167;21025;21231.15075396967;21279.468013299793;13950.441982321;14322;14621.342039608457;14705.558833234592;14796.704065918406;15996.68006639884;16051.03693778377;16310.59223519374;16474.42339518111;16861.494155175365 11:47:42 INFO - PID 29670 | __end_tp_report 11:47:42 INFO - PID 29670 | __start_cc_report 11:47:42 INFO - PID 29670 | _x_x_mozilla_cycle_collect,253 11:47:42 INFO - PID 29670 | __end_cc_report 11:47:42 INFO - PID 29670 | __startTimestamp1502736462739__endTimestamp 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | ------- Summary: start ------- 11:47:42 INFO - PID 29670 | Number of tests: 6 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | [#0] dojo.html Cycles:165 Average:6242.50 Median:6545.28 stddev:785.96 (12.0%) stddev-sans-first:758.65 11:47:42 INFO - PID 29670 | Values: 3513.2 3529.5 3545.4 3545.6 3545.9 6178.5 6216.3 6228.3 6277.7 6287.6 6191.4 6220.8 6252.7 6283.4 6304.0 5430.1 5570.6 5579.1 5586.0 5588.7 5499.9 5501.8 5529.8 5562.5 5570.4 5320.7 5477.5 5511.6 5524.1 5616.8 5429.9 5500.1 5523.9 5550.3 5567.1 5454.6 5513.7 5515.4 5536.0 5549.0 6106.7 6107.6 6217.7 6221.6 6229.9 6650.5 6669.9 6792.5 6816.5 6834.0 6860.8 6931.2 6945.8 6955.7 6962.0 6283.7 6304.5 6357.7 6392.2 6423.6 6887.1 6896.3 6903.6 6909.8 6920.0 6483.7 6487.4 6611.8 6625.2 6628.5 6779.6 6802.2 6822.9 6875.5 6882.1 6695.2 6728.3 6789.8 6794.2 6815.2 6616.5 6664.7 6705.5 6765.6 6765.8 4903.6 4904.6 4905.8 4906.4 5000.6 4490.8 4517.8 4549.2 4554.7 4574.0 6438.5 6443.5 6495.9 6505.2 6545.3 6704.7 6800.6 6865.0 6880.1 6889.1 6331.1 6352.0 6356.0 6374.6 6443.0 5736.1 5736.7 5745.5 5746.3 5751.1 6923.7 6941.8 6993.2 7006.6 7018.4 6795.0 6804.2 6818.8 6875.7 6881.8 6885.4 6890.7 6982.9 6991.8 7042.9 6676.1 6758.4 6763.2 6780.7 6806.8 6848.5 6856.8 6860.3 6919.9 6939.3 6487.9 6511.4 6660.7 6706.7 6717.8 6634.1 6637.1 6649.2 6661.1 6667.7 6527.6 6660.7 6678.0 6691.1 6704.0 6626.3 6645.2 6646.0 6678.7 6731.7 6406.9 6499.1 6503.4 6556.0 6563.3 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | [#1] ext.html Cycles:180 Average:42538.63 Median:39426.65 stddev:62532.46 (158.6%) stddev-sans-first:62629.68 11:47:42 INFO - PID 29670 | Values: 888.1 926.3 952.8 970.7 992.3 44371.8 45004.8 45036.1 45097.3 45127.3 41039.0 41129.0 41427.0 41536.0 41674.6 7249.5 7358.4 7376.6 7381.6 7395.1 7217.5 7273.3 7298.1 7312.8 7313.2 7739.3 7914.4 7932.0 7932.4 7937.2 7789.1 7819.6 7864.1 7868.4 7875.0 7838.3 7913.6 7920.0 7924.0 7925.7 41705.2 41949.6 41968.4 41972.4 42149.8 3486.5 3533.2 3542.4 3549.7 3549.8 33672.3 33725.8 33735.0 33743.7 33789.0 5007.3 5029.7 5050.3 5064.8 5069.7 215924.0 219388.0 219558.0 221853.0 222339.0 55384.0 55551.7 55794.4 55830.2 55888.0 58349.4 58354.7 58429.0 58437.7 58465.4 16375.4 16504.9 16510.2 16511.7 16638.6 13292.3 13315.1 13322.9 13326.5 13327.7 15822.6 15945.2 16101.2 16196.5 16266.8 6021.9 6025.8 6111.5 6183.6 6275.9 1100.3 1105.9 1107.2 1114.8 1125.7 25451.7 25470.0 25828.5 25850.7 25933.2 1179.2 1202.0 1223.6 1224.2 1239.6 13578.4 13751.5 13986.0 13991.0 14042.0 275851.0 278033.0 278919.0 279415.0 281376.0 56627.7 57036.0 57355.0 57704.0 57873.0 1541.1 1551.9 1591.9 1611.8 1614.0 24891.5 24946.1 24957.5 24985.0 25239.9 40769.4 40910.8 40977.4 41009.4 41015.2 216259.0 217127.0 217659.0 218790.0 220103.0 37475.6 41113.8 41730.2 41894.0 42170.8 51241.0 51825.7 51840.5 52001.7 52067.5 33955.7 34290.8 34541.3 34649.1 34840.0 37403.6 37774.8 37934.0 38058.6 38083.9 41776.4 43649.6 43783.6 43965.0 44010.0 35953.6 36057.5 36147.0 36265.6 36734.4 27077.3 27275.0 27678.6 27954.7 28026.9 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | [#2] jquery.html Cycles:180 Average:39849.95 Median:2448.65 stddev:97109.55 (3965.8%) stddev-sans-first:97337.25 11:47:42 INFO - PID 29670 | Values: 599.2 602.4 602.4 611.4 611.7 24206.0 24737.1 25619.7 25642.7 25672.1 27354.0 27818.4 27878.2 27898.3 27900.9 6368.3 6532.8 6533.4 6559.3 6571.8 4465.4 4662.3 6165.8 6327.1 6397.1 6328.9 6338.6 6365.7 6372.4 6381.8 6352.1 6366.7 6372.1 6372.8 6374.9 5855.7 5924.2 5932.7 5938.2 5946.3 32489.7 32915.2 33310.0 33692.8 33804.0 2324.9 2347.5 2358.7 2364.3 2365.2 20574.9 20978.0 20999.5 21000.8 21003.0 2377.8 2437.1 2460.2 2505.1 2515.4 157060.0 164484.2 164885.0 165280.0 165346.0 16455.2 16879.2 16881.2 17048.7 17220.1 26049.9 26114.5 26148.5 26163.5 26189.6 9920.3 10128.9 10248.2 10377.7 10414.3 8419.6 9094.8 9159.9 9178.6 9185.2 9204.4 10297.7 10322.4 10379.1 10440.9 2946.9 2975.9 3033.2 3042.7 3130.7 1050.6 1069.3 1072.0 1072.6 1077.1 25352.5 27048.0 27251.2 27400.0 28011.4 1114.1 1120.0 1124.5 1125.1 1137.3 12035.0 12366.6 12459.9 12563.6 12608.8 565229.0 568079.0 577815.0 579901.0 584994.0 129697.4 132659.0 134244.0 136638.0 138359.3 1342.6 1348.9 1349.1 1351.6 1371.9 20057.0 20075.0 20395.0 20500.9 20561.7 63114.0 63285.7 63551.7 64489.0 64790.0 81057.6 81175.2 81399.0 81554.6 82742.2 15560.7 15694.1 15879.8 15886.1 16028.4 24880.6 24929.6 25009.5 25035.4 25250.9 18816.5 19095.2 19330.4 19376.7 19429.5 16563.8 17046.6 17195.6 17584.1 17621.8 20672.8 20777.7 20973.7 21024.5 21188.8 15594.6 15604.0 15625.7 15630.9 15706.1 20174.9 20362.7 20497.7 20623.8 20638.4 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | [#3] mootools.html Cycles:180 Average:10070.34 Median:23349.36 stddev:7067.85 (30.3%) stddev-sans-first:7057.76 11:47:42 INFO - PID 29670 | Values: 1416.5 1437.6 1472.0 1489.6 1495.2 15349.8 16040.0 16050.5 16069.4 16285.3 16261.4 16394.8 16495.3 16502.0 16506.8 2999.7 3043.2 3109.9 3111.6 3113.5 2900.1 2968.2 3000.4 3005.5 3006.4 2994.5 3003.6 3031.1 3033.5 3035.2 2946.7 2953.1 2973.9 2975.8 2976.3 2847.2 2856.4 2856.4 2880.7 2881.3 15182.5 15465.0 15467.9 15484.2 15489.1 8582.1 8844.0 8886.1 8890.2 8898.3 5192.6 5378.7 5508.5 5512.1 5513.3 1860.4 1877.2 1891.9 1898.0 1899.3 27517.0 27530.7 27847.0 27875.3 27878.4 7459.7 7462.7 7495.6 7701.8 7709.5 18353.4 18528.3 18533.9 18569.3 18578.9 8516.9 8647.7 8682.7 8682.9 8687.5 7823.4 7893.1 8084.2 8110.3 8114.8 5787.0 5912.3 5949.8 5968.8 6054.1 1680.6 1690.8 1701.1 1701.7 1704.8 962.7 979.2 987.4 1005.9 1007.1 9292.5 9518.4 10127.6 10180.4 10222.7 1048.6 1091.7 1096.6 1097.1 1101.7 5608.3 5627.0 5758.4 5830.8 5915.8 22563.7 22902.5 23067.8 23119.8 23348.3 23124.4 23306.8 23350.4 23405.1 23428.9 11454.0 11944.9 12054.0 12057.4 12262.1 9144.8 9306.4 9497.0 9500.1 9784.6 19287.0 19911.3 20011.1 20443.4 20467.2 20511.4 20529.5 20626.4 20799.1 20965.4 12070.2 12338.9 12758.3 13027.1 13220.8 15091.4 15234.8 15240.8 15243.2 15250.0 11308.0 11348.9 11513.7 11607.4 11630.8 11584.5 11599.0 11619.0 11786.2 11981.2 9829.0 10344.4 10426.5 10622.9 10628.3 8171.6 8188.9 8191.3 8225.9 8316.2 8255.8 8295.4 8368.8 8381.4 8398.7 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | [#4] prototype.html Cycles:180 Average:5524.75 Median:6186.40 stddev:1543.94 (25.0%) stddev-sans-first:1502.03 11:47:42 INFO - PID 29670 | Values: 528.3 548.1 558.9 561.9 567.8 6197.4 6214.2 6226.3 6233.1 6257.6 6145.8 6160.4 6160.5 6174.6 6177.6 4943.8 4949.1 4951.8 4954.5 4979.6 4708.4 4910.6 4921.8 4930.1 4968.2 4775.6 4814.2 4816.1 4817.1 4819.6 4736.5 4754.7 4789.8 4794.0 4821.1 4335.8 4337.3 4340.6 4341.1 4356.7 5911.6 5920.6 5929.0 5959.6 5973.9 5663.8 5774.6 5776.6 5784.4 5790.2 6378.9 6447.6 6511.4 6532.8 6567.8 4892.3 4912.7 4973.5 4975.3 4989.6 6478.6 6637.6 6774.2 6798.8 6846.3 5087.8 5099.3 5109.9 5112.9 5158.0 5185.9 5193.3 5200.0 5200.7 5233.9 5636.9 5689.5 5698.4 5700.4 5753.7 6507.8 6528.3 6531.6 6571.5 6611.1 1785.6 1786.6 1793.2 1793.2 1800.8 1226.2 1239.6 1264.6 1272.6 1277.2 6174.6 6195.2 6195.6 6207.8 6225.4 6605.5 6609.4 6643.2 6694.8 6702.4 6082.7 6085.6 6118.6 6145.2 6168.6 3495.6 3542.6 3545.5 3564.4 3568.7 6522.0 6768.7 6783.8 6819.3 6868.5 6801.6 6818.4 6834.9 6847.9 6848.8 6716.4 6771.8 6820.8 6832.3 6854.1 6556.9 6580.1 6598.9 6610.9 6614.0 6496.8 6507.7 6553.1 6591.5 6593.7 6612.3 6700.6 6759.5 6764.3 6771.3 5108.8 5122.3 5136.4 5138.6 5148.7 6337.4 6390.9 6611.4 6681.7 6735.4 6382.9 6400.8 6409.6 6486.5 6560.9 6339.9 6390.8 6401.0 6461.5 6565.6 6399.3 6404.9 6413.0 6507.2 6544.3 6517.8 6532.6 6535.7 6553.6 6581.9 6369.2 6392.6 6409.9 6422.6 6433.8 11:47:42 INFO - PID 29670 | 11:47:42 INFO - PID 29670 | [#5] yui.html Cycles:180 Average:26799.46 Median:20978.37 stddev:37538.43 (178.9%) stddev-sans-first:37593.54 11:47:42 INFO - PID 29670 | Values: 946.0 948.8 952.8 975.2 983.2 19888.2 20473.9 20544.7 20548.5 21020.3 22045.7 22351.8 22426.4 22497.2 22498.9 1058.9 1059.0 1061.4 1062.9 1063.7 1044.8 1086.2 1090.4 1090.8 1097.0 1154.2 1154.5 1156.6 1158.0 1161.7 1139.2 1145.1 1145.2 1147.6 1155.0 845.1 847.6 848.1 848.6 849.5 17008.7 17357.2 20601.3 20701.6 20815.6 21441.6 21728.9 21742.1 22088.9 22178.0 16820.3 16892.2 16966.2 17059.0 17363.8 3661.9 3684.4 3721.5 3722.2 3753.7 143252.3 143259.3 145079.3 145249.0 145389.0 15371.4 15877.9 15985.8 16002.4 16055.4 30685.5 32059.5 32176.0 32240.2 32283.5 8566.6 8569.9 8613.9 8646.6 8668.1 4267.6 4314.1 4364.2 4379.8 4388.0 5741.1 5826.5 5836.6 5846.6 5879.3 1049.9 1062.1 1072.0 1082.7 1083.7 734.7 744.6 747.4 766.1 773.3 12720.5 12799.7 12934.0 12996.3 13231.1 748.8 756.5 759.5 760.8 762.6 5745.2 5756.0 5839.8 5945.0 6021.8 127640.0 128163.4 128416.0 129285.0 135636.3 111373.0 112078.0 114062.4 114600.0 115749.0 97639.5 98056.5 98625.0 100934.5 103073.0 11156.2 11223.4 11502.8 11702.4 11732.8 48843.5 48888.5 49672.0 50035.0 50999.2 78549.0 81893.6 82232.6 84115.0 85505.6 18397.4 18422.0 18652.2 18879.2 18946.8 21515.8 22101.7 22146.1 22395.6 22405.2 19911.9 20010.5 21010.3 21294.1 21422.7 20835.3 21403.3 21534.0 21710.7 21744.8 20557.0 20946.5 21025.0 21231.2 21279.5 13950.4 14322.0 14621.3 14705.6 14796.7 15996.7 16051.0 16310.6 16474.4 16861.5 11:47:42 INFO - PID 29670 | -------- Summary: end -------- 11:47:42 INFO - PID 29670 | 11:47:43 INFO - TEST-INFO | 29670: exit 0 11:47:43 INFO - TEST-OK | dromaeo_css | took 1108123ms 11:47:43 INFO - TEST-START | kraken 11:47:43 INFO - Initialising browser for kraken test... 11:47:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55802/getInfo.html -profile /tmp/tmpwSALXB/profile 11:47:43 INFO - TEST-INFO | started process 30030 (/builds/slave/test/build/application/firefox/firefox http://localhost:55802/getInfo.html) 11:47:48 INFO - TEST-INFO | 30030: exit 0 11:47:48 INFO - Browser initialized. 11:47:48 INFO - Running cycle 1/1 for kraken test... 11:47:48 INFO - TEST-INFO | started process 30195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwSALXB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:49 INFO - PID 30195 | 1502736469094 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 11:47:59 INFO - PID 30195 | RSS: Main: 139591680 11:47:59 INFO - PID 30195 | 11:48:02 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-beat-detection) 11:48:03 INFO - PID 30195 | RSS: Main: 146948096 11:48:03 INFO - PID 30195 | 11:48:05 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-dft) 11:48:06 INFO - PID 30195 | RSS: Main: 147419136 11:48:06 INFO - PID 30195 | 11:48:09 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-fft) 11:48:09 INFO - PID 30195 | RSS: Main: 147853312 11:48:09 INFO - PID 30195 | 11:48:12 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55802/tests/kraken/driver.html?testName=audio-oscillator) 11:48:12 INFO - PID 30195 | RSS: Main: 148779008 11:48:12 INFO - PID 30195 | 11:48:14 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:48:15 INFO - PID 30195 | RSS: Main: 147582976 11:48:15 INFO - PID 30195 | 11:48:18 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-darkroom) 11:48:18 INFO - PID 30195 | RSS: Main: 148258816 11:48:18 INFO - PID 30195 | 11:48:22 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55802/tests/kraken/driver.html?testName=imaging-desaturate) 11:48:22 INFO - PID 30195 | RSS: Main: 150663168 11:48:22 INFO - PID 30195 | 11:48:25 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55802/tests/kraken/driver.html?testName=json-parse-financial) 11:48:26 INFO - PID 30195 | RSS: Main: 150958080 11:48:26 INFO - PID 30195 | 11:48:27 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:48:28 INFO - PID 30195 | RSS: Main: 150794240 11:48:28 INFO - PID 30195 | 11:48:30 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:48:30 INFO - PID 30195 | RSS: Main: 150990848 11:48:30 INFO - PID 30195 | 11:48:32 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:48:33 INFO - PID 30195 | RSS: Main: 150704128 11:48:33 INFO - PID 30195 | 11:48:35 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:48:36 INFO - PID 30195 | RSS: Main: 151199744 11:48:36 INFO - PID 30195 | 11:48:39 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:48:39 INFO - PID 30195 | RSS: Main: 151433216 11:48:39 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | Cycle 1(1): loaded http://localhost:55802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55802/tests/kraken/driver.html?testName=ai-astar) 11:48:41 INFO - PID 30195 | RSS: Main: 153018368 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | __start_tp_report 11:48:41 INFO - PID 30195 | _x_x_mozilla_page_load 11:48:41 INFO - PID 30195 | _x_x_mozilla_page_load_details 11:48:41 INFO - PID 30195 | |i|pagename|runs| 11:48:41 INFO - PID 30195 | |0;ai-astar;103;109;94;106;106;108;109;105;107;108 11:48:41 INFO - PID 30195 | |1;audio-beat-detection;142;111;148;162;112;150;138;115;163;113 11:48:41 INFO - PID 30195 | |2;audio-dft;163;161;161;160;166;162;161;161;162;163 11:48:41 INFO - PID 30195 | |3;audio-fft;74;76;75;189;74;76;73;76;163;76 11:48:41 INFO - PID 30195 | |4;audio-oscillator;77;78;129;77;78;78;129;78;78;128 11:48:41 INFO - PID 30195 | |5;imaging-gaussian-blur;114;113;114;114;114;114;114;115;113;114 11:48:41 INFO - PID 30195 | |6;imaging-darkroom;148;148;148;147;148;148;148;148;149;147 11:48:41 INFO - PID 30195 | |7;imaging-desaturate;94;99;94;94;94;94;94;94;94;93 11:48:41 INFO - PID 30195 | |8;json-parse-financial;47;56;44;45;46;44;45;47;45;45 11:48:41 INFO - PID 30195 | |9;json-stringify-tinderbox;53;52;53;53;52;52;52;52;52;53 11:48:41 INFO - PID 30195 | |10;stanford-crypto-aes;77;73;76;73;75;73;74;72;74;73 11:48:41 INFO - PID 30195 | |11;stanford-crypto-ccm;123;125;126;117;115;118;118;128;117;149 11:48:41 INFO - PID 30195 | |12;stanford-crypto-pbkdf2;170;161;170;161;158;158;159;163;164;164 11:48:41 INFO - PID 30195 | |13;stanford-crypto-sha256-iterative;72;60;59;62;59;58;58;59;61;59 11:48:41 INFO - PID 30195 | __end_tp_report 11:48:41 INFO - PID 30195 | __start_cc_report 11:48:41 INFO - PID 30195 | _x_x_mozilla_cycle_collect,708 11:48:41 INFO - PID 30195 | __end_cc_report 11:48:41 INFO - PID 30195 | __startTimestamp1502736521884__endTimestamp 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | ------- Summary: start ------- 11:48:41 INFO - PID 30195 | Number of tests: 14 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#0] ai-astar Cycles:10 Average:105.50 Median:108.00 stddev:4.45 (4.1%) stddev-sans-first:4.63 11:48:41 INFO - PID 30195 | Values: 103.0 109.0 94.0 106.0 106.0 108.0 109.0 105.0 107.0 108.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:145.00 stddev:20.96 (14.5%) stddev-sans-first:22.09 11:48:41 INFO - PID 30195 | Values: 142.0 111.0 148.0 162.0 112.0 150.0 138.0 115.0 163.0 113.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.70 (1.0%) stddev-sans-first:1.76 11:48:41 INFO - PID 30195 | Values: 163.0 161.0 161.0 160.0 166.0 162.0 161.0 161.0 162.0 163.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:43.04 (57.0%) stddev-sans-first:44.96 11:48:41 INFO - PID 30195 | Values: 74.0 76.0 75.0 189.0 74.0 76.0 73.0 76.0 163.0 76.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:24.62 (31.6%) stddev-sans-first:25.42 11:48:41 INFO - PID 30195 | Values: 77.0 78.0 129.0 77.0 78.0 78.0 129.0 78.0 78.0 128.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:48:41 INFO - PID 30195 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 114.0 115.0 113.0 114.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:48:41 INFO - PID 30195 | Values: 148.0 148.0 148.0 147.0 148.0 148.0 148.0 148.0 149.0 147.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 11:48:41 INFO - PID 30195 | Values: 94.0 99.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#8] json-parse-financial Cycles:10 Average:46.40 Median:45.50 stddev:3.53 (7.8%) stddev-sans-first:3.74 11:48:41 INFO - PID 30195 | Values: 47.0 56.0 44.0 45.0 46.0 44.0 45.0 47.0 45.0 45.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#9] json-stringify-tinderbox Cycles:10 Average:52.40 Median:52.50 stddev:0.52 (1.0%) stddev-sans-first:0.50 11:48:41 INFO - PID 30195 | Values: 53.0 52.0 53.0 53.0 52.0 52.0 52.0 52.0 52.0 53.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.56 (2.1%) stddev-sans-first:1.22 11:48:41 INFO - PID 30195 | Values: 77.0 73.0 76.0 73.0 75.0 73.0 74.0 72.0 74.0 73.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:9.98 (8.0%) stddev-sans-first:10.58 11:48:41 INFO - PID 30195 | Values: 123.0 125.0 126.0 117.0 115.0 118.0 118.0 128.0 117.0 149.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.50 stddev:4.39 (2.7%) stddev-sans-first:3.81 11:48:41 INFO - PID 30195 | Values: 170.0 161.0 170.0 161.0 158.0 158.0 159.0 163.0 164.0 164.0 11:48:41 INFO - PID 30195 | 11:48:41 INFO - PID 30195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:59.50 stddev:4.16 (7.0%) stddev-sans-first:1.33 11:48:41 INFO - PID 30195 | Values: 72.0 60.0 59.0 62.0 59.0 58.0 58.0 59.0 61.0 59.0 11:48:41 INFO - PID 30195 | -------- Summary: end -------- 11:48:41 INFO - PID 30195 | 11:48:42 INFO - PID 30195 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:48:42 INFO - TEST-INFO | 30195: exit 0 11:48:42 INFO - TEST-OK | kraken | took 59147ms 11:48:42 INFO - SUITE-END | took 1167s 11:48:43 INFO - Completed test suite (00:19:27) 11:48:43 INFO - javascript benchmark 11:48:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9043.908485094755, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3513.156842357835, 3529.5058691783156, 3545.379558577248, 3545.574531056274, 3545.8936231913044, 6178.474829639486, 6216.254049514059, 6228.346023667517, 6277.686115694214, 6287.622742635439, 6191.380861913818, 6220.844478888019, 6252.718627661743, 6283.434490895818, 6303.968480157593, 5430.104032834578, 5570.637908535952, 5579.079451890433, 5586.0, 5588.692621905793, 5499.862503437426, 5501.834944951658, 5529.778808847641, 5562.471565201299, 5570.359408668014, 5320.707361095138, 5477.5070243678065, 5511.559075273968, 5524.088525393306, 5616.831495055155, 5429.918551221695, 5500.119980803052, 5523.944760552383, 5550.250716153308, 5567.053600887818, 5454.645448045904, 5513.669179849182, 5515.365732940723, 5536.031194540939, 5549.0289199390345, 6106.664133472657, 6107.633541987495, 6217.720202590895, 6221.564490485668, 6229.937700623026, 6650.5344625876205, 6669.899951500732, 6792.45660347176, 6816.488763342769, 6834.009068685063, 6860.794176174722, 6931.168259808805, 6945.756898508528, 6955.65221738911, 6962.0, 6283.654399008098, 6304.527160462938, 6357.65032923189, 6392.169018027626, 6423.550351475398, 6887.104676392037, 6896.3103689631635, 6903.5512691675885, 6909.827254318682, 6920.0, 6483.7082331295205, 6487.3836985486305, 6611.834704132339, 6625.238097618739, 6628.4697224221945, 6779.559328643622, 6802.183737951378, 6822.863542729117, 6875.518713689994, 6882.139732533434, 6695.196576410862, 6728.3271672832325, 6789.830254243683, 6794.184697836193, 6815.2162501312, 6616.470682345401, 6664.733410663519, 6705.530612857151, 6765.594064356154, 6765.763198288037, 4903.632227582945, 4904.6321525885705, 4905.8037678492465, 4906.435759887588, 5000.62495312853, 4490.820367185342, 4517.751523666164, 4549.158405694957, 4554.658400619966, 4574.0, 6438.54930154894, 6443.452306553995, 6495.8700825983215, 6505.154329937172, 6545.280019197884, 6704.66476676174, 6800.625965571941, 6865.0, 6880.105586273852, 6889.104416425833, 6331.113644089831, 6351.9682401588625, 6356.046593011085, 6374.617522948638, 6443.0, 5736.110902810071, 5736.6558006519745, 5745.540356771448, 5746.281714785652, 5751.1373294006235, 6923.653817309215, 6941.757038503729, 6993.160820701447, 7006.614636195059, 7018.438524917994, 6795.048693183057, 6804.21751498584, 6818.795436136924, 6875.724971001104, 6881.793546193722, 6885.414739747178, 6890.655467226518, 6982.895256571257, 6991.825204369931, 7042.894356584758, 6676.0987266718375, 6758.391744742997, 6763.188417389944, 6780.72877084911, 6806.76176333826, 6848.520603557902, 6856.794296171123, 6860.279670634711, 6919.861602768017, 6939.340762627542, 6487.935120648922, 6511.413972742476, 6660.666966651551, 6706.6646667665445, 6717.798466046026, 6634.137562116894, 6637.070810086495, 6649.202095748541, 6661.134052573135, 6667.699953502007, 6527.5757075789925, 6660.666966651551, 6678.0, 6691.0967019451755, 6703.966480167568, 6626.271110177973, 6645.235797883305, 6645.966770166118, 6678.732850686112, 6731.730730770714, 6406.871862562816, 6499.090127382265, 6503.414692677682, 6556.0, 6563.343665633399], "value": 6183.935983406755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.1429420609111, 926.2913870888772, 952.7570469530269, 970.7427531704095, 992.2756387836874, 44371.77814110929, 45004.774976125074, 45036.09927801446, 45097.323540146885, 45127.32309015359, 41039.0, 41129.0, 41427.0, 41536.0, 41674.583254167446, 7249.492535522516, 7358.374538164236, 7376.557406555597, 7381.630918454082, 7395.149557800868, 7217.530860494051, 7273.272672732737, 7298.124225092996, 7312.780616581511, 7313.232110628387, 7739.342155916754, 7914.3668506519625, 7932.048154221501, 7932.365410767154, 7937.2459616336355, 7789.065312162548, 7819.6481158348015, 7864.056313242419, 7868.409869259828, 7875.015623047119, 7838.255365740246, 7913.6438860250855, 7920.049594048751, 7923.960380198062, 7925.682972681086, 41705.165896681894, 41949.58050419487, 41968.370474442905, 41972.37041444381, 42149.78925105386, 3486.494458303557, 3533.1873669056263, 3542.4332106863035, 3549.716022718176, 3549.804760738158, 33672.326553468796, 33725.83137084299, 33735.0, 33743.66256337454, 33789.0, 5007.324011258506, 5029.673071250357, 5050.267711181895, 5064.797408103672, 5069.670471419346, 215924.0, 219388.0, 219558.0, 221853.0, 222339.0, 55384.0, 55551.72224138934, 55794.442055578926, 55830.162547561005, 55888.0, 58349.416505835245, 58354.7082264586, 58429.0, 58437.70781146067, 58465.415345846, 16375.42686005984, 16504.917475412545, 16510.17449127539, 16511.669766604842, 16638.584035399213, 13292.268925209206, 13315.06794524374, 13322.933385333012, 13326.533571324957, 13327.666808329675, 15822.60443488922, 15945.20273986296, 16101.19494025294, 16196.514104576881, 16266.75599866003, 6021.939780602225, 6025.849353766191, 6111.51107911366, 6183.5671502994355, 6275.905861412082, 1100.3178029621527, 1105.9170562207867, 1107.2194103157256, 1114.793763153819, 1125.7185703574107, 25451.74548254531, 25470.0, 25828.483430331664, 25850.74149258521, 25933.22200333993, 1179.2393905930626, 1202.0, 1223.614561413152, 1224.2348532167396, 1239.603326935372, 13578.388972496261, 13751.518696845562, 13986.0, 13991.039435454482, 14042.0, 275851.0, 278033.0, 278919.0, 279415.0, 281376.0, 56627.71686141543, 57036.0, 57355.0, 57704.0, 57873.0, 1541.129261966985, 1551.9379224831107, 1591.9442819501494, 1611.798525184352, 1613.9757903631455, 24891.50216995686, 24946.12688555892, 24957.505949166767, 24985.0, 25239.873800630878, 40769.388459172544, 40910.79544602377, 40977.38533921934, 41009.38485922654, 41015.1796964065, 216259.0, 217127.0, 217659.0, 218790.0, 220103.0, 37475.625243747214, 41113.79443102765, 41730.1653966925, 41894.0, 42170.78914605407, 51241.0, 51825.74087129691, 51840.481595185076, 52001.7399912998, 52067.47932520627, 33955.66044339525, 34290.82854585711, 34541.30917381689, 34649.133771655914, 34840.0, 37403.625963740014, 37774.811125944194, 37934.0, 38058.61941380551, 38083.90538520297, 41776.37335440032, 43649.56350436582, 43783.562164377945, 43965.0, 44010.0, 35953.64046359608, 36057.459138113474, 36147.0, 36265.637343627284, 36734.44898326474, 27077.323066923484, 27275.045373411835, 27678.5848212281, 27954.720452795213, 28026.859865700542], "value": 18677.98694495135, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2030599302927, 602.3885755957704, 602.4427404650697, 611.4466407900849, 611.7247238742561, 24206.0, 24737.13420030297, 25619.74380256197, 25642.743572564268, 25672.101476448304, 27354.0, 27818.443631127364, 27878.163655090328, 27898.3025424364, 27900.860495697543, 6368.29948705642, 6532.836679083013, 6533.411992920636, 6559.278479367265, 6571.835704107411, 4465.441819772528, 4662.254039353704, 6165.845853853644, 6327.082573026908, 6397.072424498445, 6328.936710632881, 6338.556301058905, 6365.713542890581, 6372.362763723614, 6381.8085457436355, 6352.1107045013505, 6366.681665916685, 6372.107904893319, 6372.84067898304, 6374.872502549946, 5855.736491857877, 5924.170616113747, 5932.7330270137945, 5938.168656388109, 5946.256717910262, 32489.6751032489, 32915.177120571934, 33310.00069997904, 33692.83153584241, 33804.0, 2324.941876453085, 2347.460084180648, 2358.7287461941924, 2364.290712786157, 2365.1958334166466, 20574.897125514428, 20978.0, 20999.47501312464, 21000.789992100035, 21003.0, 2377.7978871795917, 2437.0617312334703, 2460.2373264288126, 2505.110685706566, 2515.421453065787, 157060.0, 164484.17757911253, 164885.0, 165280.0, 165346.0, 16455.177241137895, 16879.24043418049, 16881.15594220284, 17048.744268835977, 17220.1389930503, 26049.869750651127, 26114.477710446066, 26148.477030459286, 26163.476730465285, 26189.607155892678, 9920.255980801468, 10128.898711012796, 10248.23138264633, 10377.688669339781, 10414.271001029856, 8419.579021049045, 9094.772630684285, 9159.90840091604, 9178.586963586655, 9185.173334399937, 9204.447733136034, 10297.734498410338, 10322.432266225429, 10379.11777498921, 10440.895591043993, 2946.8673909674117, 2975.8809647614285, 3033.165879383143, 3042.6653068162486, 3130.733887619532, 1050.616524968381, 1069.2675517270695, 1071.9571217151383, 1072.570971611346, 1077.1382893685177, 25352.492950141263, 27048.0, 27251.199040767307, 27400.0, 28011.439771204463, 1114.0753174865006, 1120.047959234644, 1124.4714983957526, 1125.1055410948316, 1137.3062431916524, 12035.0, 12366.62900112998, 12459.875401245872, 12563.623091307276, 12608.81086783699, 565229.0, 568079.0, 577815.0, 579901.0, 584994.0, 129697.35151324183, 132659.0, 134244.0, 136638.0, 138359.30820346036, 1342.5703774792169, 1348.9190648561118, 1349.1163288046541, 1351.574254109952, 1371.91082579632, 20057.0, 20075.0, 20395.0, 20500.872452015283, 20561.691574626093, 63114.0, 63285.683571583686, 63551.682241588496, 64489.0, 64790.0, 81057.59471202607, 81175.18824811676, 81399.0, 81554.59222703849, 82742.17257827586, 15560.688786224438, 15694.058356498646, 15879.761803573187, 15886.126263055181, 16028.439004634782, 24880.62679059852, 24929.626055608816, 25009.499810003334, 25035.374115647253, 25250.873745631154, 18816.52958676044, 19095.23619055278, 19330.4200873974, 19376.709349359488, 19429.51426214356, 16563.83436165671, 17046.573835654206, 17195.570110747332, 17584.120793959995, 17621.823781762017, 20672.759634421982, 20777.68833467469, 20973.685394718785, 21024.474388140417, 21188.78811211868, 15594.610134746723, 15604.0, 15625.68748625044, 15630.9218453907, 15706.136162511171, 20174.89912550428, 20362.694559581916, 20497.69253461229, 20623.79376206219, 20638.38084857457], "value": 12976.733285700555, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.490063577112, 1437.6405898525368, 1472.0431719382407, 1489.605254607529, 1495.200067963639, 15349.846501534981, 16040.0, 16050.518484445485, 16069.357225710957, 16285.348586056572, 16261.430849920254, 16394.754078688828, 16495.257713402894, 16502.0, 16506.83493165068, 2999.7150270724246, 3043.193553708269, 3109.937801243974, 3111.626604807415, 3113.5485354623565, 2900.05748131858, 2968.1540760883154, 3000.354923691406, 3005.5341422079505, 3006.353633968696, 2994.4609970205356, 3003.564483149942, 3031.1058237819784, 3033.5449682547574, 3035.195673146618, 2946.6758656547763, 2953.114065780268, 2973.895913643034, 2975.821450712964, 2976.3154474470775, 2847.2027832207013, 2856.3573196030934, 2856.4001559672492, 2880.683124856264, 2881.2508747725533, 15182.544523664308, 15465.0, 15467.922660386626, 15484.225788710632, 15489.07065576069, 8582.055973842873, 8843.955780221058, 8886.066962968924, 8890.244329232022, 8898.288136949028, 5192.55863251624, 5378.650387724824, 5508.504234618904, 5512.062949298629, 5513.3108361454815, 1860.395371504253, 1877.2115711401245, 1891.886486810782, 1897.9905100474548, 1899.2972600137898, 27517.0, 27530.724692753018, 27847.0, 27875.303117422023, 27878.442431151467, 7459.701611935462, 7462.664180111908, 7495.550266983998, 7701.768946931601, 7709.4603377763015, 18353.449396518125, 18528.258869645062, 18533.907330463262, 18569.25722971093, 18578.907105464386, 8516.8722469163, 8647.697330593399, 8682.739517814476, 8682.91317086821, 8687.522186279815, 7823.413244006609, 7893.13175550689, 8084.231997960184, 8110.270075693216, 8114.756557303291, 5787.0, 5912.3496415394275, 5949.762009519571, 5968.761249550056, 6054.091886217015, 1680.6050578114134, 1690.7632931389614, 1701.140923833456, 1701.7111984380988, 1704.7783788107715, 962.6919385796477, 979.2313034268066, 987.4322264697828, 1005.9144972677258, 1007.078523151323, 9292.488913109844, 9518.428894266366, 10127.64553240633, 10180.389176649425, 10222.693319200436, 1048.5648455890873, 1091.7161538000178, 1096.550414330121, 1097.1003776903024, 1101.7025403141106, 5608.3247323730275, 5627.0, 5758.395368486333, 5830.825075247664, 5915.822525324247, 22563.661545076837, 22902.541949160925, 23067.76932230656, 23119.768802311763, 23348.299551013497, 23124.421889452897, 23306.7669323308, 23350.416239593807, 23405.06379744791, 23428.882855585955, 11454.0, 11944.940275298568, 12054.0, 12057.397130143458, 12262.080343974238, 9144.771380715536, 9306.44161350294, 9496.952515237379, 9500.144986951207, 9784.559694813894, 19287.0, 19911.303104391278, 20011.09950052222, 20443.38669839907, 20467.181312747325, 20511.38465846027, 20529.486762830453, 20626.381208563766, 20799.06404211784, 20965.37103886886, 12070.215435996632, 12338.938305308417, 12758.298293593942, 13027.08810383264, 13220.801687974496, 15091.396344146551, 15234.771478428054, 15240.847591523943, 15243.161626110226, 15250.0, 11308.0, 11348.943255283672, 11513.712157196138, 11607.419629018685, 11630.825537617111, 11584.536618535165, 11599.0, 11619.0, 11786.174967752175, 11981.161318707607, 9828.950855245677, 10344.431056291976, 10426.530806113591, 10622.946885265525, 10628.25602207838, 8171.591420429074, 8188.877166842383, 8191.262786349257, 8225.876611850947, 8316.209960053786, 8255.834883302421, 8295.419320647497, 8368.83262334762, 8381.371397145116, 8398.706045288385], "value": 7254.127470138579, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.3448523830449, 548.1366847215635, 558.9245451863998, 561.8876224755048, 567.809783722453, 6197.380261973801, 6214.184007394271, 6226.3462336454695, 6233.1273621693, 6257.5619706620555, 6145.754169833202, 6160.445559899608, 6160.507159427246, 6174.634824020908, 6177.629342239457, 4943.752812359386, 4949.133901567211, 4951.777170027357, 4954.529319714621, 4979.576735977446, 4708.411448568929, 4910.582600478946, 4921.753912304388, 4930.126551910269, 4968.229924361712, 4775.641826863, 4814.229723244282, 4816.109019831342, 4817.108834865544, 4819.566239038486, 4736.5026672199265, 4754.690945088558, 4789.760511974388, 4793.976030119845, 4821.108095002436, 4335.84824531143, 4337.327714204303, 4340.631046361063, 4341.131773645252, 4356.71681340715, 5911.615744976606, 5920.585559010871, 5928.970355148197, 5959.612625179349, 5973.924693555158, 5663.773449062032, 5774.595778295521, 5776.566757493205, 5784.421557844224, 5790.160426738142, 6378.904316435257, 6447.583405367292, 6511.38141876521, 6532.804015879484, 6567.799787071337, 4892.2661600760175, 4912.680675756064, 4973.452920178777, 4975.253711943237, 4989.55094041538, 6478.611283322968, 6637.634930078843, 6774.187097548276, 6798.76204332846, 6846.349596788297, 5087.821926232564, 5099.286099946011, 5109.923351149736, 5112.923306150411, 5158.045761534128, 5185.870353241124, 5193.272941788153, 5199.974000129975, 5200.739963001834, 5233.869153271199, 5636.887262254732, 5689.487946084872, 5698.373178950312, 5700.429957004267, 5753.712314384264, 6507.837304067436, 6528.281888992207, 6531.640759758164, 6571.507136964651, 6611.107500487469, 1785.5625371783997, 1786.580153663888, 1793.175139435848, 1793.2378739035858, 1800.774903137108, 1226.2397313665585, 1239.5971309324505, 1264.607971528829, 1272.63729836996, 1277.208130958793, 6174.567780255429, 6195.1636529068, 6195.628262304276, 6207.844803879939, 6225.420383279542, 6605.504587155982, 6609.405153536205, 6643.236027856762, 6694.765683201064, 6702.39678428934, 6082.665453400017, 6085.6044357117535, 6118.632882027093, 6145.231846019247, 6168.568200225941, 3495.632958539368, 3542.5748910130433, 3545.503629491873, 3564.413835843077, 3568.7145028397667, 6521.967390163114, 6768.7292508299115, 6783.796486105425, 6819.283975182633, 6868.484863635247, 6801.557898736566, 6818.352256535622, 6834.931650683529, 6847.897281540781, 6848.767221900106, 6716.447749855024, 6771.796846094625, 6820.829479262959, 6832.282610325944, 6854.108965834509, 6556.868862622816, 6580.144581204604, 6598.868022639616, 6610.933890661032, 6614.0, 6496.805095847132, 6507.707153178024, 6553.115329430466, 6591.472682185509, 6593.670316484253, 6612.338766123349, 6700.631465269457, 6759.493038022069, 6764.289749576224, 6771.28901465339, 5108.821191258288, 5122.282880396673, 5136.357955255593, 5138.563222126161, 5148.6910785353, 6337.429631333202, 6390.90413643805, 6611.404973552403, 6681.728212407805, 6735.393814556714, 6382.87234255303, 6400.751853388544, 6409.647469389229, 6486.481081513562, 6560.901586476111, 6339.936600634119, 6390.808275751735, 6400.967995159995, 6461.515386346136, 6565.606063636197, 6399.304618889099, 6404.903926441014, 6412.9679351602945, 6507.234425369104, 6544.345565443608, 6517.771877984248, 6532.5753826001155, 6535.673216339259, 6553.639549824806, 6581.934180658132, 6369.20384951881, 6392.616443013434, 6409.871802563829, 6422.6467544285515, 6433.774817881352], "value": 5080.945469843681, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.0303189231038, 948.8471507118849, 952.7665721898136, 975.2295686407738, 983.1544871410586, 19888.20447182113, 20473.897630511827, 20544.69182962255, 20548.48628784281, 21020.264290749827, 22045.669314960287, 22351.77648223517, 22426.43933901653, 22497.21259755909, 22498.88750556245, 1058.8570542976677, 1058.9894101058967, 1061.400308825515, 1062.8830828608848, 1063.702163394247, 1044.7544826965657, 1086.1907878630432, 1090.3893819461086, 1090.841827934949, 1096.9945150274239, 1154.2382027861613, 1154.5381847261121, 1156.6125348008427, 1158.0041164598438, 1161.6689243565586, 1139.242403801471, 1145.1468655851402, 1145.2384164530577, 1147.5753971030688, 1155.029774989009, 845.1337379186383, 847.635516727813, 848.1094850407048, 848.6393282854824, 849.5157760076759, 17008.744868826976, 17357.218925148398, 20601.278955236645, 20701.585968280702, 20815.5836883263, 21441.571168576542, 21728.89135554328, 21742.130314787388, 22088.88955555228, 22178.0, 16820.32718691251, 16892.239849206693, 16966.151692415453, 17059.0, 17363.826361736472, 3661.8901432957055, 3684.392075307571, 3721.5162028936334, 3722.1997270586953, 3753.6997040236715, 143252.2837385817, 143259.28370358187, 145079.2746036284, 145249.0, 145389.0, 15371.385144594315, 15877.920610396874, 15985.760213596805, 16002.439914603166, 16055.438059667855, 30685.539716904263, 32059.51910721341, 32176.0, 32240.19399514984, 32283.51574726381, 8566.571671416405, 8569.871451928226, 8613.870791938127, 8646.567671616394, 8668.133186681282, 4267.5732426757695, 4314.115606300701, 4364.236258654722, 4379.759113248738, 4387.956120438818, 5741.081426971748, 5826.533877289807, 5836.591438599342, 5846.619969701956, 5879.323877754027, 1049.8530205771199, 1062.0759938853248, 1072.0458791675414, 1082.7076689293847, 1083.6748975307376, 734.6804140199031, 744.6090802328713, 747.3684736397735, 766.1151370167465, 773.3156156801272, 12720.491180352683, 12799.744005119845, 12934.0, 12996.285204313854, 13231.073824832361, 748.831512909591, 756.5007095317064, 759.4607828441758, 760.7945854619222, 762.6415584675194, 5745.224394706661, 5756.0, 5839.824805255849, 5945.048792193228, 6021.759129634853, 127640.0, 128163.35918320535, 128416.0, 129285.0, 135636.32181839028, 111373.0, 112078.0, 114062.4296878527, 114600.0, 115749.0, 97639.51180244054, 98056.50971745096, 98625.0, 100934.49532752289, 103073.0, 11156.206889657555, 11223.38271395081, 11502.82745758831, 11702.35637039971, 11732.824007639721, 48843.5115648839, 48888.511114888395, 49672.0, 50034.99930001307, 50999.2350114756, 78549.0, 81893.59053204935, 82232.58883705543, 84115.0, 85505.57247213973, 18397.448076557725, 18422.0, 18652.160652770388, 18879.150438230587, 18946.810531894505, 21515.784842152003, 22101.66847497257, 22146.114155433603, 22395.552088957804, 22405.21581744631, 19911.900440498284, 20010.499737506678, 21010.2646407375, 21294.148234071083, 21422.678659820427, 20835.27076552374, 21403.250886219532, 21534.030968606763, 21710.67433988523, 21744.782552174907, 20557.0, 20946.47633809167, 21025.0, 21231.15075396967, 21279.468013299793, 13950.441982321, 14322.0, 14621.342039608457, 14705.558833234592, 14796.704065918406, 15996.68006639884, 16051.03693778377, 16310.59223519374, 16474.42339518111, 16861.494155175365], "value": 9904.18617423032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 94.0, 106.0, 106.0, 108.0, 109.0, 105.0, 107.0, 108.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 148.0, 162.0, 112.0, 150.0, 138.0, 115.0, 163.0, 113.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 166.0, 162.0, 161.0, 161.0, 162.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 189.0, 74.0, 76.0, 73.0, 76.0, 163.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 129.0, 77.0, 78.0, 78.0, 129.0, 78.0, 78.0, 128.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 56.0, 44.0, 45.0, 46.0, 44.0, 45.0, 47.0, 45.0, 45.0], "value": 46.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 76.0, 73.0, 75.0, 73.0, 74.0, 72.0, 74.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 126.0, 117.0, 115.0, 118.0, 118.0, 128.0, 117.0, 149.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 161.0, 170.0, 161.0, 158.0, 158.0, 159.0, 163.0, 164.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 60.0, 59.0, 62.0, 59.0, 58.0, 58.0, 59.0, 61.0, 59.0], "value": 60.7, "unit": "score"}]}]} 11:48:43 INFO - Return code: 0 11:48:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:48:43 INFO - # TBPL SUCCESS # 11:48:43 INFO - Running post-action listener: _package_coverage_data 11:48:43 INFO - Running post-action listener: _resource_record_post_action 11:48:43 INFO - [mozharness: 2017-08-14 18:48:43.163213Z] Finished run-tests step (success) 11:48:43 INFO - Running post-run listener: _resource_record_post_run 11:48:43 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 196608; Write bytes: 368513024; Read time: 96; Write time: 293536 11:48:43 INFO - TinderboxPrint: CPU usage
13.0% 11:48:43 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 96 11:48:43 INFO - TinderboxPrint: I/O write bytes / time
368,513,024 / 293,536 11:48:43 INFO - TinderboxPrint: CPU idle
8,204.7 (87.0%) 11:48:43 INFO - TinderboxPrint: CPU user
1,179.6 (12.5%) 11:48:43 INFO - TinderboxPrint: Swap in / out
0 / 0 11:48:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 98459648; Read time: 0; Write time: 101404 11:48:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:48:43 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 192512; Write bytes: 269660160; Read time: 56; Write time: 192076 11:48:43 INFO - Running post-run listener: _upload_blobber_files 11:48:43 INFO - Blob upload gear active. 11:48:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:48:43 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 11:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:48:44 INFO - (blobuploader) - INFO - Open directory for files ... 11:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:48:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:48:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:45 INFO - (blobuploader) - INFO - Done attempting. 11:48:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:48:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:48:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:48 INFO - (blobuploader) - INFO - Done attempting. 11:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:49 INFO - (blobuploader) - INFO - Done attempting. 11:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:48:49 INFO - (blobuploader) - INFO - Done attempting. 11:48:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:48:49 INFO - Return code: 0 11:48:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:48:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:48:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/054fc15267931d03e80d84fd187935db35741ca854e0a0c1f78723f5dc8b1afdc57aa32fefc3649c7b469c2ffea0aa5d0e59067bf09c9ca76aeafe50be4494ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03e43d3691ba7c8359bd402851fada4135093d7a15eb57ec66b010b717572e74142a48820eefaddd8a5c894339e76d553a65bcca7448a332f2ca3480504976f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06d66d507eb29c1341a23c886dc9ee58d1220238a3c96cbcb60e8314ace6a0229bfe4789d6d9229b867c70222680fb4cf419340e739cde29639204d985b20022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/621d8922eb8a6665f700f8595c63f1cb16f2bcbcc7f9dd051ad87054837df83d96962c8a96a5a04d9ae6d1cfcf5963e1a1244dbd50e22b263b38e82119976a77"} 11:48:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:48:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:48:49 INFO - Contents: 11:48:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/054fc15267931d03e80d84fd187935db35741ca854e0a0c1f78723f5dc8b1afdc57aa32fefc3649c7b469c2ffea0aa5d0e59067bf09c9ca76aeafe50be4494ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03e43d3691ba7c8359bd402851fada4135093d7a15eb57ec66b010b717572e74142a48820eefaddd8a5c894339e76d553a65bcca7448a332f2ca3480504976f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06d66d507eb29c1341a23c886dc9ee58d1220238a3c96cbcb60e8314ace6a0229bfe4789d6d9229b867c70222680fb4cf419340e739cde29639204d985b20022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/621d8922eb8a6665f700f8595c63f1cb16f2bcbcc7f9dd051ad87054837df83d96962c8a96a5a04d9ae6d1cfcf5963e1a1244dbd50e22b263b38e82119976a77"} 11:48:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:48:49 INFO - Copying logs to upload dir... 11:48:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:48:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.070448 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-08-14 11:48:49.841811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 11:48:49.849838) ========= 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=1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/054fc15267931d03e80d84fd187935db35741ca854e0a0c1f78723f5dc8b1afdc57aa32fefc3649c7b469c2ffea0aa5d0e59067bf09c9ca76aeafe50be4494ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03e43d3691ba7c8359bd402851fada4135093d7a15eb57ec66b010b717572e74142a48820eefaddd8a5c894339e76d553a65bcca7448a332f2ca3480504976f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06d66d507eb29c1341a23c886dc9ee58d1220238a3c96cbcb60e8314ace6a0229bfe4789d6d9229b867c70222680fb4cf419340e739cde29639204d985b20022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/621d8922eb8a6665f700f8595c63f1cb16f2bcbcc7f9dd051ad87054837df83d96962c8a96a5a04d9ae6d1cfcf5963e1a1244dbd50e22b263b38e82119976a77"} build_url:https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/Kuf16ZkASTackq3doCbfzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/054fc15267931d03e80d84fd187935db35741ca854e0a0c1f78723f5dc8b1afdc57aa32fefc3649c7b469c2ffea0aa5d0e59067bf09c9ca76aeafe50be4494ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03e43d3691ba7c8359bd402851fada4135093d7a15eb57ec66b010b717572e74142a48820eefaddd8a5c894339e76d553a65bcca7448a332f2ca3480504976f6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/06d66d507eb29c1341a23c886dc9ee58d1220238a3c96cbcb60e8314ace6a0229bfe4789d6d9229b867c70222680fb4cf419340e739cde29639204d985b20022", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/621d8922eb8a6665f700f8595c63f1cb16f2bcbcc7f9dd051ad87054837df83d96962c8a96a5a04d9ae6d1cfcf5963e1a1244dbd50e22b263b38e82119976a77"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 11:48:49.878796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:48:49.879117) ========= 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=1f5564757af27664ca02d71f000001b0-1502734168.386432-1639216219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:48:49.960015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 11:48:49.960299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 11:48:49.963581) ========= ========= Total master_lag: 0.13 =========