builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1502994380.14 results: success (0) revision: 933e3d98fb65f36c129ed3dc625c84636c42581c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.138457) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.139002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.139288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.153590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.153925) ========= 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=781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:26:20-- 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% 215M=0s 2017-08-17 11:26:20 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.073651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.246183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.246506) ========= 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=781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014233 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:20.295652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:26:20.299029) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 933e3d98fb65f36c129ed3dc625c84636c42581c --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 933e3d98fb65f36c129ed3dc625c84636c42581c --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=781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:26:20,834 truncating revision to first 12 chars 2017-08-17 11:26:20,834 Setting DEBUG logging. 2017-08-17 11:26:20,834 attempt 1/10 2017-08-17 11:26:20,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/933e3d98fb65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 11:26:21,985 unpacking tar archive at: mozilla-beta-933e3d98fb65/testing/mozharness/ program finished with exit code 0 elapsedTime=1.564724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:26:21.877654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:21.878070) ========= script_repo_revision: 933e3d98fb65f36c129ed3dc625c84636c42581c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:21.878467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:21.878743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:26:21.894379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-17 11:26:21.894685) ========= /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=781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:22 INFO - MultiFileLogger online at 20170817 11:26:22 in /builds/slave/test 11:26:22 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:26:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:22 INFO - {'append_to_log': False, 11:26:22 INFO - 'base_work_dir': '/builds/slave/test', 11:26:22 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:26:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:22 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:26:22 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:22 INFO - 'code_coverage': False, 11:26:22 INFO - 'config_files': ('talos/linux_config.py',), 11:26:22 INFO - 'default_actions': ('clobber', 11:26:22 INFO - 'read-buildbot-config', 11:26:22 INFO - 'download-and-extract', 11:26:22 INFO - 'populate-webroot', 11:26:22 INFO - 'create-virtualenv', 11:26:22 INFO - 'install', 11:26:22 INFO - 'setup-mitmproxy', 11:26:22 INFO - 'run-tests'), 11:26:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:22 INFO - 'disable_ccov_upload': False, 11:26:22 INFO - 'download_minidump_stackwalk': True, 11:26:22 INFO - 'download_symbols': 'ondemand', 11:26:22 INFO - 'enable_stylo': False, 11:26:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:22 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:22 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:22 INFO - 'gecko_profile': False, 11:26:22 INFO - 'gecko_profile_interval': 0, 11:26:22 INFO - 'installer_path': 'installer.exe', 11:26:22 INFO - 'log_level': 'info', 11:26:22 INFO - 'log_name': 'talos', 11:26:22 INFO - 'log_to_console': True, 11:26:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:22 INFO - 'opt_config_files': (), 11:26:22 INFO - 'pip_index': False, 11:26:22 INFO - 'suite': 'dromaeojs-e10s', 11:26:22 INFO - 'system_bits': '32', 11:26:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:22 INFO - 'title': 'talos-linux64-ix-080', 11:26:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:22 INFO - 'use_talos_json': True, 11:26:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:22 INFO - 'work_dir': 'build'} 11:26:22 INFO - [mozharness: 2017-08-17 18:26:22.535584Z] Running clobber step. 11:26:22 INFO - Running pre-action listener: _resource_record_pre_action 11:26:22 INFO - Running main action method: clobber 11:26:22 INFO - rmtree: /builds/slave/test/build 11:26:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:23 INFO - Running post-action listener: _resource_record_post_action 11:26:23 INFO - [mozharness: 2017-08-17 18:26:23.589393Z] Finished clobber step (success) 11:26:23 INFO - [mozharness: 2017-08-17 18:26:23.589497Z] Running read-buildbot-config step. 11:26:23 INFO - Running pre-action listener: _resource_record_pre_action 11:26:23 INFO - Running main action method: read_buildbot_config 11:26:23 INFO - Using buildbot properties: 11:26:23 INFO - { 11:26:23 INFO - "project": "", 11:26:23 INFO - "product": "firefox", 11:26:23 INFO - "who": "ffxbld@noreply.mozilla.org", 11:26:23 INFO - "installer_path": "public/build/target.tar.bz2", 11:26:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:26:23 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:26:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:26:23 INFO - "stage_platform": "linux64", 11:26:23 INFO - "basedir": "/builds/slave/test", 11:26:23 INFO - "buildnumber": 52, 11:26:23 INFO - "platform": "ubuntu64_hw", 11:26:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:26:23 INFO - "slavebuilddir": "test", 11:26:23 INFO - "taskId": "Sn692x6CTp24a2emdKuZeQ", 11:26:23 INFO - "branch": "mozilla-beta", 11:26:23 INFO - "script_repo_revision": "production", 11:26:23 INFO - "revision": "933e3d98fb65f36c129ed3dc625c84636c42581c", 11:26:23 INFO - "slavename": "talos-linux64-ix-080", 11:26:23 INFO - "repo_path": "releases/mozilla-beta" 11:26:23 INFO - } 11:26:23 INFO - Finding installer, test and symbols from parent task. 11:26:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sn692x6CTp24a2emdKuZeQ'}, attempt #1 11:26:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sn692x6CTp24a2emdKuZeQ'}, attempt #1 11:26:24 INFO - Task dependencies: IDjId5HVRCe09dNm3x4RLg 11:26:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg'}, attempt #1 11:26:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2 11:26:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.test_packages.json 11:26:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.crashreporter-symbols.zip 11:26:25 INFO - Running post-action listener: _resource_record_post_action 11:26:25 INFO - [mozharness: 2017-08-17 18:26:25.088716Z] Finished read-buildbot-config step (success) 11:26:25 INFO - [mozharness: 2017-08-17 18:26:25.088940Z] Running download-and-extract step. 11:26:25 INFO - Running pre-action listener: _resource_record_pre_action 11:26:25 INFO - Running main action method: download_and_extract 11:26:25 INFO - mkdir: /builds/slave/test/build/tests 11:26:25 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:26:25 INFO - trying https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.test_packages.json 11:26:25 INFO - Downloading https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:26:25 INFO - Downloaded 989 bytes. 11:26:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:26:25 INFO - Using the following test package requirements: 11:26:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:26:25 INFO - u'common': [u'target.common.tests.zip'], 11:26:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:26:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:26:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:26:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:26:25 INFO - u'mozbase': [u'target.common.tests.zip'], 11:26:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:26:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:26:25 INFO - u'web-platform': [u'target.common.tests.zip', 11:26:25 INFO - u'target.web-platform.tests.tar.gz'], 11:26:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:26:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:26:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.common.tests.zip 11:26:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:26:25 INFO - Fetch https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.common.tests.zip into memory 11:26:27 INFO - Content-Length response header: 72856428 11:26:27 INFO - Bytes received: 72856428 11:26:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:26:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.common.tests.zip 11:26:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:26:38 INFO - Fetch https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.common.tests.zip into memory 11:26:39 INFO - Content-Length response header: 72856428 11:26:39 INFO - Bytes received: 72856428 11:26:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.talos.tests.zip 11:26:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:26:51 INFO - Fetch https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.talos.tests.zip into memory 11:26:52 INFO - Content-Length response header: 14496472 11:26:52 INFO - Bytes received: 14496472 11:26:52 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:26:52 INFO - trying https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2 11:26:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:26:53 INFO - Downloaded 53757849 bytes. 11:26:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2 11:26:53 INFO - mkdir: /builds/slave/test/properties 11:26:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:53 INFO - Contents: 11:26:53 INFO - build_url:https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2 11:26:53 INFO - Running post-action listener: _resource_record_post_action 11:26:53 INFO - Running post-action listener: set_extra_try_arguments 11:26:53 INFO - [mozharness: 2017-08-17 18:26:53.853841Z] Finished download-and-extract step (success) 11:26:53 INFO - [mozharness: 2017-08-17 18:26:53.853940Z] Running populate-webroot step. 11:26:53 INFO - Running pre-action listener: _resource_record_pre_action 11:26:53 INFO - Running main action method: populate_webroot 11:26:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:26:53 INFO - 'tests': ['damp', 'tps']}, 11:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:26:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:26:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:26:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:53 INFO - 'ts_paint', 11:26:53 INFO - 'tpaint', 11:26:53 INFO - 'sessionrestore', 11:26:53 INFO - 'sessionrestore_many_windows', 11:26:53 INFO - 'sessionrestore_no_auto_restore', 11:26:53 INFO - 'tabpaint']}, 11:26:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:26:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:26:53 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:53 INFO - 'talos_options': ['--mitmproxy', 11:26:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:53 INFO - '--firstNonBlankPaint'], 11:26:53 INFO - 'tests': ['quantum_pageload_google', 11:26:53 INFO - 'quantum_pageload_youtube', 11:26:53 INFO - 'quantum_pageload_amazon', 11:26:53 INFO - 'quantum_pageload_facebook']}, 11:26:53 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:53 INFO - 'talos_options': ['--stylo', 11:26:53 INFO - '--mitmproxy', 11:26:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:53 INFO - '--firstNonBlankPaint'], 11:26:53 INFO - 'tests': ['quantum_pageload_google', 11:26:53 INFO - 'quantum_pageload_youtube', 11:26:53 INFO - 'quantum_pageload_amazon', 11:26:53 INFO - 'quantum_pageload_facebook']}, 11:26:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:53 INFO - 'tsvgr_opacity', 11:26:53 INFO - 'tart', 11:26:53 INFO - 'tscrollx', 11:26:53 INFO - 'cart', 11:26:53 INFO - 'tsvg_static']}, 11:26:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:26:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:53 INFO - 'talos_options': ['--stylo', 11:26:53 INFO - '--stylo-threads=1', 11:26:53 INFO - '--mitmproxy', 11:26:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:53 INFO - '--firstNonBlankPaint'], 11:26:53 INFO - 'tests': ['tp6_google', 11:26:53 INFO - 'tp6_youtube', 11:26:53 INFO - 'tp6_amazon', 11:26:53 INFO - 'tp6_facebook']}, 11:26:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:26:53 INFO - 'talos_options': ['--xperf_path', 11:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:53 INFO - 'tests': ['tp5n']}}} 11:26:53 INFO - Running post-action listener: _resource_record_post_action 11:26:53 INFO - [mozharness: 2017-08-17 18:26:53.862702Z] Finished populate-webroot step (success) 11:26:53 INFO - [mozharness: 2017-08-17 18:26:53.862793Z] Running create-virtualenv step. 11:26:53 INFO - Running pre-action listener: _resource_record_pre_action 11:26:53 INFO - Running main action method: create_virtualenv 11:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:53 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:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:53 INFO - Using real prefix '/usr' 11:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:56 INFO - Installing pip.................done. 11:26:56 INFO - Return code: 0 11:26:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:26:56 INFO - Reading from file tmpfile_stdout 11:26:56 INFO - Output received: 11:26:56 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:26:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:56 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:26:56 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:26:56 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:26:56 INFO - Using env: {'DISPLAY': ':0', 11:26:56 INFO - 'HOME': '/home/cltbld', 11:26:56 INFO - 'LANG': 'en_US.UTF-8', 11:26:56 INFO - 'LANGUAGE': 'en_US:en', 11:26:56 INFO - 'LOGNAME': 'cltbld', 11:26:56 INFO - 'MAIL': '/var/mail/cltbld', 11:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:56 INFO - 'MOZ_NO_REMOTE': '1', 11:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:56 INFO - 'NO_EM_RESTART': '1', 11:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:56 INFO - 'PWD': '/builds/slave/test', 11:26:56 INFO - 'SHELL': '/bin/bash', 11:26:56 INFO - 'SHLVL': '1', 11:26:56 INFO - 'TERM': 'linux', 11:26:56 INFO - 'TMOUT': '86400', 11:26:56 INFO - 'USER': 'cltbld', 11:26:56 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:56 INFO - '_': '/tools/buildbot/bin/python'} 11:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:56 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:26:56 INFO - Cleaning up... 11:26:56 INFO - Return code: 0 11:26:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:56 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:26:56 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:26:56 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:26:56 INFO - Using env: {'DISPLAY': ':0', 11:26:56 INFO - 'HOME': '/home/cltbld', 11:26:56 INFO - 'LANG': 'en_US.UTF-8', 11:26:56 INFO - 'LANGUAGE': 'en_US:en', 11:26:56 INFO - 'LOGNAME': 'cltbld', 11:26:56 INFO - 'MAIL': '/var/mail/cltbld', 11:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:56 INFO - 'MOZ_NO_REMOTE': '1', 11:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:56 INFO - 'NO_EM_RESTART': '1', 11:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:56 INFO - 'PWD': '/builds/slave/test', 11:26:56 INFO - 'SHELL': '/bin/bash', 11:26:56 INFO - 'SHLVL': '1', 11:26:56 INFO - 'TERM': 'linux', 11:26:56 INFO - 'TMOUT': '86400', 11:26:56 INFO - 'USER': 'cltbld', 11:26:56 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:56 INFO - '_': '/tools/buildbot/bin/python'} 11:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:57 INFO - Downloading/unpacking psutil>=3.1.1 11:26: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:26: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:26: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:26: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:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:58 INFO - Installing collected packages: psutil 11:26:58 INFO - Running setup.py install for psutil 11:26:58 INFO - building 'psutil._psutil_linux' extension 11:26:58 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:26:58 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:26:58 INFO - building 'psutil._psutil_posix' extension 11:26:58 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:26:58 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:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:58 INFO - Successfully installed psutil 11:26:58 INFO - Cleaning up... 11:26:58 INFO - Return code: 0 11:26:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:26:58 INFO - Using env: {'DISPLAY': ':0', 11:26:58 INFO - 'HOME': '/home/cltbld', 11:26:58 INFO - 'LANG': 'en_US.UTF-8', 11:26:58 INFO - 'LANGUAGE': 'en_US:en', 11:26:58 INFO - 'LOGNAME': 'cltbld', 11:26:58 INFO - 'MAIL': '/var/mail/cltbld', 11:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:58 INFO - 'MOZ_NO_REMOTE': '1', 11:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:58 INFO - 'NO_EM_RESTART': '1', 11:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:58 INFO - 'PWD': '/builds/slave/test', 11:26:58 INFO - 'SHELL': '/bin/bash', 11:26:58 INFO - 'SHLVL': '1', 11:26:58 INFO - 'TERM': 'linux', 11:26:58 INFO - 'TMOUT': '86400', 11:26:58 INFO - 'USER': 'cltbld', 11:26:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:58 INFO - '_': '/tools/buildbot/bin/python'} 11:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:27:00 INFO - Installing collected packages: mozsystemmonitor 11:27:00 INFO - Running setup.py install for mozsystemmonitor 11:27:00 INFO - Successfully installed mozsystemmonitor 11:27:00 INFO - Cleaning up... 11:27:00 INFO - Return code: 0 11:27:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:00 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:00 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:27:00 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:27:00 INFO - Using env: {'DISPLAY': ':0', 11:27:00 INFO - 'HOME': '/home/cltbld', 11:27:00 INFO - 'LANG': 'en_US.UTF-8', 11:27:00 INFO - 'LANGUAGE': 'en_US:en', 11:27:00 INFO - 'LOGNAME': 'cltbld', 11:27:00 INFO - 'MAIL': '/var/mail/cltbld', 11:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:00 INFO - 'MOZ_NO_REMOTE': '1', 11:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:00 INFO - 'NO_EM_RESTART': '1', 11:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:00 INFO - 'PWD': '/builds/slave/test', 11:27:00 INFO - 'SHELL': '/bin/bash', 11:27:00 INFO - 'SHLVL': '1', 11:27:00 INFO - 'TERM': 'linux', 11:27:00 INFO - 'TMOUT': '86400', 11:27:00 INFO - 'USER': 'cltbld', 11:27:00 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:00 INFO - '_': '/tools/buildbot/bin/python'} 11:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:00 INFO - Downloading/unpacking jsonschema==2.5.1 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:02 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:02 INFO - warning: no files found matching '*.txt' 11:27:02 INFO - no previously-included directories found matching 'build' 11:27:02 INFO - no previously-included directories found matching 'dist' 11:27:02 INFO - no previously-included directories found matching '.git*' 11:27:02 INFO - Installing collected packages: jsonschema, functools32 11:27:02 INFO - Running setup.py install for functools32 11:27:02 INFO - warning: no files found matching '*.txt' 11:27:02 INFO - no previously-included directories found matching 'build' 11:27:02 INFO - no previously-included directories found matching 'dist' 11:27:02 INFO - no previously-included directories found matching '.git*' 11:27:03 INFO - Successfully installed jsonschema functools32 11:27:03 INFO - Cleaning up... 11:27:03 INFO - Return code: 0 11:27:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:27:03 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:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:03 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:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:03 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:03 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:27:03 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:27:03 INFO - Using env: {'DISPLAY': ':0', 11:27:03 INFO - 'HOME': '/home/cltbld', 11:27:03 INFO - 'LANG': 'en_US.UTF-8', 11:27:03 INFO - 'LANGUAGE': 'en_US:en', 11:27:03 INFO - 'LOGNAME': 'cltbld', 11:27:03 INFO - 'MAIL': '/var/mail/cltbld', 11:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:03 INFO - 'MOZ_NO_REMOTE': '1', 11:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:03 INFO - 'NO_EM_RESTART': '1', 11:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:03 INFO - 'PWD': '/builds/slave/test', 11:27:03 INFO - 'SHELL': '/bin/bash', 11:27:03 INFO - 'SHLVL': '1', 11:27:03 INFO - 'TERM': 'linux', 11:27:03 INFO - 'TMOUT': '86400', 11:27:03 INFO - 'USER': 'cltbld', 11:27:03 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:03 INFO - '_': '/tools/buildbot/bin/python'} 11:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:27:03 INFO - Cleaning up... 11:27:03 INFO - Return code: 0 11:27:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:27:03 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:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:03 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:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:03 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:03 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:27:03 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:27:03 INFO - Using env: {'DISPLAY': ':0', 11:27:03 INFO - 'HOME': '/home/cltbld', 11:27:03 INFO - 'LANG': 'en_US.UTF-8', 11:27:03 INFO - 'LANGUAGE': 'en_US:en', 11:27:03 INFO - 'LOGNAME': 'cltbld', 11:27:03 INFO - 'MAIL': '/var/mail/cltbld', 11:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:03 INFO - 'MOZ_NO_REMOTE': '1', 11:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:03 INFO - 'NO_EM_RESTART': '1', 11:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:03 INFO - 'PWD': '/builds/slave/test', 11:27:03 INFO - 'SHELL': '/bin/bash', 11:27:03 INFO - 'SHLVL': '1', 11:27:03 INFO - 'TERM': 'linux', 11:27:03 INFO - 'TMOUT': '86400', 11:27:03 INFO - 'USER': 'cltbld', 11:27:03 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:03 INFO - '_': '/tools/buildbot/bin/python'} 11:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:27:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:27:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:05 INFO - Downloading docopt-0.6.1.tar.gz 11:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:05 INFO - Running setup.py install for blobuploader 11:27:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:27:05 INFO - Running setup.py install for requests 11:27:05 INFO - Running setup.py install for docopt 11:27:05 INFO - Successfully installed blobuploader requests docopt 11:27:05 INFO - Cleaning up... 11:27:05 INFO - Return code: 0 11:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:05 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:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:05 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:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:05 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:05 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:27:05 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:27:05 INFO - Using env: {'DISPLAY': ':0', 11:27:05 INFO - 'HOME': '/home/cltbld', 11:27:05 INFO - 'LANG': 'en_US.UTF-8', 11:27:05 INFO - 'LANGUAGE': 'en_US:en', 11:27:05 INFO - 'LOGNAME': 'cltbld', 11:27:05 INFO - 'MAIL': '/var/mail/cltbld', 11:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:05 INFO - 'MOZ_NO_REMOTE': '1', 11:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:05 INFO - 'NO_EM_RESTART': '1', 11:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:05 INFO - 'PWD': '/builds/slave/test', 11:27:05 INFO - 'SHELL': '/bin/bash', 11:27:05 INFO - 'SHLVL': '1', 11:27:05 INFO - 'TERM': 'linux', 11:27:05 INFO - 'TMOUT': '86400', 11:27:05 INFO - 'USER': 'cltbld', 11:27:05 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:05 INFO - '_': '/tools/buildbot/bin/python'} 11:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:05 INFO - Running setup.py (path:/tmp/pip-H_uk7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:06 INFO - Running setup.py (path:/tmp/pip-9w93bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:06 INFO - Running setup.py (path:/tmp/pip-eZ3Rx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:06 INFO - Running setup.py (path:/tmp/pip-wjmsBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:06 INFO - Running setup.py (path:/tmp/pip-fgW3gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:06 INFO - Running setup.py (path:/tmp/pip-DJLisZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:06 INFO - Running setup.py (path:/tmp/pip-f6jx5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:06 INFO - Running setup.py (path:/tmp/pip-VpDO_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:06 INFO - Running setup.py (path:/tmp/pip-jGdgCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:06 INFO - Running setup.py (path:/tmp/pip-qZpxdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:06 INFO - Running setup.py (path:/tmp/pip-X259eW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:06 INFO - Running setup.py (path:/tmp/pip-b8_IvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:06 INFO - Running setup.py (path:/tmp/pip-3_1Gio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:06 INFO - Running setup.py (path:/tmp/pip-DqC976-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:07 INFO - Running setup.py (path:/tmp/pip-tlijCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:07 INFO - Running setup.py (path:/tmp/pip-M8_fbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:07 INFO - Running setup.py (path:/tmp/pip-zkRetQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:07 INFO - Running setup.py install for manifestparser 11:27:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Running setup.py install for mozcrash 11:27:07 INFO - Running setup.py install for mozdebug 11:27:07 INFO - Running setup.py install for mozdevice 11:27:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Running setup.py install for mozfile 11:27:07 INFO - Running setup.py install for mozhttpd 11:27:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Running setup.py install for mozinfo 11:27:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Running setup.py install for mozInstall 11:27:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:07 INFO - Running setup.py install for mozleak 11:27:08 INFO - Running setup.py install for mozlog 11:27:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Running setup.py install for moznetwork 11:27:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Running setup.py install for mozprocess 11:27:08 INFO - Running setup.py install for mozprofile 11:27:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Running setup.py install for mozrunner 11:27:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Running setup.py install for mozscreenshot 11:27:08 INFO - Running setup.py install for moztest 11:27:08 INFO - Running setup.py install for mozversion 11:27:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:08 INFO - Cleaning up... 11:27:08 INFO - Return code: 0 11:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:08 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:08 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:27:08 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:27:08 INFO - Using env: {'DISPLAY': ':0', 11:27:08 INFO - 'HOME': '/home/cltbld', 11:27:08 INFO - 'LANG': 'en_US.UTF-8', 11:27:08 INFO - 'LANGUAGE': 'en_US:en', 11:27:08 INFO - 'LOGNAME': 'cltbld', 11:27:08 INFO - 'MAIL': '/var/mail/cltbld', 11:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:08 INFO - 'MOZ_NO_REMOTE': '1', 11:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:08 INFO - 'NO_EM_RESTART': '1', 11:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:08 INFO - 'PWD': '/builds/slave/test', 11:27:08 INFO - 'SHELL': '/bin/bash', 11:27:08 INFO - 'SHLVL': '1', 11:27:08 INFO - 'TERM': 'linux', 11:27:08 INFO - 'TMOUT': '86400', 11:27:08 INFO - 'USER': 'cltbld', 11:27:08 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:08 INFO - '_': '/tools/buildbot/bin/python'} 11:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:09 INFO - Running setup.py (path:/tmp/pip-4Scp0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:09 INFO - Running setup.py (path:/tmp/pip-Iyx0XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:09 INFO - Running setup.py (path:/tmp/pip-5U2GOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:09 INFO - Running setup.py (path:/tmp/pip-tP3Egl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:09 INFO - Running setup.py (path:/tmp/pip-aDnTeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:09 INFO - Running setup.py (path:/tmp/pip-_GTM3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:09 INFO - Running setup.py (path:/tmp/pip-iHDlHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:09 INFO - Running setup.py (path:/tmp/pip-9cpN0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:09 INFO - Running setup.py (path:/tmp/pip-IAUOp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:09 INFO - Running setup.py (path:/tmp/pip-KmR9Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:09 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:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:09 INFO - Running setup.py (path:/tmp/pip-pZomwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:10 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:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:10 INFO - Running setup.py (path:/tmp/pip-GQzO5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:10 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:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:10 INFO - Running setup.py (path:/tmp/pip-_6CFoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:10 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:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:10 INFO - Running setup.py (path:/tmp/pip-ODMX8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:10 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:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:10 INFO - Running setup.py (path:/tmp/pip-eexKqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:10 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:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:10 INFO - Running setup.py (path:/tmp/pip-VvDK_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:10 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:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:10 INFO - Running setup.py (path:/tmp/pip-LiubTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:10 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:27:10 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:27:10 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:27:10 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:27:10 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:27:10 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:27:10 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:27:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27:10 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:27:10 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:27:10 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:27:10 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:27:11 INFO - Downloading blessings-1.6.tar.gz 11:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:11 INFO - Installing collected packages: blessings 11:27:11 INFO - Running setup.py install for blessings 11:27:11 INFO - Successfully installed blessings 11:27:11 INFO - Cleaning up... 11:27:11 INFO - Return code: 0 11:27:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:11 INFO - Reading from file tmpfile_stdout 11:27:11 INFO - Current package versions: 11:27:11 INFO - argparse == 1.2.1 11:27:11 INFO - blessings == 1.6 11:27:11 INFO - blobuploader == 1.2.4 11:27:11 INFO - docopt == 0.6.1 11:27:11 INFO - functools32 == 3.2.3-2 11:27:11 INFO - jsonschema == 2.5.1 11:27:11 INFO - manifestparser == 1.1 11:27:11 INFO - mozInstall == 1.13 11:27:11 INFO - mozcrash == 1.0 11:27:11 INFO - mozdebug == 0.1 11:27:11 INFO - mozdevice == 0.51 11:27:11 INFO - mozfile == 1.2 11:27:11 INFO - mozhttpd == 0.7 11:27:11 INFO - mozinfo == 0.10 11:27:11 INFO - mozleak == 0.1 11:27:11 INFO - mozlog == 3.5 11:27:11 INFO - moznetwork == 0.27 11:27:11 INFO - mozprocess == 0.25 11:27:11 INFO - mozprofile == 0.28 11:27:11 INFO - mozrunner == 6.13 11:27:11 INFO - mozscreenshot == 0.1 11:27:11 INFO - mozsystemmonitor == 0.3 11:27:11 INFO - moztest == 0.8 11:27:11 INFO - mozversion == 1.4 11:27:11 INFO - psutil == 3.1.1 11:27:11 INFO - requests == 1.2.3 11:27:11 INFO - wsgiref == 0.1.2 11:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:11 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:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:11 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:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:12 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:12 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:27:12 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:27:12 INFO - Using env: {'DISPLAY': ':0', 11:27:12 INFO - 'HOME': '/home/cltbld', 11:27:12 INFO - 'LANG': 'en_US.UTF-8', 11:27:12 INFO - 'LANGUAGE': 'en_US:en', 11:27:12 INFO - 'LOGNAME': 'cltbld', 11:27:12 INFO - 'MAIL': '/var/mail/cltbld', 11:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:12 INFO - 'MOZ_NO_REMOTE': '1', 11:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:12 INFO - 'NO_EM_RESTART': '1', 11:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:12 INFO - 'PWD': '/builds/slave/test', 11:27:12 INFO - 'SHELL': '/bin/bash', 11:27:12 INFO - 'SHLVL': '1', 11:27:12 INFO - 'TERM': 'linux', 11:27:12 INFO - 'TMOUT': '86400', 11:27:12 INFO - 'USER': 'cltbld', 11:27:12 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:12 INFO - '_': '/tools/buildbot/bin/python'} 11:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:27:12 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:27:12 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:27:12 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:27:12 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:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:27:13 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:27:13 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:27:13 INFO - Installing collected packages: simplejson 11:27:13 INFO - Running setup.py install for simplejson 11:27:13 INFO - building 'simplejson._speedups' extension 11:27:13 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:27:14 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:27:14 INFO - Successfully installed simplejson 11:27:14 INFO - Cleaning up... 11:27:14 INFO - Return code: 0 11:27:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27: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:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27: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:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:14 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 0x1b281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e97eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, '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': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', '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:27:14 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:27:14 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:27:14 INFO - Using env: {'DISPLAY': ':0', 11:27:14 INFO - 'HOME': '/home/cltbld', 11:27:14 INFO - 'LANG': 'en_US.UTF-8', 11:27:14 INFO - 'LANGUAGE': 'en_US:en', 11:27:14 INFO - 'LOGNAME': 'cltbld', 11:27:14 INFO - 'MAIL': '/var/mail/cltbld', 11:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:14 INFO - 'MOZ_NO_REMOTE': '1', 11:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:14 INFO - 'NO_EM_RESTART': '1', 11:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:14 INFO - 'PWD': '/builds/slave/test', 11:27:14 INFO - 'SHELL': '/bin/bash', 11:27:14 INFO - 'SHLVL': '1', 11:27:14 INFO - 'TERM': 'linux', 11:27:14 INFO - 'TMOUT': '86400', 11:27:14 INFO - 'USER': 'cltbld', 11:27:14 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:14 INFO - '_': '/tools/buildbot/bin/python'} 11:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:27:14 INFO - Cleaning up... 11:27:14 INFO - Return code: 0 11:27:14 INFO - Running post-action listener: _resource_record_post_action 11:27:14 INFO - Running post-action listener: _start_resource_monitoring 11:27:14 INFO - Starting resource monitoring. 11:27:14 INFO - [mozharness: 2017-08-17 18:27:14.714669Z] Finished create-virtualenv step (success) 11:27:14 INFO - [mozharness: 2017-08-17 18:27:14.715187Z] Running install step. 11:27:14 INFO - Running pre-action listener: _resource_record_pre_action 11:27:14 INFO - Running main action method: install 11:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:14 INFO - Reading from file tmpfile_stdout 11:27:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:15 INFO - Reading from file tmpfile_stdout 11:27:15 INFO - Output received: 11:27:15 INFO - Usage: mozinstall [options] installer 11:27:15 INFO - Options: 11:27:15 INFO - -h, --help show this help message and exit 11:27:15 INFO - -d DEST, --destination=DEST 11:27:15 INFO - Directory to install application into. [default: 11:27:15 INFO - "/builds/slave/test"] 11:27:15 INFO - --app=APP Application being installed. [default: firefox] 11:27:15 INFO - mkdir: /builds/slave/test/build/application 11:27:15 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:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:27:29 INFO - Reading from file tmpfile_stdout 11:27:29 INFO - Output received: 11:27:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:27:29 INFO - Running post-action listener: _resource_record_post_action 11:27:29 INFO - [mozharness: 2017-08-17 18:27:29.731046Z] Finished install step (success) 11:27:29 INFO - [mozharness: 2017-08-17 18:27:29.731425Z] Running setup-mitmproxy step. 11:27:29 INFO - Running pre-action listener: _resource_record_pre_action 11:27:29 INFO - Running main action method: setup_mitmproxy 11:27:29 INFO - Skipping: mitmproxy is not required 11:27:29 INFO - Running post-action listener: _resource_record_post_action 11:27:29 INFO - [mozharness: 2017-08-17 18:27:29.732964Z] Finished setup-mitmproxy step (success) 11:27:29 INFO - [mozharness: 2017-08-17 18:27:29.733187Z] Running run-tests step. 11:27:29 INFO - Running pre-action listener: _resource_record_pre_action 11:27:29 INFO - Running pre-action listener: _set_gcov_prefix 11:27:29 INFO - Running main action method: run_tests 11:27:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:29 INFO - Python 2.7.3 11:27:29 INFO - Return code: 0 11:27:29 INFO - grabbing minidump binary from tooltool 11:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:27:29 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 0x1e95050>, '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 0x1e95f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e963e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:29 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:27:29 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:27:29 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:27:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:29 INFO - Return code: 0 11:27:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:27:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:29 INFO - ENV: RUST_BACKTRACE is now 1 11:27:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:27:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:29 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/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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:27:29 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/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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:27:29 INFO - Using env: {'DISPLAY': ':0', 11:27:29 INFO - 'HOME': '/home/cltbld', 11:27:29 INFO - 'LANG': 'en_US.UTF-8', 11:27:29 INFO - 'LANGUAGE': 'en_US:en', 11:27:29 INFO - 'LOGNAME': 'cltbld', 11:27:29 INFO - 'MAIL': '/var/mail/cltbld', 11:27:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:29 INFO - 'MOZ_NO_REMOTE': '1', 11:27:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:29 INFO - 'NO_EM_RESTART': '1', 11:27:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:29 INFO - 'PWD': '/builds/slave/test', 11:27:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:29 INFO - 'RUST_BACKTRACE': '1', 11:27:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:27:29 INFO - 'SHELL': '/bin/bash', 11:27:29 INFO - 'SHLVL': '1', 11:27:29 INFO - 'TERM': 'linux', 11:27:29 INFO - 'TMOUT': '86400', 11:27:29 INFO - 'USER': 'cltbld', 11:27:29 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727', 11:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:29 INFO - '_': '/tools/buildbot/bin/python'} 11:27:29 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/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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:27:30 INFO - mozversion application_buildid: 20170817171355 11:27:30 INFO - mozversion application_changeset: 933e3d98fb65f36c129ed3dc625c84636c42581c 11:27:30 INFO - mozversion application_display_name: Firefox 11:27:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:30 INFO - mozversion application_name: Firefox 11:27:30 INFO - mozversion application_remotingname: firefox 11:27:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:27:30 INFO - mozversion application_vendor: Mozilla 11:27:30 INFO - mozversion application_version: 56.0 11:27:30 INFO - mozversion platform_buildid: 20170817171355 11:27:30 INFO - mozversion platform_changeset: 933e3d98fb65f36c129ed3dc625c84636c42581c 11:27:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:27:30 INFO - mozversion platform_version: 56.0 11:27:30 INFO - using testdate: 1502994450 11:27:30 INFO - actual date: 1502994450 11:27:30 INFO - starting webserver on 'localhost:58782' 11:27:30 INFO - SUITE-START | Running 2 tests 11:27:30 INFO - TEST-START | dromaeo_css 11:27:30 INFO - Initialising browser for dromaeo_css test... 11:27:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58782/getInfo.html -profile /tmp/tmpXq924X/profile 11:27:30 INFO - TEST-INFO | started process 11667 (/builds/slave/test/build/application/firefox/firefox http://localhost:58782/getInfo.html) 11:27:35 INFO - TEST-INFO | 11667: exit 0 11:27:36 INFO - Browser initialized. 11:27:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:36 INFO - TEST-INFO | started process 11833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXq924X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:36 INFO - PID 11833 | 1502994456355 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:27:47 INFO - PID 11833 | RSS: Main: 154365952 11:27:47 INFO - PID 11833 | 11:30:45 INFO - PID 11833 | Cycle 1(1): loaded http://localhost:58782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58782/tests/dromaeo/cssquery-ext.html) 11:30:46 INFO - PID 11833 | RSS: Main: 160423936 11:30:46 INFO - PID 11833 | 11:33:48 INFO - PID 11833 | Cycle 1(1): loaded http://localhost:58782/tests/dromaeo/cssquery-ext.html (next: http://localhost:58782/tests/dromaeo/cssquery-jquery.html) 11:33:48 INFO - PID 11833 | RSS: Main: 157425664 11:33:48 INFO - PID 11833 | 11:36:50 INFO - PID 11833 | Cycle 1(1): loaded http://localhost:58782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58782/tests/dromaeo/cssquery-mootools.html) 11:36:51 INFO - PID 11833 | RSS: Main: 159064064 11:36:51 INFO - PID 11833 | 11:39:52 INFO - PID 11833 | Cycle 1(1): loaded http://localhost:58782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58782/tests/dromaeo/cssquery-prototype.html) 11:39:53 INFO - PID 11833 | RSS: Main: 158916608 11:39:53 INFO - PID 11833 | 11:42:56 INFO - PID 11833 | Cycle 1(1): loaded http://localhost:58782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58782/tests/dromaeo/cssquery-yui.html) 11:42:57 INFO - PID 11833 | RSS: Main: 161423360 11:42:57 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | Cycle 1(1): loaded http://localhost:58782/tests/dromaeo/cssquery-yui.html (next: http://localhost:58782/tests/dromaeo/cssquery-dojo.html) 11:45:58 INFO - PID 11833 | RSS: Main: 164298752 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | __start_tp_report 11:45:58 INFO - PID 11833 | _x_x_mozilla_page_load 11:45:58 INFO - PID 11833 | _x_x_mozilla_page_load_details 11:45:58 INFO - PID 11833 | |i|pagename|runs| 11:45:58 INFO - PID 11833 | |0;dojo.html;3565.0909018200373;3579.785212887226;3581.6597423244784;3585.0858031202047;3611.404118320477;6362.777302794403;6375;6423.3897779710915;6441.838954026151;6465.094886715858;6307.211598550181;6373.490120790349;6377.394147555986;6391.616503009823;6446.387593178641;5468.808591699291;5594;5615.887682246353;5673.943260567404;5699.2590963174725;5604.887902241952;5652.802151924683;5672.574556908227;5714.571407144481;5724.370319264877;5467.562594992431;5604.495595396393;5628.789810190788;5670.3479099903425;5676.545876329884;5577.386487486414;5608.663480191201;5616.157576363537;5626.352969408488;5643.661380317194;5572;5595.328560572717;5605.495505404492;5628.380878103405;5652;6147.262328520562;6246.500279977591;6256.8424841404485;6261.342559031282;6400.167978162855;6733.956236783307;6771.950347696115;6788.422984046362;6789.422899053587;6944.826379340557;6976.232614412411;6990.335918087773;7022.613756243404;7056.717731290742;7059.258777828305;6324.209473815773;6460.709268082947;6463.418292353664;6514.088027676129;6524.217093948709;6940.063091482585;6941.826454338682;6945.062416573799;6945.201301850352;6977.232504424509;6528.118703974903;6536.575122617015;6582.44049255809;6662.533622646465;6685.832854178587;6942.271061538567;6951.409130223887;7000.474964377692;7009.894851577231;7010.263922288086;6810.557313774688;6818.352256535721;6838.111045564045;6881.41507971818;6885.483588730765;6712.865742685119;6750.426213771786;6854.862902741917;6911.89632155518;6933.757318493828;5021.623378246646;5077.669951453144;5077.746112694351;5081.339425874687;5114;4575.81696732127;4587.931181032287;4614.446266448048;4631.490536041033;4638.350630911675;6548.952167653152;6591.110200122922;6593.637349945703;6667.099941507834;6688.063671086052;6804.421624161902;6871.312868713188;6907.309269073053;6949.235584085746;7018.789436316919;6490.2536208335705;6511.674416279167;6512.837179070561;6559.47524198063;6679.398854103154;5830.5044071254415;5838;5915.319738230159;5934.643921364732;5944.108383742473;7126.073610430611;7130.679119439741;7135.678894449762;7231.059962204879;7240.9637951810955;6825.2833452486775;6886.208086070166;6943.51395402317;6984.092068031327;6996.755113571001;7113.857722845618;7159.534630249017;7212.386947109345;7242.601656908921;7255;6818.488613353919;6834.658267086526;6845.589264644137;6896.2069362022;6896.551724137915;6808.148981377328;6811.65941702903;6847.828804279933;6974.267701891228;7033.437325014089;6715.764948226789;6777.2883847195335;6787.321267873173;6800.421964133104;6815.69329380189;6604.801855944329;6678.699458524281;6688.464922806066;6700.93299067003;6756.290589488033;6678.031685405686;6691.832704182434;6701.396874281338;6705.765298214539;6709.127813384229;6697.799066028027;6740.12378390806;6773.458123350021;6830.726770929107;6870.553414028072;6499.415052645285;6560.9343906560325;6566.507511936719;6655.800325990228;6657.600543967377 11:45:58 INFO - PID 11833 | |1;ext.html;862.4120381858447;888.3391983352232;908.4231512989252;935.3966691483989;936.6113063078818;42149.57850421495;42941.570584294146;43009.139817203635;43019.13961720768;43024.78487607557;39685;39731;39973.60026399735;40087.799561002226;40208.59791402085;6915.1701795784575;7035.894461583081;7074.717011319541;7080.85838283234;7083.291670832927;6867.965660171717;6930.376266136047;6938.757143499978;6940;6964.477664175207;6920.688569014381;7736.497127686711;7923.960380198091;7931.246531579491;7954.602269886512;7850.097238817523;7856.803579910491;7881.8029549261155;7894.250046245597;7924.286814186751;7733.690652373898;7803.765887023398;7808.843823123506;7810.258025487569;7828.5694286814205;40400.1919961602;40529.189416211804;40663;40792.59207407918;40818.795906020576;3674.2467794102145;3715.7956312402807;3717.5910649828497;3724.646158614927;3736.290104880064;33257.83371083153;33351.332973340395;33393.49909751356;33434.49848252278;33482.162945926306;5151.690898546061;5185.818496352647;5210.713410762407;5229.555487783543;5241.3710354757295;219819;221847;222895;226495;238282;53653.731731341875;53847;53910.46089539054;53913.46086539163;53931.730341348826;55583.16625250624;55991.72004139953;56030;56177.43822561804;56194;16926;17080.743788843178;17100.230489627997;17108.82891171097;17220.138993050547;13905.235212063231;13968.58094257174;14036.578902632937;14043.578692639237;14046.1572305662;15290.388384464497;15361.231938403258;15498.767518487231;15620.594146526868;15669;5912.881742365129;5968;6083.6045657032155;6086.421789929949;6086.573939824259;1082.8971247731454;1097.4074000040048;1100.884407137255;1108.8336749487642;1116.609186784635;25656;25716.742832571435;25899.223023309332;26078.34804129912;26100.477990440086;1190.6844686158174;1208.1422190244848;1216.707990082374;1216.9756604867853;1223.9143259971895;13633.795493067611;13653.658658533615;13668.17990920528;17930.19314130867;18637.347692830685;283074;290771;290836;291109;291393;62720.686396567726;63525.36474635287;63588;63637.04544431837;63666;1496.1546726099718;1508.9170095644845;1521.25458525324;1536.454558631692;1539.5535294764393;30870.935045611695;31204.687953120178;31290;31432;31676.683233167372;42483;42726.78636606797;42743.358849616656;42777.358339624305;42826.78586607047;241908;245401;245730;246150;246854;36676.26647466982;36683.89948301555;39252.803735981135;39257.607423925394;39284;49082;49290.26064608962;49707.502924970286;49897;49971.500284996684;36485.27029459449;36662.450063249606;36685.449718253716;36838.79909463449;36949.81525092357;35836.82081589576;36101;36405.27189456249;36918.154092295816;36968.44547331846;41278.38082428706;41605;42080.15839683128;42481.57518424776;42810.1437971245;35022.47466287957;35257.471137932436;35312.47031294481;35378.46932295966;35839.82080089583;26276.08033718811;26455.867720661274;26899.73100268972;27174.72825271722;27270.181894542402 11:45:58 INFO - PID 11833 | |2;jquery.html;590.2297501760204;595.244040069112;604.5919004671846;616.8427051101968;632.5319263744829;23821.76178238217;24340.148094816686;24367.512649746994;24382.268531944024;24689.876550617268;26783.866080669617;26887.32781680459;27281.45437091257;27499.31251718708;27571.862140689267;6292.779752708656;6460.612363258196;6468.223813142406;6468.708908099147;6472.805815825533;5887.411258874121;6114.633122012693;6390.105385246069;6391.744330226786;6398.13625160602;6324.588901721373;6371.012493063583;6375.617462952215;6381.425671689547;6381.840453988664;6313.084602732601;6345.8413539661415;6349.777757778479;6365.140706004677;6373.585716928431;5945.137954996545;5952.642841429528;5972.223610930595;6000.8499787505225;6005.759769609211;29621.703782962326;30731.38537229243;30886;31024.0692779217;31414.528782068057;2289.198780426854;2321.3500219938446;2328.8253380996493;2347.424880904189;2349.01341436597;20084.096215670328;20422.08100635475;20541.38375848727;20616.38150855477;20616.896915515477;2409.33743220614;2462.741412151734;2496.962545561818;2505.549001179787;2511.824172307939;153299.23350383175;156158.21920890323;156869;156908;158257;16002.519924402053;16152.676946461004;16218.837811621968;16235.512934611981;17441.389551365643;25715.09997150091;25733.74266257351;25762;25796.48407031849;25833.354166145997;11174.888251117385;11206.719832004264;11267.154963377616;11390.886091139148;11464.770704585862;9249.630014799333;10413.219008574388;10419.843702344471;10515.24291447513;10611.469426528643;8934.553272336358;9868.111869931741;10261.179105671677;10317.821282380648;10384.169266458664;2895.5077636801793;2914.184028472031;2946.911592652224;2959.615250017527;2989.790714649997;1073.8174510333263;1076.56399158341;1089.722120859176;1092.3882625729616;1095.2606990281529;22466.55066898653;26539;27408.7666055028;28229.858850705616;28581.99963001285;1123.7920984617872;1159.837622732818;1168.6727716239466;1170.3796987596588;1184.7867383870814;12115.39423028845;12676.746465070646;12982.740345193044;13051.28217948003;13067.738645227042;602948;617751;618253;630282;632495;142345;143029;147111;149759;150928;1303.850057243429;1331.2811082015796;1352.6618345413647;1358.3140514040347;1375.7454870848726;23175;23185.3044408668;23450.648240276067;23502.294931152093;23742;64663;64817.67591162014;65225.347746523825;66335.66832165809;67667.66166169138;81446.59276703579;81611;81657.59171204106;81701;82265.58867205626;13797;15678.216089195723;15679.216039198223;15881.126538040518;15919.602009949844;24877.502449951262;24921.875390622932;24975.375615609755;25141.24576262715;25197.622035669112;19293.421197364103;19792.307269245506;19871.30450434228;19914.60170796605;20015.899920500306;17063.23215455283;17435.215415306087;17659.646807064044;17736.467905962843;17889.19498622591;20342.694859577416;20728.06723697407;20803.271885483937;20932.686009709563;21030;15412.383504660136;15504.612384690021;15629.452969146025;15660.138692371573;15669;20028.699569506178;20069.197232110553;20088.096035678136;20099.79900201038;20102.69845952341 11:45:58 INFO - PID 11833 | |3;mootools.html;1473.3222717549927;1500.3623460029485;1503.9398424063031;1517.150395778364;1532.7087853307871;15475.303611337502;16110.677786444294;16117.113558754263;16123.758143627854;16151.596210094738;15555.84444155558;16515.917420412912;16707.498775036736;16724.749128763047;16735.246913888874;2933.208033830875;2976;3015.2311160654003;3027.545868119789;3030.772692048094;2878.0934005788213;2914.3005678637082;2970.5841182234503;2976.0774160010465;3027.3339865229614;2939.3974235281717;2972.7770417218794;2987.5668028135906;3002.4145291668024;3003.1140813459974;2847.1316248544185;2896.6234389529436;2900.65192176938;2905.404392099625;2914.810537315089;2863.21261653045;2869.6126022986837;2875.0081221978385;2881.2652773542823;2881.4957382458197;15875.920620396939;15883.682326353408;16022.75965860513;16052.678946421007;16086;8634.870476942851;8901.866472002925;8925.285977121815;8929.508877011827;8936.46381217129;5527.115661494142;5543.6396634218645;5574.1917421973585;5860.150278209679;5927.644341339534;1879.4549580621604;1881.67070762616;1908.8568357373254;1914.5213696575856;1923.144200830631;27519.31201719953;28386.432271354664;28419.14742557706;28449.715502844912;28474.857625711946;7234;7268.345848873627;7328.9267107329315;7354.485186037033;7433;18610.720839187423;18612.813871861108;18616.441506754818;18623.81376186221;18629.534261643566;8426.747197584082;8462.87305690415;8567;8582.65669373218;8593.785155371166;7834.960825195838;7962.2037796221075;8197.016358037074;8201.22088401601;8208.712695055645;5371.462853714597;5708.600397972102;6005.549583781234;6067.908981365194;6107.511399088063;1620.9756853647204;1666.9166541672869;1667.5414261078301;1671.707451196036;1689.341156948791;930.4789317981952;952.9428234305964;959.1799011844912;970.0929630795229;970.1656575345197;8766.123387661182;9178.449293042439;9179.082091790768;9187.173154416001;9314.394564353295;1057.534684738728;1074.5594306334365;1074.897884700952;1075.3494136047734;1097.7584931315098;4896.608271338356;5551.306086739158;5712.914306285409;5788.363280039192;5998.730057147439;22737.31788046361;23173.53652926966;23504.647430288558;23508.41228969255;23526.176583819484;22788;22903.88548057249;22918.42703932415;22997.310080697607;24338.756612434005;12973.41619627119;13147.60557183286;13217.537386191438;13253.933730331479;13277.535286265127;9033.277337812828;9092.545372731469;9487.241020718464;9553.952230238805;9556.378835375679;20158.39524814258;20203.696944546136;20569.382918512467;20913.686294705894;21102.26142085081;21149.68275475838;21405.250816221356;21449.892750536772;21612.567748645255;21756.34730958074;13335.199888006751;13561.864381356454;13683.179009259477;13699.315034248048;13701.45194192261;14875.628109297355;14939.77590336124;14963.102213867203;14995.325210365778;15051.548453546411;11269.436528173395;11845.289282643069;11997.340146291688;12071.517139314328;12169.878301216875;11552;11789.174757766874;11900.821487677866;12026.699332516757;12120.515179392725;10301.35178371457;10502.369857808557;10506.579736810441;10507.632232872118;10514.106300964504;8146.674133034612;8173.305269052197;8296.917030829856;8336.749897503085;8353.624086915981;8048.517088974446;8098.83802323962;8139.1453897339925;8148.755537333889;8163.7142700005215 11:45:58 INFO - PID 11833 | |4;prototype.html;526.208056874404;534.9518543331101;558.416454804729;563.1046635849001;563.7463141586287;6239.25128984522;6248.4688801451875;6310.495160387175;6334.271558770743;6356.3325850785695;5973.581849270553;6068.180795592593;6154.384561543855;6154.723037463314;6184.721687524061;4820.686655367407;4821.54195351441;4835.516448355154;4837.177679794443;4842.467328593852;4752.572268495835;4864.294677271793;4864.683795553296;4888.828890988816;4898;4778.617710583162;4811.566958973692;4859.757012149396;4869.196582563873;4870.245112007645;4835.734034628094;4867.659263851532;4889.633277504184;4897.951020489821;4916.483769204217;4392.38506609075;4411.955880441186;4450.955490445086;4489.685721999462;4494.438195225597;6094.146819445281;6114.908276375858;6117.5717699761035;6151.938480615226;6154.692265386713;5734.254546908917;5824.359320474744;5895.498882594985;5913.645181289136;5920.733566989496;6613.93386066138;6629.569078009914;6675.666216689195;6692.816989381637;6700.765473208463;5111.591072714174;5114.897702045975;5120.667156634844;5125.513076257749;5127.512886275797;6985.26654701249;6985.930140698579;6987.196472405688;7019.473539484508;7063.011178435023;5184.533391994663;5185.325907631984;5189.327496339388;5202.505761952609;5212.869678258074;5244.947550524446;5272.525472707398;5279.86482906177;5291.576673866081;5296.682199067991;5814.796482123105;5838.182654428383;5844.357120716718;5846.386129456431;5866.266716660418;6458.225012998376;6539.149910511603;6568.408843204039;6698.229703584053;6715.764948226789;1780.8753387263027;1793.7399077133744;1821.3807305516189;1822.0161112998833;1829.4237315245655;1269.3272565540094;1284.6659868434274;1300.8048792681172;1310.2073245686413;1310.2924420812653;6406.839829004219;6442.098106265126;6450.0647406125845;6477.4170324671;6490.870182596322;6500.252470965805;6798.558093723892;6820.6930688119155;6864.622445765531;6873.690683919235;6437.9678101610125;6441.710123044474;6447.806565803034;6490.383413575702;6492.383223593751;3590.3537363274863;3630.6006339302658;3649.908752281161;3655.451682247684;3663.5054267674054;6913.446924246149;6985.860282794316;7091.361777440055;7119.288071192943;7130.465215108888;6837;7011.949801836217;7037.120359955005;7042.92957070433;7046.823829404306;7039;7046.154461464657;7071.292870712888;7101.751438699621;7105.32499412555;6793.558418702769;6866.485013623898;6877.828054298682;6885.208201056943;6969.337912898267;6536.150300460909;6665.166854143232;6735.158105236846;6742.325767423218;6807.829804254933;7003.719851206099;7004.509684322048;7042.22535521082;7091.539049961736;7091.680874360563;5152.27868098474;5157.742112894415;5180.093483640423;5191.195364718475;5196.272521846869;6594.406503414716;6799.89800153008;6821.829454263683;6848.383645471931;6875.965620171867;6371.39471750183;6556.2788093308745;6618;6638.468922486286;6668.266490685924;6440.232464008607;6542.54202205841;6550.47596192313;6552.803415897531;6563.278039415756;6548.8035358939305;6571.408573228432;6620.172478440195;6622.801315960529;6653.367930046637;6559.4752419805345;6682.131322927989;6682.560865284234;6731.798046058626;6738.225104113089;6409.166808315075;6460.289368169591;6472.255690595642;6517.315681853527;6518.641474718746 11:45:58 INFO - PID 11833 | |5;yui.html;954.1317401164941;954.4654993203807;985.5417230987589;995.4226548601812;1000.574755728815;19276.228950841967;19834.008299585017;19889.602207955868;19910.800891991094;22679.659805102936;21810.345689629296;22692.205772797955;22697;22856.08575656976;22856.65715014272;1069.5294070608945;1099.3953325670889;1099.76355083657;1102.735343517558;1104.5305745058358;1084.078533246742;1100.372787511119;1101.0860985382153;1101.6639924822925;1102.08526922654;1113.4265853085667;1147.1912301827192;1149.8735139134687;1150.6375491720123;1151.4933429291086;1136.0797753819434;1143.771245750849;1145.2040831622026;1146.3866831245243;1147.6671765188084;797.314309693663;806.6410447350931;811.1280373598405;812.3338862133053;817.0889458254063;20434.182632694676;20697.896510517352;20738.170473181053;20775.58448831015;21047.368578942656;21634.78365216359;21636.24273150432;21717.67423488649;21771.346859594236;22364.552708945892;16998.06510641914;17182.39861604838;17370.305187792474;17436.389726359645;17547.5613109672;3767.9246415071543;3774.2451509697894;3778.149916268845;3780.1683629601443;3790.166163444038;148442;149241.99999999892;150572;150918;151312;14817.629559261104;15953.202339882959;16299.266533005806;16382.180890955404;16406.09766462856;32636.518558127995;32846;33232.501512477334;33238.16904577405;33679.83160084233;9503.42979421223;9625.229981601455;9633.181179599673;9634.181094606896;9665.565049572786;4650.162970665313;4663.137319595886;4670.322803193518;4730.195866702668;4744.59670927975;5518.061929471999;5545.1682247663175;5616.606837521416;5626.212330273765;5645.661260324394;1153.2792004996877;1159.8202278646822;1193.9910775394778;1201.8077107662907;1207.5109580619687;758.3364556013488;761.588742079282;780.2080887898787;784.6861255497846;795.0777098565752;12813.807792883114;13392.263425511495;13641;13785.586432407044;13941.093828901088;756.3759898083993;758.8102974256436;762.0969151555424;763.1719584251039;769.9961500192463;6405.167328247298;6431.967840160769;6454.451371633464;6509.218893732783;6568.934310656832;129219.35390322989;129979.35010324889;130769;133466.33266833605;136284;111505.44247278712;113169;113241;115310.42344788222;116917;94855;96430;97211;98189;98428.5078574617;12546.121771476273;12572.559960401342;12619.49522019109;12641.93679031599;12660.810087848873;46191.30713039375;46877.531224687315;47227.52772472231;47467.52532474631;47951.5204847947;61688;61912.38087619066;61919;61954;62675.6866215666;16982.490525284262;17125.14374281306;17163.141842907557;17255.309787608356;17366.39217627377;18673.439796806117;18833;18895.43313700591;19083.427497175107;19224.13491392863;16793.41223057187;17176.914115429343;17245.22396492136;17393.478195654152;22019.339419817432;21480.570388592452;21581.46046348854;21793.891030544746;21803;22163.889180553993;19744.40766776999;19770.802291976896;19848.30530931468;19973.60052798965;20757.584848302646;14724.190169540778;15195.696086078438;15497.5350739478;15651.921740391224;15967.680646386774;14516.419343226153;14791.852081479477;16135.75796363032;16391.91804040972;16642.916785415997 11:45:58 INFO - PID 11833 | __end_tp_report 11:45:58 INFO - PID 11833 | __start_cc_report 11:45:58 INFO - PID 11833 | _x_x_mozilla_cycle_collect,292 11:45:58 INFO - PID 11833 | __end_cc_report 11:45:58 INFO - PID 11833 | __startTimestamp1502995558956__endTimestamp 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | ------- Summary: start ------- 11:45:58 INFO - PID 11833 | Number of tests: 6 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | [#0] dojo.html Cycles:165 Average:6348.26 Median:6667.10 stddev:792.58 (11.9%) stddev-sans-first:764.34 11:45:58 INFO - PID 11833 | Values: 3565.1 3579.8 3581.7 3585.1 3611.4 6362.8 6375.0 6423.4 6441.8 6465.1 6307.2 6373.5 6377.4 6391.6 6446.4 5468.8 5594.0 5615.9 5673.9 5699.3 5604.9 5652.8 5672.6 5714.6 5724.4 5467.6 5604.5 5628.8 5670.3 5676.5 5577.4 5608.7 5616.2 5626.4 5643.7 5572.0 5595.3 5605.5 5628.4 5652.0 6147.3 6246.5 6256.8 6261.3 6400.2 6734.0 6772.0 6788.4 6789.4 6944.8 6976.2 6990.3 7022.6 7056.7 7059.3 6324.2 6460.7 6463.4 6514.1 6524.2 6940.1 6941.8 6945.1 6945.2 6977.2 6528.1 6536.6 6582.4 6662.5 6685.8 6942.3 6951.4 7000.5 7009.9 7010.3 6810.6 6818.4 6838.1 6881.4 6885.5 6712.9 6750.4 6854.9 6911.9 6933.8 5021.6 5077.7 5077.7 5081.3 5114.0 4575.8 4587.9 4614.4 4631.5 4638.4 6549.0 6591.1 6593.6 6667.1 6688.1 6804.4 6871.3 6907.3 6949.2 7018.8 6490.3 6511.7 6512.8 6559.5 6679.4 5830.5 5838.0 5915.3 5934.6 5944.1 7126.1 7130.7 7135.7 7231.1 7241.0 6825.3 6886.2 6943.5 6984.1 6996.8 7113.9 7159.5 7212.4 7242.6 7255.0 6818.5 6834.7 6845.6 6896.2 6896.6 6808.1 6811.7 6847.8 6974.3 7033.4 6715.8 6777.3 6787.3 6800.4 6815.7 6604.8 6678.7 6688.5 6700.9 6756.3 6678.0 6691.8 6701.4 6705.8 6709.1 6697.8 6740.1 6773.5 6830.7 6870.6 6499.4 6560.9 6566.5 6655.8 6657.6 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | [#1] ext.html Cycles:180 Average:43744.32 Median:3730.47 stddev:66325.68 (1777.9%) stddev-sans-first:66433.59 11:45:58 INFO - PID 11833 | Values: 862.4 888.3 908.4 935.4 936.6 42149.6 42941.6 43009.1 43019.1 43024.8 39685.0 39731.0 39973.6 40087.8 40208.6 6915.2 7035.9 7074.7 7080.9 7083.3 6868.0 6930.4 6938.8 6940.0 6964.5 6920.7 7736.5 7924.0 7931.2 7954.6 7850.1 7856.8 7881.8 7894.3 7924.3 7733.7 7803.8 7808.8 7810.3 7828.6 40400.2 40529.2 40663.0 40792.6 40818.8 3674.2 3715.8 3717.6 3724.6 3736.3 33257.8 33351.3 33393.5 33434.5 33482.2 5151.7 5185.8 5210.7 5229.6 5241.4 219819.0 221847.0 222895.0 226495.0 238282.0 53653.7 53847.0 53910.5 53913.5 53931.7 55583.2 55991.7 56030.0 56177.4 56194.0 16926.0 17080.7 17100.2 17108.8 17220.1 13905.2 13968.6 14036.6 14043.6 14046.2 15290.4 15361.2 15498.8 15620.6 15669.0 5912.9 5968.0 6083.6 6086.4 6086.6 1082.9 1097.4 1100.9 1108.8 1116.6 25656.0 25716.7 25899.2 26078.3 26100.5 1190.7 1208.1 1216.7 1217.0 1223.9 13633.8 13653.7 13668.2 17930.2 18637.3 283074.0 290771.0 290836.0 291109.0 291393.0 62720.7 63525.4 63588.0 63637.0 63666.0 1496.2 1508.9 1521.3 1536.5 1539.6 30870.9 31204.7 31290.0 31432.0 31676.7 42483.0 42726.8 42743.4 42777.4 42826.8 241908.0 245401.0 245730.0 246150.0 246854.0 36676.3 36683.9 39252.8 39257.6 39284.0 49082.0 49290.3 49707.5 49897.0 49971.5 36485.3 36662.5 36685.4 36838.8 36949.8 35836.8 36101.0 36405.3 36918.2 36968.4 41278.4 41605.0 42080.2 42481.6 42810.1 35022.5 35257.5 35312.5 35378.5 35839.8 26276.1 26455.9 26899.7 27174.7 27270.2 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | [#2] jquery.html Cycles:180 Average:41318.24 Median:12925.65 stddev:104196.98 (806.1%) stddev-sans-first:104444.41 11:45:58 INFO - PID 11833 | Values: 590.2 595.2 604.6 616.8 632.5 23821.8 24340.1 24367.5 24382.3 24689.9 26783.9 26887.3 27281.5 27499.3 27571.9 6292.8 6460.6 6468.2 6468.7 6472.8 5887.4 6114.6 6390.1 6391.7 6398.1 6324.6 6371.0 6375.6 6381.4 6381.8 6313.1 6345.8 6349.8 6365.1 6373.6 5945.1 5952.6 5972.2 6000.8 6005.8 29621.7 30731.4 30886.0 31024.1 31414.5 2289.2 2321.4 2328.8 2347.4 2349.0 20084.1 20422.1 20541.4 20616.4 20616.9 2409.3 2462.7 2497.0 2505.5 2511.8 153299.2 156158.2 156869.0 156908.0 158257.0 16002.5 16152.7 16218.8 16235.5 17441.4 25715.1 25733.7 25762.0 25796.5 25833.4 11174.9 11206.7 11267.2 11390.9 11464.8 9249.6 10413.2 10419.8 10515.2 10611.5 8934.6 9868.1 10261.2 10317.8 10384.2 2895.5 2914.2 2946.9 2959.6 2989.8 1073.8 1076.6 1089.7 1092.4 1095.3 22466.6 26539.0 27408.8 28229.9 28582.0 1123.8 1159.8 1168.7 1170.4 1184.8 12115.4 12676.7 12982.7 13051.3 13067.7 602948.0 617751.0 618253.0 630282.0 632495.0 142345.0 143029.0 147111.0 149759.0 150928.0 1303.9 1331.3 1352.7 1358.3 1375.7 23175.0 23185.3 23450.6 23502.3 23742.0 64663.0 64817.7 65225.3 66335.7 67667.7 81446.6 81611.0 81657.6 81701.0 82265.6 13797.0 15678.2 15679.2 15881.1 15919.6 24877.5 24921.9 24975.4 25141.2 25197.6 19293.4 19792.3 19871.3 19914.6 20015.9 17063.2 17435.2 17659.6 17736.5 17889.2 20342.7 20728.1 20803.3 20932.7 21030.0 15412.4 15504.6 15629.5 15660.1 15669.0 20028.7 20069.2 20088.1 20099.8 20102.7 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | [#3] mootools.html Cycles:180 Average:10176.86 Median:27952.87 stddev:7219.01 (25.8%) stddev-sans-first:7209.64 11:45:58 INFO - PID 11833 | Values: 1473.3 1500.4 1503.9 1517.2 1532.7 15475.3 16110.7 16117.1 16123.8 16151.6 15555.8 16515.9 16707.5 16724.7 16735.2 2933.2 2976.0 3015.2 3027.5 3030.8 2878.1 2914.3 2970.6 2976.1 3027.3 2939.4 2972.8 2987.6 3002.4 3003.1 2847.1 2896.6 2900.7 2905.4 2914.8 2863.2 2869.6 2875.0 2881.3 2881.5 15875.9 15883.7 16022.8 16052.7 16086.0 8634.9 8901.9 8925.3 8929.5 8936.5 5527.1 5543.6 5574.2 5860.2 5927.6 1879.5 1881.7 1908.9 1914.5 1923.1 27519.3 28386.4 28419.1 28449.7 28474.9 7234.0 7268.3 7328.9 7354.5 7433.0 18610.7 18612.8 18616.4 18623.8 18629.5 8426.7 8462.9 8567.0 8582.7 8593.8 7835.0 7962.2 8197.0 8201.2 8208.7 5371.5 5708.6 6005.5 6067.9 6107.5 1621.0 1666.9 1667.5 1671.7 1689.3 930.5 952.9 959.2 970.1 970.2 8766.1 9178.4 9179.1 9187.2 9314.4 1057.5 1074.6 1074.9 1075.3 1097.8 4896.6 5551.3 5712.9 5788.4 5998.7 22737.3 23173.5 23504.6 23508.4 23526.2 22788.0 22903.9 22918.4 22997.3 24338.8 12973.4 13147.6 13217.5 13253.9 13277.5 9033.3 9092.5 9487.2 9554.0 9556.4 20158.4 20203.7 20569.4 20913.7 21102.3 21149.7 21405.3 21449.9 21612.6 21756.3 13335.2 13561.9 13683.2 13699.3 13701.5 14875.6 14939.8 14963.1 14995.3 15051.5 11269.4 11845.3 11997.3 12071.5 12169.9 11552.0 11789.2 11900.8 12026.7 12120.5 10301.4 10502.4 10506.6 10507.6 10514.1 8146.7 8173.3 8296.9 8336.7 8353.6 8048.5 8098.8 8139.1 8148.8 8163.7 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | [#4] prototype.html Cycles:180 Average:5652.26 Median:6389.12 stddev:1602.36 (25.1%) stddev-sans-first:1559.98 11:45:58 INFO - PID 11833 | Values: 526.2 535.0 558.4 563.1 563.7 6239.3 6248.5 6310.5 6334.3 6356.3 5973.6 6068.2 6154.4 6154.7 6184.7 4820.7 4821.5 4835.5 4837.2 4842.5 4752.6 4864.3 4864.7 4888.8 4898.0 4778.6 4811.6 4859.8 4869.2 4870.2 4835.7 4867.7 4889.6 4898.0 4916.5 4392.4 4412.0 4451.0 4489.7 4494.4 6094.1 6114.9 6117.6 6151.9 6154.7 5734.3 5824.4 5895.5 5913.6 5920.7 6613.9 6629.6 6675.7 6692.8 6700.8 5111.6 5114.9 5120.7 5125.5 5127.5 6985.3 6985.9 6987.2 7019.5 7063.0 5184.5 5185.3 5189.3 5202.5 5212.9 5244.9 5272.5 5279.9 5291.6 5296.7 5814.8 5838.2 5844.4 5846.4 5866.3 6458.2 6539.1 6568.4 6698.2 6715.8 1780.9 1793.7 1821.4 1822.0 1829.4 1269.3 1284.7 1300.8 1310.2 1310.3 6406.8 6442.1 6450.1 6477.4 6490.9 6500.3 6798.6 6820.7 6864.6 6873.7 6438.0 6441.7 6447.8 6490.4 6492.4 3590.4 3630.6 3649.9 3655.5 3663.5 6913.4 6985.9 7091.4 7119.3 7130.5 6837.0 7011.9 7037.1 7042.9 7046.8 7039.0 7046.2 7071.3 7101.8 7105.3 6793.6 6866.5 6877.8 6885.2 6969.3 6536.2 6665.2 6735.2 6742.3 6807.8 7003.7 7004.5 7042.2 7091.5 7091.7 5152.3 5157.7 5180.1 5191.2 5196.3 6594.4 6799.9 6821.8 6848.4 6876.0 6371.4 6556.3 6618.0 6638.5 6668.3 6440.2 6542.5 6550.5 6552.8 6563.3 6548.8 6571.4 6620.2 6622.8 6653.4 6559.5 6682.1 6682.6 6731.8 6738.2 6409.2 6460.3 6472.3 6517.3 6518.6 11:45:58 INFO - PID 11833 | 11:45:58 INFO - PID 11833 | [#5] yui.html Cycles:180 Average:26292.33 Median:19900.20 stddev:37346.94 (187.7%) stddev-sans-first:37403.24 11:45:58 INFO - PID 11833 | Values: 954.1 954.5 985.5 995.4 1000.6 19276.2 19834.0 19889.6 19910.8 22679.7 21810.3 22692.2 22697.0 22856.1 22856.7 1069.5 1099.4 1099.8 1102.7 1104.5 1084.1 1100.4 1101.1 1101.7 1102.1 1113.4 1147.2 1149.9 1150.6 1151.5 1136.1 1143.8 1145.2 1146.4 1147.7 797.3 806.6 811.1 812.3 817.1 20434.2 20697.9 20738.2 20775.6 21047.4 21634.8 21636.2 21717.7 21771.3 22364.6 16998.1 17182.4 17370.3 17436.4 17547.6 3767.9 3774.2 3778.1 3780.2 3790.2 148442.0 149242.0 150572.0 150918.0 151312.0 14817.6 15953.2 16299.3 16382.2 16406.1 32636.5 32846.0 33232.5 33238.2 33679.8 9503.4 9625.2 9633.2 9634.2 9665.6 4650.2 4663.1 4670.3 4730.2 4744.6 5518.1 5545.2 5616.6 5626.2 5645.7 1153.3 1159.8 1194.0 1201.8 1207.5 758.3 761.6 780.2 784.7 795.1 12813.8 13392.3 13641.0 13785.6 13941.1 756.4 758.8 762.1 763.2 770.0 6405.2 6432.0 6454.5 6509.2 6568.9 129219.4 129979.4 130769.0 133466.3 136284.0 111505.4 113169.0 113241.0 115310.4 116917.0 94855.0 96430.0 97211.0 98189.0 98428.5 12546.1 12572.6 12619.5 12641.9 12660.8 46191.3 46877.5 47227.5 47467.5 47951.5 61688.0 61912.4 61919.0 61954.0 62675.7 16982.5 17125.1 17163.1 17255.3 17366.4 18673.4 18833.0 18895.4 19083.4 19224.1 16793.4 17176.9 17245.2 17393.5 22019.3 21480.6 21581.5 21793.9 21803.0 22163.9 19744.4 19770.8 19848.3 19973.6 20757.6 14724.2 15195.7 15497.5 15651.9 15967.7 14516.4 14791.9 16135.8 16391.9 16642.9 11:45:58 INFO - PID 11833 | -------- Summary: end -------- 11:45:58 INFO - PID 11833 | 11:45:59 INFO - TEST-INFO | 11833: exit 0 11:45:59 INFO - TEST-OK | dromaeo_css | took 1109531ms 11:45:59 INFO - TEST-START | kraken 11:45:59 INFO - Initialising browser for kraken test... 11:45:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58782/getInfo.html -profile /tmp/tmpYK6AvE/profile 11:45:59 INFO - TEST-INFO | started process 12190 (/builds/slave/test/build/application/firefox/firefox http://localhost:58782/getInfo.html) 11:46:05 INFO - TEST-INFO | 12190: exit 0 11:46:05 INFO - Browser initialized. 11:46:05 INFO - Running cycle 1/1 for kraken test... 11:46:05 INFO - TEST-INFO | started process 12353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYK6AvE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:05 INFO - PID 12353 | 1502995565933 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:46:16 INFO - PID 12353 | RSS: Main: 150257664 11:46:16 INFO - PID 12353 | 11:46:19 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58782/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:20 INFO - PID 12353 | RSS: Main: 157028352 11:46:20 INFO - PID 12353 | 11:46:22 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58782/tests/kraken/driver.html?testName=audio-dft) 11:46:23 INFO - PID 12353 | RSS: Main: 157216768 11:46:23 INFO - PID 12353 | 11:46:26 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58782/tests/kraken/driver.html?testName=audio-fft) 11:46:26 INFO - PID 12353 | RSS: Main: 157257728 11:46:26 INFO - PID 12353 | 11:46:28 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58782/tests/kraken/driver.html?testName=audio-oscillator) 11:46:29 INFO - PID 12353 | RSS: Main: 157364224 11:46:29 INFO - PID 12353 | 11:46:31 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:32 INFO - PID 12353 | RSS: Main: 156868608 11:46:32 INFO - PID 12353 | 11:46:35 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58782/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:35 INFO - PID 12353 | RSS: Main: 156692480 11:46:35 INFO - PID 12353 | 11:46:39 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58782/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:39 INFO - PID 12353 | RSS: Main: 160440320 11:46:39 INFO - PID 12353 | 11:46:42 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58782/tests/kraken/driver.html?testName=json-parse-financial) 11:46:43 INFO - PID 12353 | RSS: Main: 161046528 11:46:43 INFO - PID 12353 | 11:46:44 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:45 INFO - PID 12353 | RSS: Main: 160833536 11:46:45 INFO - PID 12353 | 11:46:47 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:47 INFO - PID 12353 | RSS: Main: 160698368 11:46:47 INFO - PID 12353 | 11:46:49 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:50 INFO - PID 12353 | RSS: Main: 160309248 11:46:50 INFO - PID 12353 | 11:46:52 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:53 INFO - PID 12353 | RSS: Main: 160559104 11:46:53 INFO - PID 12353 | 11:46:56 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:56 INFO - PID 12353 | RSS: Main: 161050624 11:46:56 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | Cycle 1(1): loaded http://localhost:58782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58782/tests/kraken/driver.html?testName=ai-astar) 11:46:58 INFO - PID 12353 | RSS: Main: 163033088 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | __start_tp_report 11:46:58 INFO - PID 12353 | _x_x_mozilla_page_load 11:46:58 INFO - PID 12353 | _x_x_mozilla_page_load_details 11:46:58 INFO - PID 12353 | |i|pagename|runs| 11:46:58 INFO - PID 12353 | |0;ai-astar;96;105;98;106;105;106;113;99;106;107 11:46:58 INFO - PID 12353 | |1;audio-beat-detection;138;114;140;165;112;147;138;118;161;114 11:46:58 INFO - PID 12353 | |2;audio-dft;162;162;163;163;162;163;163;162;163;163 11:46:58 INFO - PID 12353 | |3;audio-fft;76;74;76;186;75;75;74;77;151;76 11:46:58 INFO - PID 12353 | |4;audio-oscillator;77;78;129;79;78;76;122;79;78;127 11:46:58 INFO - PID 12353 | |5;imaging-gaussian-blur;114;114;113;116;114;114;114;114;114;114 11:46:58 INFO - PID 12353 | |6;imaging-darkroom;148;147;147;147;151;150;147;148;148;147 11:46:58 INFO - PID 12353 | |7;imaging-desaturate;95;94;95;93;93;94;95;95;95;94 11:46:58 INFO - PID 12353 | |8;json-parse-financial;46;46;45;46;50;50;46;45;45;46 11:46:58 INFO - PID 12353 | |9;json-stringify-tinderbox;52;51;52;53;51;55;51;51;51;52 11:46:58 INFO - PID 12353 | |10;stanford-crypto-aes;72;73;72;73;73;73;84;73;74;72 11:46:58 INFO - PID 12353 | |11;stanford-crypto-ccm;116;117;116;118;121;116;114;123;110;148 11:46:58 INFO - PID 12353 | |12;stanford-crypto-pbkdf2;158;159;162;157;160;168;156;172;156;165 11:46:58 INFO - PID 12353 | |13;stanford-crypto-sha256-iterative;60;60;58;59;57;58;57;56;61;59 11:46:58 INFO - PID 12353 | __end_tp_report 11:46:58 INFO - PID 12353 | __start_cc_report 11:46:58 INFO - PID 12353 | _x_x_mozilla_cycle_collect,791 11:46:58 INFO - PID 12353 | __end_cc_report 11:46:58 INFO - PID 12353 | __startTimestamp1502995618748__endTimestamp 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | ------- Summary: start ------- 11:46:58 INFO - PID 12353 | Number of tests: 14 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#0] ai-astar Cycles:10 Average:104.10 Median:110.00 stddev:5.04 (4.6%) stddev-sans-first:4.42 11:46:58 INFO - PID 12353 | Values: 96.0 105.0 98.0 106.0 105.0 106.0 113.0 99.0 106.0 107.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:139.00 stddev:19.61 (14.1%) stddev-sans-first:20.77 11:46:58 INFO - PID 12353 | Values: 138.0 114.0 140.0 165.0 112.0 147.0 138.0 118.0 161.0 114.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 11:46:58 INFO - PID 12353 | Values: 162.0 162.0 163.0 163.0 162.0 163.0 163.0 162.0 163.0 163.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:40.13 (53.2%) stddev-sans-first:42.04 11:46:58 INFO - PID 12353 | Values: 76.0 74.0 76.0 186.0 75.0 75.0 74.0 77.0 151.0 76.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:78.00 stddev:23.33 (29.9%) stddev-sans-first:24.08 11:46:58 INFO - PID 12353 | Values: 77.0 78.0 129.0 79.0 78.0 76.0 122.0 79.0 78.0 127.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:46:58 INFO - PID 12353 | Values: 114.0 114.0 113.0 116.0 114.0 114.0 114.0 114.0 114.0 114.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.41 (1.0%) stddev-sans-first:1.50 11:46:58 INFO - PID 12353 | Values: 148.0 147.0 147.0 147.0 151.0 150.0 147.0 148.0 148.0 147.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 11:46:58 INFO - PID 12353 | Values: 95.0 94.0 95.0 93.0 93.0 94.0 95.0 95.0 95.0 94.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:46.00 stddev:1.90 (4.1%) stddev-sans-first:2.01 11:46:58 INFO - PID 12353 | Values: 46.0 46.0 45.0 46.0 50.0 50.0 46.0 45.0 45.0 46.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#9] json-stringify-tinderbox Cycles:10 Average:51.90 Median:52.00 stddev:1.29 (2.5%) stddev-sans-first:1.36 11:46:58 INFO - PID 12353 | Values: 52.0 51.0 52.0 53.0 51.0 55.0 51.0 51.0 51.0 52.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.00 stddev:3.60 (4.9%) stddev-sans-first:3.76 11:46:58 INFO - PID 12353 | Values: 72.0 73.0 72.0 73.0 73.0 73.0 84.0 73.0 74.0 72.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:117.50 stddev:10.49 (8.9%) stddev-sans-first:11.03 11:46:58 INFO - PID 12353 | Values: 116.0 117.0 116.0 118.0 121.0 116.0 114.0 123.0 110.0 148.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.00 stddev:5.44 (3.4%) stddev-sans-first:5.63 11:46:58 INFO - PID 12353 | Values: 158.0 159.0 162.0 157.0 160.0 168.0 156.0 172.0 156.0 165.0 11:46:58 INFO - PID 12353 | 11:46:58 INFO - PID 12353 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.50 Median:59.00 stddev:1.58 (2.7%) stddev-sans-first:1.58 11:46:58 INFO - PID 12353 | Values: 60.0 60.0 58.0 59.0 57.0 58.0 57.0 56.0 61.0 59.0 11:46:58 INFO - PID 12353 | -------- Summary: end -------- 11:46:58 INFO - PID 12353 | 11:46:59 INFO - PID 12353 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:46:59 INFO - TEST-INFO | 12353: exit 0 11:46:59 INFO - TEST-OK | kraken | took 59862ms 11:46:59 INFO - SUITE-END | took 1169s 11:46:59 INFO - Completed test suite (00:19:29) 11:46:59 INFO - javascript benchmark 11:46:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9131.799577815715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3565.0909018200373, 3579.785212887226, 3581.6597423244784, 3585.0858031202047, 3611.404118320477, 6362.777302794403, 6375.0, 6423.3897779710915, 6441.838954026151, 6465.094886715858, 6307.211598550181, 6373.490120790349, 6377.394147555986, 6391.616503009823, 6446.387593178641, 5468.808591699291, 5594.0, 5615.887682246353, 5673.943260567404, 5699.2590963174725, 5604.887902241952, 5652.802151924683, 5672.574556908227, 5714.571407144481, 5724.370319264877, 5467.562594992431, 5604.495595396393, 5628.789810190788, 5670.3479099903425, 5676.545876329884, 5577.386487486414, 5608.663480191201, 5616.157576363537, 5626.352969408488, 5643.661380317194, 5572.0, 5595.328560572717, 5605.495505404492, 5628.380878103405, 5652.0, 6147.262328520562, 6246.500279977591, 6256.8424841404485, 6261.342559031282, 6400.167978162855, 6733.956236783307, 6771.950347696115, 6788.422984046362, 6789.422899053587, 6944.826379340557, 6976.232614412411, 6990.335918087773, 7022.613756243404, 7056.717731290742, 7059.258777828305, 6324.209473815773, 6460.709268082947, 6463.418292353664, 6514.088027676129, 6524.217093948709, 6940.063091482585, 6941.826454338682, 6945.062416573799, 6945.201301850352, 6977.232504424509, 6528.118703974903, 6536.575122617015, 6582.44049255809, 6662.533622646465, 6685.832854178587, 6942.271061538567, 6951.409130223887, 7000.474964377692, 7009.894851577231, 7010.263922288086, 6810.557313774688, 6818.352256535721, 6838.111045564045, 6881.41507971818, 6885.483588730765, 6712.865742685119, 6750.426213771786, 6854.862902741917, 6911.89632155518, 6933.757318493828, 5021.623378246646, 5077.669951453144, 5077.746112694351, 5081.339425874687, 5114.0, 4575.81696732127, 4587.931181032287, 4614.446266448048, 4631.490536041033, 4638.350630911675, 6548.952167653152, 6591.110200122922, 6593.637349945703, 6667.099941507834, 6688.063671086052, 6804.421624161902, 6871.312868713188, 6907.309269073053, 6949.235584085746, 7018.789436316919, 6490.2536208335705, 6511.674416279167, 6512.837179070561, 6559.47524198063, 6679.398854103154, 5830.5044071254415, 5838.0, 5915.319738230159, 5934.643921364732, 5944.108383742473, 7126.073610430611, 7130.679119439741, 7135.678894449762, 7231.059962204879, 7240.9637951810955, 6825.2833452486775, 6886.208086070166, 6943.51395402317, 6984.092068031327, 6996.755113571001, 7113.857722845618, 7159.534630249017, 7212.386947109345, 7242.601656908921, 7255.0, 6818.488613353919, 6834.658267086526, 6845.589264644137, 6896.2069362022, 6896.551724137915, 6808.148981377328, 6811.65941702903, 6847.828804279933, 6974.267701891228, 7033.437325014089, 6715.764948226789, 6777.2883847195335, 6787.321267873173, 6800.421964133104, 6815.69329380189, 6604.801855944329, 6678.699458524281, 6688.464922806066, 6700.93299067003, 6756.290589488033, 6678.031685405686, 6691.832704182434, 6701.396874281338, 6705.765298214539, 6709.127813384229, 6697.799066028027, 6740.12378390806, 6773.458123350021, 6830.726770929107, 6870.553414028072, 6499.415052645285, 6560.9343906560325, 6566.507511936719, 6655.800325990228, 6657.600543967377], "value": 6289.562161099105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.4120381858447, 888.3391983352232, 908.4231512989252, 935.3966691483989, 936.6113063078818, 42149.57850421495, 42941.570584294146, 43009.139817203635, 43019.13961720768, 43024.78487607557, 39685.0, 39731.0, 39973.60026399735, 40087.799561002226, 40208.59791402085, 6915.1701795784575, 7035.894461583081, 7074.717011319541, 7080.85838283234, 7083.291670832927, 6867.965660171717, 6930.376266136047, 6938.757143499978, 6940.0, 6964.477664175207, 6920.688569014381, 7736.497127686711, 7923.960380198091, 7931.246531579491, 7954.602269886512, 7850.097238817523, 7856.803579910491, 7881.8029549261155, 7894.250046245597, 7924.286814186751, 7733.690652373898, 7803.765887023398, 7808.843823123506, 7810.258025487569, 7828.5694286814205, 40400.1919961602, 40529.189416211804, 40663.0, 40792.59207407918, 40818.795906020576, 3674.2467794102145, 3715.7956312402807, 3717.5910649828497, 3724.646158614927, 3736.290104880064, 33257.83371083153, 33351.332973340395, 33393.49909751356, 33434.49848252278, 33482.162945926306, 5151.690898546061, 5185.818496352647, 5210.713410762407, 5229.555487783543, 5241.3710354757295, 219819.0, 221847.0, 222895.0, 226495.0, 238282.0, 53653.731731341875, 53847.0, 53910.46089539054, 53913.46086539163, 53931.730341348826, 55583.16625250624, 55991.72004139953, 56030.0, 56177.43822561804, 56194.0, 16926.0, 17080.743788843178, 17100.230489627997, 17108.82891171097, 17220.138993050547, 13905.235212063231, 13968.58094257174, 14036.578902632937, 14043.578692639237, 14046.1572305662, 15290.388384464497, 15361.231938403258, 15498.767518487231, 15620.594146526868, 15669.0, 5912.881742365129, 5968.0, 6083.6045657032155, 6086.421789929949, 6086.573939824259, 1082.8971247731454, 1097.4074000040048, 1100.884407137255, 1108.8336749487642, 1116.609186784635, 25656.0, 25716.742832571435, 25899.223023309332, 26078.34804129912, 26100.477990440086, 1190.6844686158174, 1208.1422190244848, 1216.707990082374, 1216.9756604867853, 1223.9143259971895, 13633.795493067611, 13653.658658533615, 13668.17990920528, 17930.19314130867, 18637.347692830685, 283074.0, 290771.0, 290836.0, 291109.0, 291393.0, 62720.686396567726, 63525.36474635287, 63588.0, 63637.04544431837, 63666.0, 1496.1546726099718, 1508.9170095644845, 1521.25458525324, 1536.454558631692, 1539.5535294764393, 30870.935045611695, 31204.687953120178, 31290.0, 31432.0, 31676.683233167372, 42483.0, 42726.78636606797, 42743.358849616656, 42777.358339624305, 42826.78586607047, 241908.0, 245401.0, 245730.0, 246150.0, 246854.0, 36676.26647466982, 36683.89948301555, 39252.803735981135, 39257.607423925394, 39284.0, 49082.0, 49290.26064608962, 49707.502924970286, 49897.0, 49971.500284996684, 36485.27029459449, 36662.450063249606, 36685.449718253716, 36838.79909463449, 36949.81525092357, 35836.82081589576, 36101.0, 36405.27189456249, 36918.154092295816, 36968.44547331846, 41278.38082428706, 41605.0, 42080.15839683128, 42481.57518424776, 42810.1437971245, 35022.47466287957, 35257.471137932436, 35312.47031294481, 35378.46932295966, 35839.82080089583, 26276.08033718811, 26455.867720661274, 26899.73100268972, 27174.72825271722, 27270.181894542402], "value": 18777.105495733143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.2297501760204, 595.244040069112, 604.5919004671846, 616.8427051101968, 632.5319263744829, 23821.76178238217, 24340.148094816686, 24367.512649746994, 24382.268531944024, 24689.876550617268, 26783.866080669617, 26887.32781680459, 27281.45437091257, 27499.31251718708, 27571.862140689267, 6292.779752708656, 6460.612363258196, 6468.223813142406, 6468.708908099147, 6472.805815825533, 5887.411258874121, 6114.633122012693, 6390.105385246069, 6391.744330226786, 6398.13625160602, 6324.588901721373, 6371.012493063583, 6375.617462952215, 6381.425671689547, 6381.840453988664, 6313.084602732601, 6345.8413539661415, 6349.777757778479, 6365.140706004677, 6373.585716928431, 5945.137954996545, 5952.642841429528, 5972.223610930595, 6000.8499787505225, 6005.759769609211, 29621.703782962326, 30731.38537229243, 30886.0, 31024.0692779217, 31414.528782068057, 2289.198780426854, 2321.3500219938446, 2328.8253380996493, 2347.424880904189, 2349.01341436597, 20084.096215670328, 20422.08100635475, 20541.38375848727, 20616.38150855477, 20616.896915515477, 2409.33743220614, 2462.741412151734, 2496.962545561818, 2505.549001179787, 2511.824172307939, 153299.23350383175, 156158.21920890323, 156869.0, 156908.0, 158257.0, 16002.519924402053, 16152.676946461004, 16218.837811621968, 16235.512934611981, 17441.389551365643, 25715.09997150091, 25733.74266257351, 25762.0, 25796.48407031849, 25833.354166145997, 11174.888251117385, 11206.719832004264, 11267.154963377616, 11390.886091139148, 11464.770704585862, 9249.630014799333, 10413.219008574388, 10419.843702344471, 10515.24291447513, 10611.469426528643, 8934.553272336358, 9868.111869931741, 10261.179105671677, 10317.821282380648, 10384.169266458664, 2895.5077636801793, 2914.184028472031, 2946.911592652224, 2959.615250017527, 2989.790714649997, 1073.8174510333263, 1076.56399158341, 1089.722120859176, 1092.3882625729616, 1095.2606990281529, 22466.55066898653, 26539.0, 27408.7666055028, 28229.858850705616, 28581.99963001285, 1123.7920984617872, 1159.837622732818, 1168.6727716239466, 1170.3796987596588, 1184.7867383870814, 12115.39423028845, 12676.746465070646, 12982.740345193044, 13051.28217948003, 13067.738645227042, 602948.0, 617751.0, 618253.0, 630282.0, 632495.0, 142345.0, 143029.0, 147111.0, 149759.0, 150928.0, 1303.850057243429, 1331.2811082015796, 1352.6618345413647, 1358.3140514040347, 1375.7454870848726, 23175.0, 23185.3044408668, 23450.648240276067, 23502.294931152093, 23742.0, 64663.0, 64817.67591162014, 65225.347746523825, 66335.66832165809, 67667.66166169138, 81446.59276703579, 81611.0, 81657.59171204106, 81701.0, 82265.58867205626, 13797.0, 15678.216089195723, 15679.216039198223, 15881.126538040518, 15919.602009949844, 24877.502449951262, 24921.875390622932, 24975.375615609755, 25141.24576262715, 25197.622035669112, 19293.421197364103, 19792.307269245506, 19871.30450434228, 19914.60170796605, 20015.899920500306, 17063.23215455283, 17435.215415306087, 17659.646807064044, 17736.467905962843, 17889.19498622591, 20342.694859577416, 20728.06723697407, 20803.271885483937, 20932.686009709563, 21030.0, 15412.383504660136, 15504.612384690021, 15629.452969146025, 15660.138692371573, 15669.0, 20028.699569506178, 20069.197232110553, 20088.096035678136, 20099.79900201038, 20102.69845952341], "value": 13132.691220087105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.3222717549927, 1500.3623460029485, 1503.9398424063031, 1517.150395778364, 1532.7087853307871, 15475.303611337502, 16110.677786444294, 16117.113558754263, 16123.758143627854, 16151.596210094738, 15555.84444155558, 16515.917420412912, 16707.498775036736, 16724.749128763047, 16735.246913888874, 2933.208033830875, 2976.0, 3015.2311160654003, 3027.545868119789, 3030.772692048094, 2878.0934005788213, 2914.3005678637082, 2970.5841182234503, 2976.0774160010465, 3027.3339865229614, 2939.3974235281717, 2972.7770417218794, 2987.5668028135906, 3002.4145291668024, 3003.1140813459974, 2847.1316248544185, 2896.6234389529436, 2900.65192176938, 2905.404392099625, 2914.810537315089, 2863.21261653045, 2869.6126022986837, 2875.0081221978385, 2881.2652773542823, 2881.4957382458197, 15875.920620396939, 15883.682326353408, 16022.75965860513, 16052.678946421007, 16086.0, 8634.870476942851, 8901.866472002925, 8925.285977121815, 8929.508877011827, 8936.46381217129, 5527.115661494142, 5543.6396634218645, 5574.1917421973585, 5860.150278209679, 5927.644341339534, 1879.4549580621604, 1881.67070762616, 1908.8568357373254, 1914.5213696575856, 1923.144200830631, 27519.31201719953, 28386.432271354664, 28419.14742557706, 28449.715502844912, 28474.857625711946, 7234.0, 7268.345848873627, 7328.9267107329315, 7354.485186037033, 7433.0, 18610.720839187423, 18612.813871861108, 18616.441506754818, 18623.81376186221, 18629.534261643566, 8426.747197584082, 8462.87305690415, 8567.0, 8582.65669373218, 8593.785155371166, 7834.960825195838, 7962.2037796221075, 8197.016358037074, 8201.22088401601, 8208.712695055645, 5371.462853714597, 5708.600397972102, 6005.549583781234, 6067.908981365194, 6107.511399088063, 1620.9756853647204, 1666.9166541672869, 1667.5414261078301, 1671.707451196036, 1689.341156948791, 930.4789317981952, 952.9428234305964, 959.1799011844912, 970.0929630795229, 970.1656575345197, 8766.123387661182, 9178.449293042439, 9179.082091790768, 9187.173154416001, 9314.394564353295, 1057.534684738728, 1074.5594306334365, 1074.897884700952, 1075.3494136047734, 1097.7584931315098, 4896.608271338356, 5551.306086739158, 5712.914306285409, 5788.363280039192, 5998.730057147439, 22737.31788046361, 23173.53652926966, 23504.647430288558, 23508.41228969255, 23526.176583819484, 22788.0, 22903.88548057249, 22918.42703932415, 22997.310080697607, 24338.756612434005, 12973.41619627119, 13147.60557183286, 13217.537386191438, 13253.933730331479, 13277.535286265127, 9033.277337812828, 9092.545372731469, 9487.241020718464, 9553.952230238805, 9556.378835375679, 20158.39524814258, 20203.696944546136, 20569.382918512467, 20913.686294705894, 21102.26142085081, 21149.68275475838, 21405.250816221356, 21449.892750536772, 21612.567748645255, 21756.34730958074, 13335.199888006751, 13561.864381356454, 13683.179009259477, 13699.315034248048, 13701.45194192261, 14875.628109297355, 14939.77590336124, 14963.102213867203, 14995.325210365778, 15051.548453546411, 11269.436528173395, 11845.289282643069, 11997.340146291688, 12071.517139314328, 12169.878301216875, 11552.0, 11789.174757766874, 11900.821487677866, 12026.699332516757, 12120.515179392725, 10301.35178371457, 10502.369857808557, 10506.579736810441, 10507.632232872118, 10514.106300964504, 8146.674133034612, 8173.305269052197, 8296.917030829856, 8336.749897503085, 8353.624086915981, 8048.517088974446, 8098.83802323962, 8139.1453897339925, 8148.755537333889, 8163.7142700005215], "value": 7277.029605228739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.208056874404, 534.9518543331101, 558.416454804729, 563.1046635849001, 563.7463141586287, 6239.25128984522, 6248.4688801451875, 6310.495160387175, 6334.271558770743, 6356.3325850785695, 5973.581849270553, 6068.180795592593, 6154.384561543855, 6154.723037463314, 6184.721687524061, 4820.686655367407, 4821.54195351441, 4835.516448355154, 4837.177679794443, 4842.467328593852, 4752.572268495835, 4864.294677271793, 4864.683795553296, 4888.828890988816, 4898.0, 4778.617710583162, 4811.566958973692, 4859.757012149396, 4869.196582563873, 4870.245112007645, 4835.734034628094, 4867.659263851532, 4889.633277504184, 4897.951020489821, 4916.483769204217, 4392.38506609075, 4411.955880441186, 4450.955490445086, 4489.685721999462, 4494.438195225597, 6094.146819445281, 6114.908276375858, 6117.5717699761035, 6151.938480615226, 6154.692265386713, 5734.254546908917, 5824.359320474744, 5895.498882594985, 5913.645181289136, 5920.733566989496, 6613.93386066138, 6629.569078009914, 6675.666216689195, 6692.816989381637, 6700.765473208463, 5111.591072714174, 5114.897702045975, 5120.667156634844, 5125.513076257749, 5127.512886275797, 6985.26654701249, 6985.930140698579, 6987.196472405688, 7019.473539484508, 7063.011178435023, 5184.533391994663, 5185.325907631984, 5189.327496339388, 5202.505761952609, 5212.869678258074, 5244.947550524446, 5272.525472707398, 5279.86482906177, 5291.576673866081, 5296.682199067991, 5814.796482123105, 5838.182654428383, 5844.357120716718, 5846.386129456431, 5866.266716660418, 6458.225012998376, 6539.149910511603, 6568.408843204039, 6698.229703584053, 6715.764948226789, 1780.8753387263027, 1793.7399077133744, 1821.3807305516189, 1822.0161112998833, 1829.4237315245655, 1269.3272565540094, 1284.6659868434274, 1300.8048792681172, 1310.2073245686413, 1310.2924420812653, 6406.839829004219, 6442.098106265126, 6450.0647406125845, 6477.4170324671, 6490.870182596322, 6500.252470965805, 6798.558093723892, 6820.6930688119155, 6864.622445765531, 6873.690683919235, 6437.9678101610125, 6441.710123044474, 6447.806565803034, 6490.383413575702, 6492.383223593751, 3590.3537363274863, 3630.6006339302658, 3649.908752281161, 3655.451682247684, 3663.5054267674054, 6913.446924246149, 6985.860282794316, 7091.361777440055, 7119.288071192943, 7130.465215108888, 6837.0, 7011.949801836217, 7037.120359955005, 7042.92957070433, 7046.823829404306, 7039.0, 7046.154461464657, 7071.292870712888, 7101.751438699621, 7105.32499412555, 6793.558418702769, 6866.485013623898, 6877.828054298682, 6885.208201056943, 6969.337912898267, 6536.150300460909, 6665.166854143232, 6735.158105236846, 6742.325767423218, 6807.829804254933, 7003.719851206099, 7004.509684322048, 7042.22535521082, 7091.539049961736, 7091.680874360563, 5152.27868098474, 5157.742112894415, 5180.093483640423, 5191.195364718475, 5196.272521846869, 6594.406503414716, 6799.89800153008, 6821.829454263683, 6848.383645471931, 6875.965620171867, 6371.39471750183, 6556.2788093308745, 6618.0, 6638.468922486286, 6668.266490685924, 6440.232464008607, 6542.54202205841, 6550.47596192313, 6552.803415897531, 6563.278039415756, 6548.8035358939305, 6571.408573228432, 6620.172478440195, 6622.801315960529, 6653.367930046637, 6559.4752419805345, 6682.131322927989, 6682.560865284234, 6731.798046058626, 6738.225104113089, 6409.166808315075, 6460.289368169591, 6472.255690595642, 6517.315681853527, 6518.641474718746], "value": 5189.238670403281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [954.1317401164941, 954.4654993203807, 985.5417230987589, 995.4226548601812, 1000.574755728815, 19276.228950841967, 19834.008299585017, 19889.602207955868, 19910.800891991094, 22679.659805102936, 21810.345689629296, 22692.205772797955, 22697.0, 22856.08575656976, 22856.65715014272, 1069.5294070608945, 1099.3953325670889, 1099.76355083657, 1102.735343517558, 1104.5305745058358, 1084.078533246742, 1100.372787511119, 1101.0860985382153, 1101.6639924822925, 1102.08526922654, 1113.4265853085667, 1147.1912301827192, 1149.8735139134687, 1150.6375491720123, 1151.4933429291086, 1136.0797753819434, 1143.771245750849, 1145.2040831622026, 1146.3866831245243, 1147.6671765188084, 797.314309693663, 806.6410447350931, 811.1280373598405, 812.3338862133053, 817.0889458254063, 20434.182632694676, 20697.896510517352, 20738.170473181053, 20775.58448831015, 21047.368578942656, 21634.78365216359, 21636.24273150432, 21717.67423488649, 21771.346859594236, 22364.552708945892, 16998.06510641914, 17182.39861604838, 17370.305187792474, 17436.389726359645, 17547.5613109672, 3767.9246415071543, 3774.2451509697894, 3778.149916268845, 3780.1683629601443, 3790.166163444038, 148442.0, 149241.99999999892, 150572.0, 150918.0, 151312.0, 14817.629559261104, 15953.202339882959, 16299.266533005806, 16382.180890955404, 16406.09766462856, 32636.518558127995, 32846.0, 33232.501512477334, 33238.16904577405, 33679.83160084233, 9503.42979421223, 9625.229981601455, 9633.181179599673, 9634.181094606896, 9665.565049572786, 4650.162970665313, 4663.137319595886, 4670.322803193518, 4730.195866702668, 4744.59670927975, 5518.061929471999, 5545.1682247663175, 5616.606837521416, 5626.212330273765, 5645.661260324394, 1153.2792004996877, 1159.8202278646822, 1193.9910775394778, 1201.8077107662907, 1207.5109580619687, 758.3364556013488, 761.588742079282, 780.2080887898787, 784.6861255497846, 795.0777098565752, 12813.807792883114, 13392.263425511495, 13641.0, 13785.586432407044, 13941.093828901088, 756.3759898083993, 758.8102974256436, 762.0969151555424, 763.1719584251039, 769.9961500192463, 6405.167328247298, 6431.967840160769, 6454.451371633464, 6509.218893732783, 6568.934310656832, 129219.35390322989, 129979.35010324889, 130769.0, 133466.33266833605, 136284.0, 111505.44247278712, 113169.0, 113241.0, 115310.42344788222, 116917.0, 94855.0, 96430.0, 97211.0, 98189.0, 98428.5078574617, 12546.121771476273, 12572.559960401342, 12619.49522019109, 12641.93679031599, 12660.810087848873, 46191.30713039375, 46877.531224687315, 47227.52772472231, 47467.52532474631, 47951.5204847947, 61688.0, 61912.38087619066, 61919.0, 61954.0, 62675.6866215666, 16982.490525284262, 17125.14374281306, 17163.141842907557, 17255.309787608356, 17366.39217627377, 18673.439796806117, 18833.0, 18895.43313700591, 19083.427497175107, 19224.13491392863, 16793.41223057187, 17176.914115429343, 17245.22396492136, 17393.478195654152, 22019.339419817432, 21480.570388592452, 21581.46046348854, 21793.891030544746, 21803.0, 22163.889180553993, 19744.40766776999, 19770.802291976896, 19848.30530931468, 19973.60052798965, 20757.584848302646, 14724.190169540778, 15195.696086078438, 15497.5350739478, 15651.921740391224, 15967.680646386774, 14516.419343226153, 14791.852081479477, 16135.75796363032, 16391.91804040972, 16642.916785415997], "value": 9900.349274811346, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 98.0, 106.0, 105.0, 106.0, 113.0, 99.0, 106.0, 107.0], "value": 104.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 114.0, 140.0, 165.0, 112.0, 147.0, 138.0, 118.0, 161.0, 114.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 186.0, 75.0, 75.0, 74.0, 77.0, 151.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 129.0, 79.0, 78.0, 76.0, 122.0, 79.0, 78.0, 127.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 151.0, 150.0, 147.0, 148.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 93.0, 93.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 45.0, 46.0, 50.0, 50.0, 46.0, 45.0, 45.0, 46.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 53.0, 51.0, 55.0, 51.0, 51.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 84.0, 73.0, 74.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 118.0, 121.0, 116.0, 114.0, 123.0, 110.0, 148.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 162.0, 157.0, 160.0, 168.0, 156.0, 172.0, 156.0, 165.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 58.0, 59.0, 57.0, 58.0, 57.0, 56.0, 61.0, 59.0], "value": 58.5, "unit": "score"}]}]} 11:47:00 INFO - Return code: 0 11:47:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:47:00 INFO - # TBPL SUCCESS # 11:47:00 INFO - Running post-action listener: _package_coverage_data 11:47:00 INFO - Running post-action listener: _resource_record_post_action 11:47:00 INFO - [mozharness: 2017-08-17 18:47:00.074697Z] Finished run-tests step (success) 11:47:00 INFO - Running post-run listener: _resource_record_post_run 11:47:00 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 499712; Write bytes: 375754752; Read time: 32; Write time: 321596 11:47:00 INFO - TinderboxPrint: CPU usage
13.0% 11:47:00 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 32 11:47:00 INFO - TinderboxPrint: I/O write bytes / time
375,754,752 / 321,596 11:47:00 INFO - TinderboxPrint: CPU idle
8,217.9 (87.0%) 11:47:00 INFO - TinderboxPrint: CPU user
1,183.0 (12.5%) 11:47:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:47:00 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 98422784; Read time: 0; Write time: 130992 11:47:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:47:00 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 495616; Write bytes: 276926464; Read time: 24; Write time: 190540 11:47:00 INFO - Running post-run listener: _upload_blobber_files 11:47:00 INFO - Blob upload gear active. 11:47:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:00 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:47:00 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:47:00 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:47:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:02 INFO - (blobuploader) - INFO - Done attempting. 11:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:02 INFO - (blobuploader) - INFO - Done attempting. 11:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:03 INFO - (blobuploader) - INFO - Done attempting. 11:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:10 INFO - (blobuploader) - INFO - Done attempting. 11:47:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:10 INFO - Return code: 0 11:47:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3092d9d8ef6ea3853a35f1f5bfcdf19183d98bb81b08b0d6075d03af43532540aab32cb8b3c5bf6af7069f29f60c0e9f1778c0764711d5c1af64ecda90ab8501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3076a88f90fbd2af9a864ebf4f45feec9838167eaa30eb1956fefe9e41541248e2048b9a5689580827fd6266ef41d9f4dc1a29930009015d458d9e1095a99a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/66a2e73068d81946fe588239ce92a569250407e978b4867421c03131be4616bce19ac0ac2e229d5c58885c9f882e1fbf56afce50f555696817c99a4c15ecebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d64d995362e9d290037dafed7ce08f74db1e2f3aab5b4e453adf4cd6f9b0bb50b1ba78f26f235dc632446a25f32b94e29da4549b1014f5229cd09c5837c61fd7"} 11:47:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:10 INFO - Contents: 11:47:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3092d9d8ef6ea3853a35f1f5bfcdf19183d98bb81b08b0d6075d03af43532540aab32cb8b3c5bf6af7069f29f60c0e9f1778c0764711d5c1af64ecda90ab8501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3076a88f90fbd2af9a864ebf4f45feec9838167eaa30eb1956fefe9e41541248e2048b9a5689580827fd6266ef41d9f4dc1a29930009015d458d9e1095a99a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/66a2e73068d81946fe588239ce92a569250407e978b4867421c03131be4616bce19ac0ac2e229d5c58885c9f882e1fbf56afce50f555696817c99a4c15ecebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d64d995362e9d290037dafed7ce08f74db1e2f3aab5b4e453adf4cd6f9b0bb50b1ba78f26f235dc632446a25f32b94e29da4549b1014f5229cd09c5837c61fd7"} 11:47:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:10 INFO - Copying logs to upload dir... 11:47:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.323149 ========= master_lag: -0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-17 11:47:09.825074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:47:09.829248) ========= 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=781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3092d9d8ef6ea3853a35f1f5bfcdf19183d98bb81b08b0d6075d03af43532540aab32cb8b3c5bf6af7069f29f60c0e9f1778c0764711d5c1af64ecda90ab8501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3076a88f90fbd2af9a864ebf4f45feec9838167eaa30eb1956fefe9e41541248e2048b9a5689580827fd6266ef41d9f4dc1a29930009015d458d9e1095a99a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/66a2e73068d81946fe588239ce92a569250407e978b4867421c03131be4616bce19ac0ac2e229d5c58885c9f882e1fbf56afce50f555696817c99a4c15ecebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d64d995362e9d290037dafed7ce08f74db1e2f3aab5b4e453adf4cd6f9b0bb50b1ba78f26f235dc632446a25f32b94e29da4549b1014f5229cd09c5837c61fd7"} build_url:https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/IDjId5HVRCe09dNm3x4RLg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3092d9d8ef6ea3853a35f1f5bfcdf19183d98bb81b08b0d6075d03af43532540aab32cb8b3c5bf6af7069f29f60c0e9f1778c0764711d5c1af64ecda90ab8501", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3076a88f90fbd2af9a864ebf4f45feec9838167eaa30eb1956fefe9e41541248e2048b9a5689580827fd6266ef41d9f4dc1a29930009015d458d9e1095a99a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/66a2e73068d81946fe588239ce92a569250407e978b4867421c03131be4616bce19ac0ac2e229d5c58885c9f882e1fbf56afce50f555696817c99a4c15ecebb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d64d995362e9d290037dafed7ce08f74db1e2f3aab5b4e453adf4cd6f9b0bb50b1ba78f26f235dc632446a25f32b94e29da4549b1014f5229cd09c5837c61fd7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:47:09.855316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:47:09.855601) ========= 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=781b77c4c33858b1f599d705000001c1-1502994379.714413-1901687727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:47:09.937573) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:47:09.940869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:47:09.941147) ========= ========= Total master_lag: -0.23 =========