builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1503071657.15 results: success (0) revision: 554f6e2674fecadc3a66ec5a497bcaf7064068ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.146748) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.147198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.147504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.172575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.172865) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 08:54:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-08-18 08:54:17 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.210700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.403594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.403923) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017653 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:17.457654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-08-18 08:54:17.457991) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 554f6e2674fecadc3a66ec5a497bcaf7064068ee --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 554f6e2674fecadc3a66ec5a497bcaf7064068ee --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=9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 08:54:17,692 truncating revision to first 12 chars 2017-08-18 08:54:17,692 Setting DEBUG logging. 2017-08-18 08:54:17,692 attempt 1/10 2017-08-18 08:54:17,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/554f6e2674fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 08:54:18,781 unpacking tar archive at: mozilla-beta-554f6e2674fe/testing/mozharness/ program finished with exit code 0 elapsedTime=2.422243 ========= master_lag: 1.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-08-18 08:54:20.897300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:20.897641) ========= script_repo_revision: 554f6e2674fecadc3a66ec5a497bcaf7064068ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:20.903096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:20.903414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 08:54:20.925461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-18 08:54:20.925828) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:54:21 INFO - MultiFileLogger online at 20170818 08:54:21 in /builds/slave/test 08:54:21 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 08:54:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:21 INFO - {'append_to_log': False, 08:54:21 INFO - 'base_work_dir': '/builds/slave/test', 08:54:21 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:54:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:21 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:54:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:21 INFO - 'code_coverage': False, 08:54:21 INFO - 'config_files': ('talos/linux_config.py',), 08:54:21 INFO - 'default_actions': ('clobber', 08:54:21 INFO - 'read-buildbot-config', 08:54:21 INFO - 'download-and-extract', 08:54:21 INFO - 'populate-webroot', 08:54:21 INFO - 'create-virtualenv', 08:54:21 INFO - 'install', 08:54:21 INFO - 'setup-mitmproxy', 08:54:21 INFO - 'run-tests'), 08:54:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:21 INFO - 'disable_ccov_upload': False, 08:54:21 INFO - 'download_minidump_stackwalk': True, 08:54:21 INFO - 'download_symbols': 'ondemand', 08:54:21 INFO - 'enable_stylo': False, 08:54:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:21 INFO - 'gecko_profile': False, 08:54:21 INFO - 'gecko_profile_interval': 0, 08:54:21 INFO - 'installer_path': 'installer.exe', 08:54:21 INFO - 'log_level': 'info', 08:54:21 INFO - 'log_name': 'talos', 08:54:21 INFO - 'log_to_console': True, 08:54:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:54:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:54:21 INFO - 'opt_config_files': (), 08:54:21 INFO - 'pip_index': False, 08:54:21 INFO - 'suite': 'dromaeojs-e10s', 08:54:21 INFO - 'system_bits': '32', 08:54:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:21 INFO - 'title': 'talos-linux64-ix-013', 08:54:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:21 INFO - 'use_talos_json': True, 08:54:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:21 INFO - 'work_dir': 'build'} 08:54:21 INFO - [mozharness: 2017-08-18 15:54:21.355918Z] Running clobber step. 08:54:21 INFO - Running pre-action listener: _resource_record_pre_action 08:54:21 INFO - Running main action method: clobber 08:54:21 INFO - rmtree: /builds/slave/test/build 08:54:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:22 INFO - Running post-action listener: _resource_record_post_action 08:54:22 INFO - [mozharness: 2017-08-18 15:54:22.343360Z] Finished clobber step (success) 08:54:22 INFO - [mozharness: 2017-08-18 15:54:22.343461Z] Running read-buildbot-config step. 08:54:22 INFO - Running pre-action listener: _resource_record_pre_action 08:54:22 INFO - Running main action method: read_buildbot_config 08:54:22 INFO - Using buildbot properties: 08:54:22 INFO - { 08:54:22 INFO - "project": "", 08:54:22 INFO - "product": "firefox", 08:54:22 INFO - "who": "ryanvm@gmail.com", 08:54:22 INFO - "installer_path": "public/build/target.tar.bz2", 08:54:22 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:54:22 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:54:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:54:22 INFO - "stage_platform": "linux64", 08:54:22 INFO - "basedir": "/builds/slave/test", 08:54:22 INFO - "buildnumber": 54, 08:54:22 INFO - "platform": "ubuntu64_hw", 08:54:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:54:22 INFO - "slavebuilddir": "test", 08:54:22 INFO - "taskId": "S3p_ZsYVQIytNbT2TPWKVw", 08:54:22 INFO - "branch": "mozilla-beta", 08:54:22 INFO - "script_repo_revision": "production", 08:54:22 INFO - "revision": "554f6e2674fecadc3a66ec5a497bcaf7064068ee", 08:54:22 INFO - "slavename": "talos-linux64-ix-013", 08:54:22 INFO - "repo_path": "releases/mozilla-beta" 08:54:22 INFO - } 08:54:22 INFO - Finding installer, test and symbols from parent task. 08:54:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3p_ZsYVQIytNbT2TPWKVw'}, attempt #1 08:54:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3p_ZsYVQIytNbT2TPWKVw'}, attempt #1 08:54:23 INFO - Task dependencies: DEuWB2k6QUiZM6PwgNLnRg 08:54:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg'}, attempt #1 08:54:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2 08:54:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.test_packages.json 08:54:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.crashreporter-symbols.zip 08:54:23 INFO - Running post-action listener: _resource_record_post_action 08:54:23 INFO - [mozharness: 2017-08-18 15:54:23.737670Z] Finished read-buildbot-config step (success) 08:54:23 INFO - [mozharness: 2017-08-18 15:54:23.737894Z] Running download-and-extract step. 08:54:23 INFO - Running pre-action listener: _resource_record_pre_action 08:54:23 INFO - Running main action method: download_and_extract 08:54:23 INFO - mkdir: /builds/slave/test/build/tests 08:54:23 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')]} 08:54:23 INFO - trying https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.test_packages.json 08:54:23 INFO - Downloading https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:54:24 INFO - Downloaded 989 bytes. 08:54:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:54:24 INFO - Using the following test package requirements: 08:54:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:54:24 INFO - u'common': [u'target.common.tests.zip'], 08:54:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:54:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:54:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:54:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:54:24 INFO - u'mozbase': [u'target.common.tests.zip'], 08:54:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:54:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:54:24 INFO - u'web-platform': [u'target.common.tests.zip', 08:54:24 INFO - u'target.web-platform.tests.tar.gz'], 08:54:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:54:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:54:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.common.tests.zip 08:54:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:24 INFO - Fetch https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.common.tests.zip into memory 08:54:25 INFO - Content-Length response header: 72854434 08:54:25 INFO - Bytes received: 72854434 08:54:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:54:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.common.tests.zip 08:54:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:36 INFO - Fetch https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.common.tests.zip into memory 08:54:37 INFO - Content-Length response header: 72854434 08:54:37 INFO - Bytes received: 72854434 08:54:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.talos.tests.zip 08:54:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:54:52 INFO - Fetch https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.talos.tests.zip into memory 08:54:53 INFO - Content-Length response header: 14496472 08:54:53 INFO - Bytes received: 14496472 08:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:53 INFO - trying https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2 08:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:54:54 INFO - Downloaded 53939014 bytes. 08:54:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2 08:54:54 INFO - mkdir: /builds/slave/test/properties 08:54:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:54 INFO - Contents: 08:54:54 INFO - build_url:https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2 08:54:54 INFO - Running post-action listener: _resource_record_post_action 08:54:54 INFO - Running post-action listener: set_extra_try_arguments 08:54:54 INFO - [mozharness: 2017-08-18 15:54:54.444570Z] Finished download-and-extract step (success) 08:54:54 INFO - [mozharness: 2017-08-18 15:54:54.444667Z] Running populate-webroot step. 08:54:54 INFO - Running pre-action listener: _resource_record_pre_action 08:54:54 INFO - Running main action method: populate_webroot 08:54:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:54:54 INFO - 'tests': ['damp', 'tps']}, 08:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:54:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:54:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:54:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:54 INFO - 'ts_paint', 08:54:54 INFO - 'tpaint', 08:54:54 INFO - 'sessionrestore', 08:54:54 INFO - 'sessionrestore_many_windows', 08:54:54 INFO - 'sessionrestore_no_auto_restore', 08:54:54 INFO - 'tabpaint']}, 08:54:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:54:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:54:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:54:54 INFO - 'talos_options': ['--mitmproxy', 08:54:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:54:54 INFO - '--firstNonBlankPaint'], 08:54:54 INFO - 'tests': ['quantum_pageload_google', 08:54:54 INFO - 'quantum_pageload_youtube', 08:54:54 INFO - 'quantum_pageload_amazon', 08:54:54 INFO - 'quantum_pageload_facebook']}, 08:54:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:54:54 INFO - 'talos_options': ['--stylo', 08:54:54 INFO - '--mitmproxy', 08:54:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:54:54 INFO - '--firstNonBlankPaint'], 08:54:54 INFO - 'tests': ['quantum_pageload_google', 08:54:54 INFO - 'quantum_pageload_youtube', 08:54:54 INFO - 'quantum_pageload_amazon', 08:54:54 INFO - 'quantum_pageload_facebook']}, 08:54:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:54 INFO - 'tsvgr_opacity', 08:54:54 INFO - 'tart', 08:54:54 INFO - 'tscrollx', 08:54:54 INFO - 'cart', 08:54:54 INFO - 'tsvg_static']}, 08:54:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:54:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:54:54 INFO - 'talos_options': ['--stylo', 08:54:54 INFO - '--stylo-threads=1', 08:54:54 INFO - '--mitmproxy', 08:54:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:54:54 INFO - '--firstNonBlankPaint'], 08:54:54 INFO - 'tests': ['tp6_google', 08:54:54 INFO - 'tp6_youtube', 08:54:54 INFO - 'tp6_amazon', 08:54:54 INFO - 'tp6_facebook']}, 08:54:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:54:54 INFO - 'talos_options': ['--xperf_path', 08:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:54 INFO - 'tests': ['tp5n']}}} 08:54:54 INFO - Running post-action listener: _resource_record_post_action 08:54:54 INFO - [mozharness: 2017-08-18 15:54:54.453263Z] Finished populate-webroot step (success) 08:54:54 INFO - [mozharness: 2017-08-18 15:54:54.453372Z] Running create-virtualenv step. 08:54:54 INFO - Running pre-action listener: _resource_record_pre_action 08:54:54 INFO - Running main action method: create_virtualenv 08:54:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:54 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 08:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:54 INFO - Using real prefix '/usr' 08:54:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:57 INFO - Installing pip.................done. 08:54:57 INFO - Return code: 0 08:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:54:57 INFO - Reading from file tmpfile_stdout 08:54:57 INFO - Output received: 08:54:57 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) 08:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:54:57 INFO - Using env: {'DISPLAY': ':0', 08:54:57 INFO - 'HOME': '/home/cltbld', 08:54:57 INFO - 'LANG': 'en_US.UTF-8', 08:54:57 INFO - 'LANGUAGE': 'en_US:en', 08:54:57 INFO - 'LOGNAME': 'cltbld', 08:54:57 INFO - 'MAIL': '/var/mail/cltbld', 08:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:57 INFO - 'MOZ_NO_REMOTE': '1', 08:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:57 INFO - 'NO_EM_RESTART': '1', 08:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:57 INFO - 'PWD': '/builds/slave/test', 08:54:57 INFO - 'SHELL': '/bin/bash', 08:54:57 INFO - 'SHLVL': '1', 08:54:57 INFO - 'TERM': 'linux', 08:54:57 INFO - 'TMOUT': '86400', 08:54:57 INFO - 'USER': 'cltbld', 08:54:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:57 INFO - '_': '/tools/buildbot/bin/python'} 08:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:57 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 08:54:57 INFO - Cleaning up... 08:54:57 INFO - Return code: 0 08:54:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:54:57 INFO - Using env: {'DISPLAY': ':0', 08:54:57 INFO - 'HOME': '/home/cltbld', 08:54:57 INFO - 'LANG': 'en_US.UTF-8', 08:54:57 INFO - 'LANGUAGE': 'en_US:en', 08:54:57 INFO - 'LOGNAME': 'cltbld', 08:54:57 INFO - 'MAIL': '/var/mail/cltbld', 08:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:57 INFO - 'MOZ_NO_REMOTE': '1', 08:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:57 INFO - 'NO_EM_RESTART': '1', 08:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:57 INFO - 'PWD': '/builds/slave/test', 08:54:57 INFO - 'SHELL': '/bin/bash', 08:54:57 INFO - 'SHLVL': '1', 08:54:57 INFO - 'TERM': 'linux', 08:54:57 INFO - 'TMOUT': '86400', 08:54:57 INFO - 'USER': 'cltbld', 08:54:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:57 INFO - '_': '/tools/buildbot/bin/python'} 08:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:57 INFO - Downloading/unpacking psutil>=3.1.1 08:54: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 08:54: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 08:54: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 08:54: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 08:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:59 INFO - Installing collected packages: psutil 08:54:59 INFO - Running setup.py install for psutil 08:54:59 INFO - building 'psutil._psutil_linux' extension 08:54:59 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 08:55:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:55:00 INFO - building 'psutil._psutil_posix' extension 08:55:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:55:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:00 INFO - Successfully installed psutil 08:55:00 INFO - Cleaning up... 08:55:00 INFO - Return code: 0 08:55:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55: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')]} 08:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:55: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 mozsystemmonitor==0.3 08:55:00 INFO - Using env: {'DISPLAY': ':0', 08:55:00 INFO - 'HOME': '/home/cltbld', 08:55:00 INFO - 'LANG': 'en_US.UTF-8', 08:55:00 INFO - 'LANGUAGE': 'en_US:en', 08:55:00 INFO - 'LOGNAME': 'cltbld', 08:55:00 INFO - 'MAIL': '/var/mail/cltbld', 08:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:00 INFO - 'MOZ_NO_REMOTE': '1', 08:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:00 INFO - 'NO_EM_RESTART': '1', 08:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:00 INFO - 'PWD': '/builds/slave/test', 08:55:00 INFO - 'SHELL': '/bin/bash', 08:55:00 INFO - 'SHLVL': '1', 08:55:00 INFO - 'TERM': 'linux', 08:55:00 INFO - 'TMOUT': '86400', 08:55:00 INFO - 'USER': 'cltbld', 08:55:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:00 INFO - '_': '/tools/buildbot/bin/python'} 08:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:55: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 08:55: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 08:55: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 08:55: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 08:55:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:55:01 INFO - Installing collected packages: mozsystemmonitor 08:55:01 INFO - Running setup.py install for mozsystemmonitor 08:55:02 INFO - Successfully installed mozsystemmonitor 08:55:02 INFO - Cleaning up... 08:55:02 INFO - Return code: 0 08:55:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:55:02 INFO - Using env: {'DISPLAY': ':0', 08:55:02 INFO - 'HOME': '/home/cltbld', 08:55:02 INFO - 'LANG': 'en_US.UTF-8', 08:55:02 INFO - 'LANGUAGE': 'en_US:en', 08:55:02 INFO - 'LOGNAME': 'cltbld', 08:55:02 INFO - 'MAIL': '/var/mail/cltbld', 08:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:02 INFO - 'MOZ_NO_REMOTE': '1', 08:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:02 INFO - 'NO_EM_RESTART': '1', 08:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:02 INFO - 'PWD': '/builds/slave/test', 08:55:02 INFO - 'SHELL': '/bin/bash', 08:55:02 INFO - 'SHLVL': '1', 08:55:02 INFO - 'TERM': 'linux', 08:55:02 INFO - 'TMOUT': '86400', 08:55:02 INFO - 'USER': 'cltbld', 08:55:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:02 INFO - '_': '/tools/buildbot/bin/python'} 08:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:02 INFO - Downloading/unpacking jsonschema==2.5.1 08:55: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 08:55: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 08:55: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 08:55: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 08:55:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:55: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 08:55: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 08:55: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 08:55: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 08:55:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:03 INFO - warning: no files found matching '*.txt' 08:55:03 INFO - no previously-included directories found matching 'build' 08:55:03 INFO - no previously-included directories found matching 'dist' 08:55:03 INFO - no previously-included directories found matching '.git*' 08:55:03 INFO - Installing collected packages: jsonschema, functools32 08:55:03 INFO - Running setup.py install for functools32 08:55:03 INFO - warning: no files found matching '*.txt' 08:55:03 INFO - no previously-included directories found matching 'build' 08:55:03 INFO - no previously-included directories found matching 'dist' 08:55:03 INFO - no previously-included directories found matching '.git*' 08:55:03 INFO - Successfully installed jsonschema functools32 08:55:03 INFO - Cleaning up... 08:55:03 INFO - Return code: 0 08:55:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55: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')]} 08:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55: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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55: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 08:55: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 08:55:03 INFO - Using env: {'DISPLAY': ':0', 08:55:03 INFO - 'HOME': '/home/cltbld', 08:55:03 INFO - 'LANG': 'en_US.UTF-8', 08:55:03 INFO - 'LANGUAGE': 'en_US:en', 08:55:03 INFO - 'LOGNAME': 'cltbld', 08:55:03 INFO - 'MAIL': '/var/mail/cltbld', 08:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:03 INFO - 'MOZ_NO_REMOTE': '1', 08:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:03 INFO - 'NO_EM_RESTART': '1', 08:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:03 INFO - 'PWD': '/builds/slave/test', 08:55:03 INFO - 'SHELL': '/bin/bash', 08:55:03 INFO - 'SHLVL': '1', 08:55:03 INFO - 'TERM': 'linux', 08:55:03 INFO - 'TMOUT': '86400', 08:55:03 INFO - 'USER': 'cltbld', 08:55:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:03 INFO - '_': '/tools/buildbot/bin/python'} 08:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:55:04 INFO - Cleaning up... 08:55:04 INFO - Return code: 0 08:55:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:55:04 INFO - Using env: {'DISPLAY': ':0', 08:55:04 INFO - 'HOME': '/home/cltbld', 08:55:04 INFO - 'LANG': 'en_US.UTF-8', 08:55:04 INFO - 'LANGUAGE': 'en_US:en', 08:55:04 INFO - 'LOGNAME': 'cltbld', 08:55:04 INFO - 'MAIL': '/var/mail/cltbld', 08:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:04 INFO - 'MOZ_NO_REMOTE': '1', 08:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:04 INFO - 'NO_EM_RESTART': '1', 08:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:04 INFO - 'PWD': '/builds/slave/test', 08:55:04 INFO - 'SHELL': '/bin/bash', 08:55:04 INFO - 'SHLVL': '1', 08:55:04 INFO - 'TERM': 'linux', 08:55:04 INFO - 'TMOUT': '86400', 08:55:04 INFO - 'USER': 'cltbld', 08:55:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:04 INFO - '_': '/tools/buildbot/bin/python'} 08:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:55: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 08:55: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 08:55: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 08:55: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 08:55:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:05 INFO - Downloading docopt-0.6.1.tar.gz 08:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:06 INFO - Running setup.py install for blobuploader 08:55:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:06 INFO - Running setup.py install for requests 08:55:06 INFO - Running setup.py install for docopt 08:55:06 INFO - Successfully installed blobuploader requests docopt 08:55:06 INFO - Cleaning up... 08:55:06 INFO - Return code: 0 08:55:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:55:06 INFO - Using env: {'DISPLAY': ':0', 08:55:06 INFO - 'HOME': '/home/cltbld', 08:55:06 INFO - 'LANG': 'en_US.UTF-8', 08:55:06 INFO - 'LANGUAGE': 'en_US:en', 08:55:06 INFO - 'LOGNAME': 'cltbld', 08:55:06 INFO - 'MAIL': '/var/mail/cltbld', 08:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:06 INFO - 'MOZ_NO_REMOTE': '1', 08:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:06 INFO - 'NO_EM_RESTART': '1', 08:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:06 INFO - 'PWD': '/builds/slave/test', 08:55:06 INFO - 'SHELL': '/bin/bash', 08:55:06 INFO - 'SHLVL': '1', 08:55:06 INFO - 'TERM': 'linux', 08:55:06 INFO - 'TMOUT': '86400', 08:55:06 INFO - 'USER': 'cltbld', 08:55:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:06 INFO - '_': '/tools/buildbot/bin/python'} 08:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:06 INFO - Running setup.py (path:/tmp/pip-wZShPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:06 INFO - Running setup.py (path:/tmp/pip-ISuDpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:06 INFO - Running setup.py (path:/tmp/pip-7QgkNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:07 INFO - Running setup.py (path:/tmp/pip-Da_yky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:07 INFO - Running setup.py (path:/tmp/pip-BsLii4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:07 INFO - Running setup.py (path:/tmp/pip-Gotijn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:07 INFO - Running setup.py (path:/tmp/pip-y7pO9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:07 INFO - Running setup.py (path:/tmp/pip-9t5YXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:07 INFO - Running setup.py (path:/tmp/pip-clgPmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:07 INFO - Running setup.py (path:/tmp/pip-yruhs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:07 INFO - Running setup.py (path:/tmp/pip-aQJYUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:07 INFO - Running setup.py (path:/tmp/pip-SZS7at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:07 INFO - Running setup.py (path:/tmp/pip-dVMtys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:07 INFO - Running setup.py (path:/tmp/pip-qJGnsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:07 INFO - Running setup.py (path:/tmp/pip-YlDGQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:07 INFO - Running setup.py (path:/tmp/pip-lR1f4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:07 INFO - Running setup.py (path:/tmp/pip-W0CiwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:08 INFO - Running setup.py install for manifestparser 08:55:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozcrash 08:55:08 INFO - Running setup.py install for mozdebug 08:55:08 INFO - Running setup.py install for mozdevice 08:55:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozfile 08:55:08 INFO - Running setup.py install for mozhttpd 08:55:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozinfo 08:55:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozInstall 08:55:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:08 INFO - Running setup.py install for mozleak 08:55:08 INFO - Running setup.py install for mozlog 08:55:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for moznetwork 08:55:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozprocess 08:55:09 INFO - Running setup.py install for mozprofile 08:55:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozrunner 08:55:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Running setup.py install for mozscreenshot 08:55:09 INFO - Running setup.py install for moztest 08:55:09 INFO - Running setup.py install for mozversion 08:55:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:09 INFO - Cleaning up... 08:55:09 INFO - Return code: 0 08:55:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:09 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')]} 08:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:09 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')]} 08:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:09 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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55:09 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 08:55:09 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 08:55:09 INFO - Using env: {'DISPLAY': ':0', 08:55:09 INFO - 'HOME': '/home/cltbld', 08:55:09 INFO - 'LANG': 'en_US.UTF-8', 08:55:09 INFO - 'LANGUAGE': 'en_US:en', 08:55:09 INFO - 'LOGNAME': 'cltbld', 08:55:09 INFO - 'MAIL': '/var/mail/cltbld', 08:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:09 INFO - 'MOZ_NO_REMOTE': '1', 08:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:09 INFO - 'NO_EM_RESTART': '1', 08:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:09 INFO - 'PWD': '/builds/slave/test', 08:55:09 INFO - 'SHELL': '/bin/bash', 08:55:09 INFO - 'SHLVL': '1', 08:55:09 INFO - 'TERM': 'linux', 08:55:09 INFO - 'TMOUT': '86400', 08:55:09 INFO - 'USER': 'cltbld', 08:55:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:09 INFO - '_': '/tools/buildbot/bin/python'} 08:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:10 INFO - Running setup.py (path:/tmp/pip-ZBlmf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:10 INFO - Running setup.py (path:/tmp/pip-4quYFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:10 INFO - Running setup.py (path:/tmp/pip-V4QLhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:10 INFO - Running setup.py (path:/tmp/pip-0xkTeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:10 INFO - Running setup.py (path:/tmp/pip-h9FTke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:10 INFO - Running setup.py (path:/tmp/pip-WBMPm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:10 INFO - Running setup.py (path:/tmp/pip-Uy5gwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:10 INFO - Running setup.py (path:/tmp/pip-Wqw2Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:10 INFO - Running setup.py (path:/tmp/pip-Lp2Lpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:10 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)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:10 INFO - Running setup.py (path:/tmp/pip-9Wsu4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:10 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)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:10 INFO - Running setup.py (path:/tmp/pip-pVtIYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55: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)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:10 INFO - Running setup.py (path:/tmp/pip-iNh4wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55: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)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:10 INFO - Running setup.py (path:/tmp/pip-0XUmi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55: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)) 08:55:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:11 INFO - Running setup.py (path:/tmp/pip-7zqUc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:11 INFO - Running setup.py (path:/tmp/pip-f5N9rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:11 INFO - Running setup.py (path:/tmp/pip-lm06cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:55:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:11 INFO - Running setup.py (path:/tmp/pip-aAQ5N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:55:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:12 INFO - Downloading blessings-1.6.tar.gz 08:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:55:12 INFO - Installing collected packages: blessings 08:55:12 INFO - Running setup.py install for blessings 08:55:12 INFO - Successfully installed blessings 08:55:12 INFO - Cleaning up... 08:55:12 INFO - Return code: 0 08:55:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:55:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:12 INFO - Reading from file tmpfile_stdout 08:55:12 INFO - Current package versions: 08:55:12 INFO - argparse == 1.2.1 08:55:12 INFO - blessings == 1.6 08:55:12 INFO - blobuploader == 1.2.4 08:55:12 INFO - docopt == 0.6.1 08:55:12 INFO - functools32 == 3.2.3-2 08:55:12 INFO - jsonschema == 2.5.1 08:55:12 INFO - manifestparser == 1.1 08:55:12 INFO - mozInstall == 1.13 08:55:12 INFO - mozcrash == 1.0 08:55:12 INFO - mozdebug == 0.1 08:55:12 INFO - mozdevice == 0.51 08:55:12 INFO - mozfile == 1.2 08:55:12 INFO - mozhttpd == 0.7 08:55:12 INFO - mozinfo == 0.10 08:55:12 INFO - mozleak == 0.1 08:55:12 INFO - mozlog == 3.5 08:55:12 INFO - moznetwork == 0.27 08:55:12 INFO - mozprocess == 0.25 08:55:12 INFO - mozprofile == 0.28 08:55:12 INFO - mozrunner == 6.13 08:55:12 INFO - mozscreenshot == 0.1 08:55:12 INFO - mozsystemmonitor == 0.3 08:55:12 INFO - moztest == 0.8 08:55:12 INFO - mozversion == 1.4 08:55:12 INFO - psutil == 3.1.1 08:55:12 INFO - requests == 1.2.3 08:55:12 INFO - wsgiref == 0.1.2 08:55:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:12 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')]} 08:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:12 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')]} 08:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55: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 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55: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 08:55: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 08:55:12 INFO - Using env: {'DISPLAY': ':0', 08:55:12 INFO - 'HOME': '/home/cltbld', 08:55:12 INFO - 'LANG': 'en_US.UTF-8', 08:55:12 INFO - 'LANGUAGE': 'en_US:en', 08:55:12 INFO - 'LOGNAME': 'cltbld', 08:55:12 INFO - 'MAIL': '/var/mail/cltbld', 08:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:12 INFO - 'MOZ_NO_REMOTE': '1', 08:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:12 INFO - 'NO_EM_RESTART': '1', 08:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:12 INFO - 'PWD': '/builds/slave/test', 08:55:12 INFO - 'SHELL': '/bin/bash', 08:55:12 INFO - 'SHLVL': '1', 08:55:12 INFO - 'TERM': 'linux', 08:55:12 INFO - 'TMOUT': '86400', 08:55:12 INFO - 'USER': 'cltbld', 08:55:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:12 INFO - '_': '/tools/buildbot/bin/python'} 08:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:55:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:55:14 INFO - Installing collected packages: simplejson 08:55:14 INFO - Running setup.py install for simplejson 08:55:14 INFO - building 'simplejson._speedups' extension 08:55:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:55:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:55:15 INFO - Successfully installed simplejson 08:55:15 INFO - Cleaning up... 08:55:15 INFO - Return code: 0 08:55:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25631f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x272fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d2eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', '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 08:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:55:15 INFO - Using env: {'DISPLAY': ':0', 08:55:15 INFO - 'HOME': '/home/cltbld', 08:55:15 INFO - 'LANG': 'en_US.UTF-8', 08:55:15 INFO - 'LANGUAGE': 'en_US:en', 08:55:15 INFO - 'LOGNAME': 'cltbld', 08:55:15 INFO - 'MAIL': '/var/mail/cltbld', 08:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:15 INFO - 'MOZ_NO_REMOTE': '1', 08:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:15 INFO - 'NO_EM_RESTART': '1', 08:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:15 INFO - 'PWD': '/builds/slave/test', 08:55:15 INFO - 'SHELL': '/bin/bash', 08:55:15 INFO - 'SHLVL': '1', 08:55:15 INFO - 'TERM': 'linux', 08:55:15 INFO - 'TMOUT': '86400', 08:55:15 INFO - 'USER': 'cltbld', 08:55:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:15 INFO - '_': '/tools/buildbot/bin/python'} 08:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:55:15 INFO - Cleaning up... 08:55:15 INFO - Return code: 0 08:55:15 INFO - Running post-action listener: _resource_record_post_action 08:55:15 INFO - Running post-action listener: _start_resource_monitoring 08:55:15 INFO - Starting resource monitoring. 08:55:15 INFO - [mozharness: 2017-08-18 15:55:15.550128Z] Finished create-virtualenv step (success) 08:55:15 INFO - [mozharness: 2017-08-18 15:55:15.551146Z] Running install step. 08:55:15 INFO - Running pre-action listener: _resource_record_pre_action 08:55:15 INFO - Running main action method: install 08:55:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:15 INFO - Reading from file tmpfile_stdout 08:55:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:15 INFO - Reading from file tmpfile_stdout 08:55:15 INFO - Output received: 08:55:15 INFO - Usage: mozinstall [options] installer 08:55:15 INFO - Options: 08:55:15 INFO - -h, --help show this help message and exit 08:55:15 INFO - -d DEST, --destination=DEST 08:55:15 INFO - Directory to install application into. [default: 08:55:15 INFO - "/builds/slave/test"] 08:55:15 INFO - --app=APP Application being installed. [default: firefox] 08:55:15 INFO - mkdir: /builds/slave/test/build/application 08:55: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'] 08:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:55:30 INFO - Reading from file tmpfile_stdout 08:55:30 INFO - Output received: 08:55:30 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:30 INFO - Running post-action listener: _resource_record_post_action 08:55:30 INFO - [mozharness: 2017-08-18 15:55:30.659670Z] Finished install step (success) 08:55:30 INFO - [mozharness: 2017-08-18 15:55:30.659922Z] Running setup-mitmproxy step. 08:55:30 INFO - Running pre-action listener: _resource_record_pre_action 08:55:30 INFO - Running main action method: setup_mitmproxy 08:55:30 INFO - Skipping: mitmproxy is not required 08:55:30 INFO - Running post-action listener: _resource_record_post_action 08:55:30 INFO - [mozharness: 2017-08-18 15:55:30.661046Z] Finished setup-mitmproxy step (success) 08:55:30 INFO - [mozharness: 2017-08-18 15:55:30.661267Z] Running run-tests step. 08:55:30 INFO - Running pre-action listener: _resource_record_pre_action 08:55:30 INFO - Running pre-action listener: _set_gcov_prefix 08:55:30 INFO - Running main action method: run_tests 08:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:30 INFO - Python 2.7.3 08:55:30 INFO - Return code: 0 08:55:30 INFO - grabbing minidump binary from tooltool 08:55:30 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')]} 08:55:30 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 0x28d0050>, '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 0x28d0f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d13e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:30 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 08:55:30 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 08:55:30 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 08:55:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:30 INFO - Return code: 0 08:55:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:30 INFO - ENV: RUST_BACKTRACE is now 1 08:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:30 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/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:55:30 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/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 08:55:30 INFO - Using env: {'DISPLAY': ':0', 08:55:30 INFO - 'HOME': '/home/cltbld', 08:55:30 INFO - 'LANG': 'en_US.UTF-8', 08:55:30 INFO - 'LANGUAGE': 'en_US:en', 08:55:30 INFO - 'LOGNAME': 'cltbld', 08:55:30 INFO - 'MAIL': '/var/mail/cltbld', 08:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:30 INFO - 'MOZ_NO_REMOTE': '1', 08:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:30 INFO - 'NO_EM_RESTART': '1', 08:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:30 INFO - 'PWD': '/builds/slave/test', 08:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:30 INFO - 'RUST_BACKTRACE': '1', 08:55:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:55:30 INFO - 'SHELL': '/bin/bash', 08:55:30 INFO - 'SHLVL': '1', 08:55:30 INFO - 'TERM': 'linux', 08:55:30 INFO - 'TMOUT': '86400', 08:55:30 INFO - 'USER': 'cltbld', 08:55:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459', 08:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:30 INFO - '_': '/tools/buildbot/bin/python'} 08:55:30 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/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:55:31 INFO - mozversion application_buildid: 20170818144711 08:55:31 INFO - mozversion application_changeset: 554f6e2674fecadc3a66ec5a497bcaf7064068ee 08:55:31 INFO - mozversion application_display_name: Firefox 08:55:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:31 INFO - mozversion application_name: Firefox 08:55:31 INFO - mozversion application_remotingname: firefox 08:55:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:55:31 INFO - mozversion application_vendor: Mozilla 08:55:31 INFO - mozversion application_version: 56.0 08:55:31 INFO - mozversion platform_buildid: 20170818144711 08:55:31 INFO - mozversion platform_changeset: 554f6e2674fecadc3a66ec5a497bcaf7064068ee 08:55:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:55:31 INFO - mozversion platform_version: 56.0 08:55:31 INFO - using testdate: 1503071731 08:55:31 INFO - actual date: 1503071731 08:55:31 INFO - starting webserver on 'localhost:43401' 08:55:31 INFO - SUITE-START | Running 2 tests 08:55:31 INFO - TEST-START | dromaeo_css 08:55:31 INFO - Initialising browser for dromaeo_css test... 08:55:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html -profile /tmp/tmpQ_NEvp/profile 08:55:31 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html) 08:55:37 INFO - TEST-INFO | 3315: exit 0 08:55:37 INFO - Browser initialized. 08:55:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:37 INFO - TEST-INFO | started process 3477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ_NEvp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:37 INFO - PID 3477 | 1503071737788 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 08:55:48 INFO - PID 3477 | RSS: Main: 154312704 08:55:48 INFO - PID 3477 | 08:58:47 INFO - PID 3477 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43401/tests/dromaeo/cssquery-ext.html) 08:58:48 INFO - PID 3477 | RSS: Main: 160358400 08:58:48 INFO - PID 3477 | 09:01:49 INFO - PID 3477 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-ext.html (next: http://localhost:43401/tests/dromaeo/cssquery-jquery.html) 09:01:50 INFO - PID 3477 | RSS: Main: 157339648 09:01:50 INFO - PID 3477 | 09:04:51 INFO - PID 3477 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43401/tests/dromaeo/cssquery-mootools.html) 09:04:52 INFO - PID 3477 | RSS: Main: 158961664 09:04:52 INFO - PID 3477 | 09:07:53 INFO - PID 3477 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43401/tests/dromaeo/cssquery-prototype.html) 09:07:54 INFO - PID 3477 | RSS: Main: 159113216 09:07:54 INFO - PID 3477 | 09:10:57 INFO - PID 3477 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43401/tests/dromaeo/cssquery-yui.html) 09:10:58 INFO - PID 3477 | RSS: Main: 161943552 09:10:58 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | Cycle 1(1): loaded http://localhost:43401/tests/dromaeo/cssquery-yui.html (next: http://localhost:43401/tests/dromaeo/cssquery-dojo.html) 09:14:00 INFO - PID 3477 | RSS: Main: 163651584 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | __start_tp_report 09:14:00 INFO - PID 3477 | _x_x_mozilla_page_load 09:14:00 INFO - PID 3477 | _x_x_mozilla_page_load_details 09:14:00 INFO - PID 3477 | |i|pagename|runs| 09:14:00 INFO - PID 3477 | |0;dojo.html;3614.8734794282195;3616.13212828921;3616.6021737608858;3617.7467577269585;3641.8725344612944;6414.550981431302;6420.133282006934;6449.709763060662;6484.837879053026;6499.1876015498065;6399.520035997296;6405.839854003652;6491.383318584739;6499.4150526452495;6526.118973938505;5489.1217405215175;5578.191162281487;5578.9163162552595;5686.914696279559;5703.372629010826;5631.18347839563;5689.431056894319;5692.288463942007;5721.713914304268;5727.57043221758;5593.664380137205;5656.632318899279;5657.943420565783;5672.12082127271;5734.913976290359;5532.336119665626;5584.776608935637;5590.2732644756325;5668.57485688575;5671.376148623648;5599.356074051496;5645;5646.943530564683;5675.404082571353;5685.289338832646;6363.981762917957;6365.49076073913;6388.265349484822;6415.230172379298;6450.225972883237;6732.057511948331;6851.38337549618;6854.2117656469645;6924.6537673116145;6949.200841903195;6956.65216739161;6989.986451964488;6994.195667498201;7000.3699667029705;7016.193137789169;6331.240251169797;6375.93624063758;6443.355664433566;6515.120458738057;6543.770968016144;7036.19083805369;7038.964805175941;7040;7044.36600705939;7045.11936007999;6715.865682686319;6728;6741.426978706767;6745.3591908768585;6778.389944904884;6861.245263021064;6949.583025018515;6977.33715297046;7045.7533986311255;7075.292470752986;6861.55399899005;6870.793876183722;6936.514443988974;6938.098047253825;6939.895901561481;6885.208201056943;6894.620795856175;6960.025596416505;6962.443004559623;6964.756233531802;5009.198528235538;5078.060558796635;5078.822241221614;5082.263071854561;5083.288339632454;4569.428821397325;4599.632029437637;4604.677672562955;4642;4675.836345727883;6560.40956313934;6568.1789776277965;6573.638449885302;6661.700223489955;6665.466762658975;6804.115464989619;6856.382925536626;6941.34057264559;7004.3696067354185;7010.824729381806;6412.551121421456;6445.387688169616;6447;6455.128557644658;6458.903116453257;5721.084626459747;5739.598228124075;5743.9425605744245;5743.9425605744245;5747.4252574742195;6947.270536593584;6981.650917454209;7012.948057791372;7014.123234595676;7055.753048643272;6648.235452922976;6829.658517074027;6866.965665171642;6978.267281935527;7043.647817609201;7076.186238582629;7103.2541583133025;7110.57336559808;7185.568865868065;7185.964070179615;6790.898136527857;6845.452363810983;6888.242293347627;6906.758263460755;6946.548474349152;6893.172819261721;6989.790306290819;7093;7097.254788247366;7102.254263302279;6784.626845523544;6794.456443484411;6840.657967101724;6851.623160726208;6852.486063545154;6651.235107962646;6775.525713200029;6780.1524809398825;6856.382925536725;6859.759908403182;6652.234992975869;6662.100616416722;6663.167104111986;6669.233038200669;6678.3989440950545;6715.959026350728;6743.494237932076;6860.794176174722;6870.27862074475;6921;6543.378379053982;6598.670066496752;6599.769008084694;6643.169603799525;6682.899756503753 09:14:00 INFO - PID 3477 | |1;ext.html;885.1403707456636;929.0802105915142;938.4369378372975;974.7709288317244;979.6277414582457;34948.12629684256;35634;35673.82163089184;43176.784116079456;44165.89585260362;43675.34486982698;44059;44284.335734964;44493.7775311123;44544.33183502242;7626.389888808882;7705.537667739925;7827.882581761278;7959.16428774979;7964.761057168294;7783.610819459032;7809.921900780976;7848.646810893495;7880.448368614199;7897;7809.297163255306;7866;7873.409494287923;7898.091719452279;7933.286004259616;7851.136374998802;7880.290773830383;7890.763277101696;7909.802254943615;7916.762497125095;7780.494267872627;7826.804329891798;7834.529928204326;7834.960825195838;7835.764927052198;39546.40680389797;39887.60112398868;39887.60112398897;39968.80015599933;39991.20017599632;3644.5626524816926;3650.0692323457347;3680.907977300562;3681;3683.0239986403626;32362.352752944807;32414.35171296561;32519.67480325214;32541;32547.186320341945;4886.462489126193;4952.975235123838;4986.975065124688;5035.395752509686;5039.77321020555;208688;209410.95294523583;210942;211462;211685;51435.7428212864;51824.74087629538;51972.480275196765;51981;51993.48006519886;54496.45503544914;55072.44927550753;55078;55229.447705523235;55230.72384638051;16126.75809862853;18060.729089063676;18461.446156615322;18495.53761155982;18495.630087398178;13819.930900345635;14763.557093287003;15236.162011089275;15238.314275857612;15271.236438178046;15170.013949093274;15314.923425382802;15344.539663810103;15357.846421535865;15457.613559661098;5795.884082318415;6050.848728781728;6097.17688112108;6194.876102477925;6226.62640241587;1095.1840878545534;1100.6973082402403;1105.4141305108305;1109.2567979453625;1129.7345123895877;24920.5015899681;25056.874715626305;25068.623970640456;25112;25126.497470050497;1220.975580488403;1224.2226186371718;1233.5189276182296;1239.9938000309942;1250.2560976219136;13303.93348033273;13330.600081997556;13496.932515337361;13595.252261125535;17443.040632765067;300493;301967;303491;303939;304126;60057.39942600606;60921.39078609246;61282;61407.38592614017;61493;1485.6657252118187;1505.7063872544747;1539.4765779634754;1555.673308605183;1560.968780624404;29475.852620737616;29649.25876853096;29922.25194370158;30239.546406804355;30321.090367289016;41313.1737365245;41391.79304103581;41457.1708565833;41711.37432938569;41723;170576.14711926362;170960;171676;171883;171940;36200;38129;39557;39609.40585891157;39610.60389396069;47944;48699.269510958075;48777.5122248773;48958.26562601635;48998.75500622474;36036.09909752277;36328;36385;36658.63341366552;36786.63213367832;35694.28611427705;36010.819945900104;36106.8194659025;36125.0968725784;36166;41154;41221.1755764889;41247.381289280085;41418;41546.58453415548;43244.78377608092;44710.55289447064;44970;45124.54875451335;45142.32286515639;31617.367652646357;32335.51496727598;32455.350892982482;32766.1808454781;33538 09:14:00 INFO - PID 3477 | |2;jquery.html;587.4448646029504;600.6216083867163;602.1209034809178;602.1990752299442;625.2621906150741;22775.20286789963;23607.763922360773;24168.274951751453;24211.999999999978;24235.636465453033;27266.863665681645;27652;27728.584071238896;27921.16236512908;27966.440671186563;6558.278589355179;6673.432758215557;6701.966490167542;6709.664516774166;6720;6144.8463788405425;6387.425131738142;6401.9039714404325;6409.2949775524885;6600.976848588452;6314.368563143695;6339.873202535947;6365.2998170201245;6365.586236894587;6369.108324834527;6342.460890824285;6349.555531112824;6351.809445716636;6354.523410744213;6356.110144579739;5933.643981361132;5944.286685597756;5948.2862056553495;5950.0479923212515;5954.345022047572;29245.415091698047;31970.520442193152;32575.185620359443;32644.6735532644;32933;2183.9781602183934;2219.0679914435977;2227.0535022615322;2227.6769868369156;2228;20454.59090818175;20660.17359305641;20755.481112972146;20805.271815486536;20832.166713331448;2436.8903399346896;2475.7029156501335;2475.987620061906;2489.8879550420274;2519.6220566914926;160895;163040.18479907524;163858;164289.17855410767;165042.9999999988;16026.278817453243;16189.838101619069;16212.594685132966;16591.170441477876;16904.830951690325;25503.23490295294;25506.23481295564;25611.359716006875;25685.871570642026;25786;10972.670819875417;11007.394593297286;11123.27698699582;11140.275882067639;11276.605318813803;9615.56729947154;9896.752581185528;10228.590856365661;10229.43738094412;10383.013613706686;9513.381630194015;10005.899941000642;10036.347637403545;10092.192624590016;10322.277440579237;2627.8160528763187;2652.840829550233;2728.6179934809143;2776.155025289988;2870.6124673168856;1050.4380156616173;1072.265498133781;1079.5789642039454;1080.195254535376;1090.4547726136932;22289;22395.21616743406;22523;22525;22596.09615615357;1129.0741591894732;1133.5564586819687;1137.6587023892798;1138.9316641001567;1141.7659379827116;12074.577389791491;12208.145429819828;12307.138500305071;12452.626421207378;12580.874191258154;564274;566065;577081;577841;602262;137951;140231;140334;140679;141209;1261.5962891874697;1284.640300715801;1298.2210673595955;1305.106002388367;1317.413750880868;19591.31430399929;19685.40943771689;19778.30775922836;19857;19902.90048549806;63035.793747218624;64512.67743661252;64860.67569662121;65383;66035.66982165059;83628.16371836203;83823.58088209764;83962;84050.15949840423;84454;15373.769393458884;15636.061836289859;15685.372585096467;15747;15800.209989500248;24334;24594.877025614758;24794.380140496633;24820.25539233826;24963;19483.318083866998;19593;20062.398128056182;20099.19603215855;20220.494487637927;16557.58606034859;16968.83031169722;17444.47666570005;17484.12579371001;18001.1899464527;19025.33411330597;20243.696344555137;20276.290329838386;20281.69577456369;20376;15397.84602154009;15474.922625386802;15480.5355839325;15483.612909676898;15486.457973970857;18987.43037708871;19246.518837028627;19412.417627471197;19710.704339434633;19811 09:14:00 INFO - PID 3477 | |3;mootools.html;1472.3889585821885;1513.8713209377202;1527.343242405765;1542.1749364090215;1548.7599422089572;15770.921145394272;16331.34674613017;16382.83617163828;16404.425845095426;16410.753838692428;15805.52583422499;16846.494605161864;17094.145292735346;17118.14409279534;17129.74305385417;2976.776741744367;2977.478941185295;3043.8478076096217;3050.054483110243;3053.4656435123875;2954.542045982876;3017.125033740224;3028.4700177468967;3054.144839444959;3064.5709600655928;2972.1380799568205;3000.3999200159947;3039.7264246217837;3043.269615292336;3049.649290331618;2856.742893139617;2872.569114632801;2908.185708001763;2908.8836446542114;2914.111196085193;2963.68881267466;2973.3310005248863;2985.5521671749193;2985.7611391088662;2987.686292939232;15693.764593531107;15874;15993.440229592024;16006.679866402723;16039.037657740573;8639.352048596318;8931.419457735292;8953.373263871532;8960.193582577534;8987.41581797181;5354.223637572569;5499.780008799643;5588.888222235532;5627.324721033461;5647.887042259173;1975.0815870620231;1999.6200721862945;2020.7676117246558;2033;2042.2954080842085;27760.722392776217;28431.71568284332;28639;28641.57037644437;28678.283042923886;7704.6532906019365;7872.488288261245;7878.212178782191;8047.758567242992;8077.959610201911;21843.453913651967;21848.126074956825;21861.12555497794;21881.12475500962;21897.781022189894;8656.523891186045;8871.600777964877;8916.242119419792;8923.643054277885;8929.776755581162;7845.0978137513775;7909.6836126555445;8060.798480037929;8143.348532117535;8146.022477302761;5446.8910621787345;5956.7319470623925;6083.8479038023515;6198.101275315054;6213.254409470893;1647.044714065839;1775.7336399539913;1777.8133296003991;1790.9373171938919;1812.6737187306148;926.323783637948;959.3955807841155;959.5250351076262;960.8366577681811;978.4814048554277;8932.553372331358;9000.09999000108;9009.279257659502;9216.2626989842;9284.767880803034;1055.2824079625775;1076.617800680747;1108.4734750993214;1114.8717897441898;1135.6649788312468;5456.672599644034;5582.609217354746;5626.465485778845;6114.785982490592;6173.536984726074;23291.3012609622;23751.524969500515;23879;24019.51960960771;24179.879100604383;23500.177493787636;24154.51690966171;24174.87912560426;24183.39541511441;24216.757832421452;12655.620331390073;12827;12849.614511564481;12880.03399745023;12927.482900684055;8991.595378207865;9003.54982250898;9233.399829011092;9576.712698619052;9639.228861691188;19445.222191112196;19593;20214;20525.152736253807;21037.053332599764;20434.69347959752;20689.27587534429;20923.37229883106;20974.895125524275;21088.261910833047;12824.294663793207;12903.032272579407;12904.612861614167;12918.031147664151;13136;11823.408829558659;14586.781198281822;14703.55889323322;14751.92624036873;14766.33551490164;11222.438878056228;12330.321832299309;13085.280309583064;13095.869041309465;13107;11764.823527647264;12013.45939432745;12176.208546444454;12646.367681615699;12831.807522887351;9881.654142104991;10084.546195421077;10105.24210684187;10113.393196408239;10127.088562029452;6967.686454109476;7031.578105313493;7321.341079302675;7445.739399121005;7456.925430745623;7555.962220189083;7664.770056898302;7758.7672369829;7789.10425301075;7805.609719514116 09:14:00 INFO - PID 3477 | |4;prototype.html;528.632600342762;555.9527440167585;560.6215804332074;561.5451484297718;562.403851916968;6269.185005949232;6343.238811342634;6466.191726034246;6471.288158302583;6474.643894585796;6231.626102433857;6249.375062493748;6319.241690997075;6340.175777148964;6372.362763723625;5045.344105266319;5076.771545280453;5120;5123.743812809364;5130.4613015633195;4746.596539294164;4934.975325123387;5015.724135172564;5068.163752980754;5075.695458272516;4846.563809257166;4865.124277630025;4907.386576677915;4921.163402221613;4941.728204948727;4923.532264434873;4927.334809800667;4961.727105009223;4965.72688502134;4989.65072444929;4436.334549817521;4477.776111194427;4479.081788233404;4479.507254202035;4513.0973805238755;6097.664628445434;6155;6169.7840575580085;6239;6279.654618995954;5898.380670029671;5908.852278693024;5911.113333000041;5956.493698035672;6000.18997435345;6635.336466353374;6661.301368151139;6661.4004739573675;6694.297098804653;6714.966425167843;5063;5100.209467532539;5104.183330667075;5150.892558100027;5155.871103222412;6818.352256535622;6839.555428897106;6889.24324297306;6986.3451888282125;7038.436925046035;5230.163173892235;5267;5267.78928842842;5271.973640131851;5286.180642000496;5288.418273989858;5313.57491400687;5337.19942008694;5358.855498721271;5371.274877891513;5941.821745347646;5945.256842894638;5960.821175364746;5968.880622387528;5971.492423144082;6590.472762179014;6670.966645166744;6681.732730690718;6737.450386411055;6859.657017149123;1821.3807305515923;1853.9073046347628;1856.2203874372526;1859.6652602531674;1877.9812201877805;1271;1298.9935050324689;1309.5154792726753;1313.3695826003382;1329.5080820096625;6303.432691057827;6479.5788273763;6575.706556222287;6579.605223686594;6615.834604134839;6771.187457505131;6810.659467026629;6816.318368163144;6935.514513984073;6976.476764242702;6446.323136070739;6540.574862633914;6551.312112228243;6560.704768285439;6601.966990165019;3661.8169091545315;3663;3674.3202507536193;3686.207465394953;3687.11509237781;7027.543209691354;7109.857802843914;7113.253108423644;7131.679074441663;7176.210616832144;7120.750773722895;7127.144742630814;7128.322809333105;7144.6425179215785;7157.785266442015;7057.36483716468;7081.46888983318;7100.041494398293;7136.93029021578;7155.713771449084;6883.3116688330765;6926.411255043377;6926.722931082701;6956.2000369958105;6982.7206911725;6746.797596072126;6795.3204679531655;6834.589924604539;6841.589504629738;6846.349596788297;7095.858082838417;7105.467089968376;7121.928780712126;7122.145342558926;7158.928410715826;5252.894942101213;5265.947340526545;5280.973595132154;5287.762050707651;5297.205419187153;6751.156105486814;6860.485463590151;6887.965560172167;6978.267281935527;6986.794837845838;6657.633830139195;6716.462682985251;6731.091302674272;6745.460363171032;6764.594124352555;6698.789399498057;6713.093732346266;6744;6749.190097188369;6797.66011699423;6583;6617.8014659560295;6661.933380666132;6694.966525167343;6739.326067393222;6772.830679233059;6780.966095169492;6790.219124800711;6795.048693182859;6804.319568043156;6487.124238227968;6488.740450382121;6536.705848236746;6575.901361479678;6619.855568605067 09:14:00 INFO - PID 3477 | |5;yui.html;944.8755980383346;946.1012038563366;973.7419583810287;984.7242772023832;998.6105418886635;16652.83347166528;16731.498055058368;16771.580710482245;16783.41258055968;16813.327466901326;17592;19014.14436350364;19071.809281907175;19218.903905480453;19225;1031.9948400257988;1057.1067448006422;1065.9626913058005;1067.5996501312009;1069.2675517270657;1025.6410256410272;1069.4545781651375;1069.8662667166604;1074.049466222391;1079.0773888325486;1129.5030186717818;1129.6667483092508;1135.9716007099848;1137.4710759496832;1149.591894877319;1122.421952694363;1125.3079356195922;1126.0822429719751;1127.402476687357;1136.7612801311734;826.68999125328;827.6523859978823;828;830.3689196210863;832.9875051874227;17989.910050449795;17999.100044997696;18100.366487173018;18185;18198.181081851348;19073.809261907343;19079.236830526763;19268.325608603773;19449.222031118738;19458.416247512596;15586.688266234725;15656.217189140498;15832.920835395864;15856.127912964783;15963.600909977344;3638.272345530904;3659.5242618459697;3660.4509323601405;3662.34077865984;3665.2486240320936;135112;137236;143121;145212;148504;14666.266686665624;14725.631859203391;14764.926175369055;14788.556343309718;15322.15728134941;32866.17834554155;33079;33127.66872331294;33436;33540.49689254663;9007.594658240263;9143.77140571491;9192.21866141372;9218.492982886006;9222.354435189472;3795.544534655859;3940.940885886714;4148.481439820022;4522.751248681288;4592.10453961481;5706.9714651426475;5817.767289308465;5838.620489668158;5851.21008663825;5852.063669812809;1051.8264486359817;1084.4035780320792;1093.9671809845718;1103.382106020631;1106.1206340958956;685.5920727167328;707.1019804847814;712.9108861392326;714.5284112485734;715.9248278930742;11554.133439992034;11810.645680629596;11818.290902545874;11937.164398492196;12280.877191228152;707.9787606371817;714.6391072508454;716.3552802477708;719.3022767915114;731.5318196354337;5465.289512363367;5502.532284755761;5510.779568817283;5596.804111856066;5638.915416268759;123963.3801830985;124781;130189.34905325413;131918;133439;110639.44680276708;112323.43838280757;113349;114589.42705286421;118796.40601796936;100678;101229.49385253027;102786.48606757067;103071;105877.47061264644;12210.145289829981;12280.263184208976;12589.433475493808;12650.557230496888;12789;47013.52986470229;47356.52643473659;47986.28020579624;49539.752301238266;50640.74679626578;91560;92227;93125.5343723277;94681;94855;19463.70804437963;19947.900260498605;20469.488262793548;20562.897185513975;20604.38186854397;21315.68026479573;21592.244271450425;21773.56452870902;22175.667364989862;22383.216587419363;18237.81762182361;18242.36151734736;18359.632807344045;18409.079546022378;18870.24519019279;19624.509387265432;20042.799572004093;20059.09734062;20269.797302026793;20503.897480512504;15948.8405115952;15958.12230327343;15976.680466390839;16121.67756644884;16132.919335403249;12949.352532373156;12962.611121666365;13294.933525332312;13358.064935454426;13391.799123012968;14209.502667407005;14603.342849571582;14677.633059173606;15016.6996660064;15263.23683815827 09:14:00 INFO - PID 3477 | __end_tp_report 09:14:00 INFO - PID 3477 | __start_cc_report 09:14:00 INFO - PID 3477 | _x_x_mozilla_cycle_collect,301 09:14:00 INFO - PID 3477 | __end_cc_report 09:14:00 INFO - PID 3477 | __startTimestamp1503072840376__endTimestamp 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | ------- Summary: start ------- 09:14:00 INFO - PID 3477 | Number of tests: 6 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | [#0] dojo.html Cycles:165 Average:6366.30 Median:6663.17 stddev:794.51 (11.9%) stddev-sans-first:767.07 09:14:00 INFO - PID 3477 | Values: 3614.9 3616.1 3616.6 3617.7 3641.9 6414.6 6420.1 6449.7 6484.8 6499.2 6399.5 6405.8 6491.4 6499.4 6526.1 5489.1 5578.2 5578.9 5686.9 5703.4 5631.2 5689.4 5692.3 5721.7 5727.6 5593.7 5656.6 5657.9 5672.1 5734.9 5532.3 5584.8 5590.3 5668.6 5671.4 5599.4 5645.0 5646.9 5675.4 5685.3 6364.0 6365.5 6388.3 6415.2 6450.2 6732.1 6851.4 6854.2 6924.7 6949.2 6956.7 6990.0 6994.2 7000.4 7016.2 6331.2 6375.9 6443.4 6515.1 6543.8 7036.2 7039.0 7040.0 7044.4 7045.1 6715.9 6728.0 6741.4 6745.4 6778.4 6861.2 6949.6 6977.3 7045.8 7075.3 6861.6 6870.8 6936.5 6938.1 6939.9 6885.2 6894.6 6960.0 6962.4 6964.8 5009.2 5078.1 5078.8 5082.3 5083.3 4569.4 4599.6 4604.7 4642.0 4675.8 6560.4 6568.2 6573.6 6661.7 6665.5 6804.1 6856.4 6941.3 7004.4 7010.8 6412.6 6445.4 6447.0 6455.1 6458.9 5721.1 5739.6 5743.9 5743.9 5747.4 6947.3 6981.7 7012.9 7014.1 7055.8 6648.2 6829.7 6867.0 6978.3 7043.6 7076.2 7103.3 7110.6 7185.6 7186.0 6790.9 6845.5 6888.2 6906.8 6946.5 6893.2 6989.8 7093.0 7097.3 7102.3 6784.6 6794.5 6840.7 6851.6 6852.5 6651.2 6775.5 6780.2 6856.4 6859.8 6652.2 6662.1 6663.2 6669.2 6678.4 6716.0 6743.5 6860.8 6870.3 6921.0 6543.4 6598.7 6599.8 6643.2 6682.9 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | [#1] ext.html Cycles:180 Average:41769.43 Median:39551.70 stddev:61173.59 (154.7%) stddev-sans-first:61268.17 09:14:00 INFO - PID 3477 | Values: 885.1 929.1 938.4 974.8 979.6 34948.1 35634.0 35673.8 43176.8 44165.9 43675.3 44059.0 44284.3 44493.8 44544.3 7626.4 7705.5 7827.9 7959.2 7964.8 7783.6 7809.9 7848.6 7880.4 7897.0 7809.3 7866.0 7873.4 7898.1 7933.3 7851.1 7880.3 7890.8 7909.8 7916.8 7780.5 7826.8 7834.5 7835.0 7835.8 39546.4 39887.6 39887.6 39968.8 39991.2 3644.6 3650.1 3680.9 3681.0 3683.0 32362.4 32414.4 32519.7 32541.0 32547.2 4886.5 4953.0 4987.0 5035.4 5039.8 208688.0 209411.0 210942.0 211462.0 211685.0 51435.7 51824.7 51972.5 51981.0 51993.5 54496.5 55072.4 55078.0 55229.4 55230.7 16126.8 18060.7 18461.4 18495.5 18495.6 13819.9 14763.6 15236.2 15238.3 15271.2 15170.0 15314.9 15344.5 15357.8 15457.6 5795.9 6050.8 6097.2 6194.9 6226.6 1095.2 1100.7 1105.4 1109.3 1129.7 24920.5 25056.9 25068.6 25112.0 25126.5 1221.0 1224.2 1233.5 1240.0 1250.3 13303.9 13330.6 13496.9 13595.3 17443.0 300493.0 301967.0 303491.0 303939.0 304126.0 60057.4 60921.4 61282.0 61407.4 61493.0 1485.7 1505.7 1539.5 1555.7 1561.0 29475.9 29649.3 29922.3 30239.5 30321.1 41313.2 41391.8 41457.2 41711.4 41723.0 170576.1 170960.0 171676.0 171883.0 171940.0 36200.0 38129.0 39557.0 39609.4 39610.6 47944.0 48699.3 48777.5 48958.3 48998.8 36036.1 36328.0 36385.0 36658.6 36786.6 35694.3 36010.8 36106.8 36125.1 36166.0 41154.0 41221.2 41247.4 41418.0 41546.6 43244.8 44710.6 44970.0 45124.5 45142.3 31617.4 32335.5 32455.4 32766.2 33538.0 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | [#2] jquery.html Cycles:180 Average:39924.55 Median:2227.84 stddev:97706.38 (4385.7%) stddev-sans-first:97935.83 09:14:00 INFO - PID 3477 | Values: 587.4 600.6 602.1 602.2 625.3 22775.2 23607.8 24168.3 24212.0 24235.6 27266.9 27652.0 27728.6 27921.2 27966.4 6558.3 6673.4 6702.0 6709.7 6720.0 6144.8 6387.4 6401.9 6409.3 6601.0 6314.4 6339.9 6365.3 6365.6 6369.1 6342.5 6349.6 6351.8 6354.5 6356.1 5933.6 5944.3 5948.3 5950.0 5954.3 29245.4 31970.5 32575.2 32644.7 32933.0 2184.0 2219.1 2227.1 2227.7 2228.0 20454.6 20660.2 20755.5 20805.3 20832.2 2436.9 2475.7 2476.0 2489.9 2519.6 160895.0 163040.2 163858.0 164289.2 165043.0 16026.3 16189.8 16212.6 16591.2 16904.8 25503.2 25506.2 25611.4 25685.9 25786.0 10972.7 11007.4 11123.3 11140.3 11276.6 9615.6 9896.8 10228.6 10229.4 10383.0 9513.4 10005.9 10036.3 10092.2 10322.3 2627.8 2652.8 2728.6 2776.2 2870.6 1050.4 1072.3 1079.6 1080.2 1090.5 22289.0 22395.2 22523.0 22525.0 22596.1 1129.1 1133.6 1137.7 1138.9 1141.8 12074.6 12208.1 12307.1 12452.6 12580.9 564274.0 566065.0 577081.0 577841.0 602262.0 137951.0 140231.0 140334.0 140679.0 141209.0 1261.6 1284.6 1298.2 1305.1 1317.4 19591.3 19685.4 19778.3 19857.0 19902.9 63035.8 64512.7 64860.7 65383.0 66035.7 83628.2 83823.6 83962.0 84050.2 84454.0 15373.8 15636.1 15685.4 15747.0 15800.2 24334.0 24594.9 24794.4 24820.3 24963.0 19483.3 19593.0 20062.4 20099.2 20220.5 16557.6 16968.8 17444.5 17484.1 18001.2 19025.3 20243.7 20276.3 20281.7 20376.0 15397.8 15474.9 15480.5 15483.6 15486.5 18987.4 19246.5 19412.4 19710.7 19811.0 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | [#3] mootools.html Cycles:180 Average:10265.84 Median:15644.23 stddev:7371.46 (47.1%) stddev-sans-first:7362.53 09:14:00 INFO - PID 3477 | Values: 1472.4 1513.9 1527.3 1542.2 1548.8 15770.9 16331.3 16382.8 16404.4 16410.8 15805.5 16846.5 17094.1 17118.1 17129.7 2976.8 2977.5 3043.8 3050.1 3053.5 2954.5 3017.1 3028.5 3054.1 3064.6 2972.1 3000.4 3039.7 3043.3 3049.6 2856.7 2872.6 2908.2 2908.9 2914.1 2963.7 2973.3 2985.6 2985.8 2987.7 15693.8 15874.0 15993.4 16006.7 16039.0 8639.4 8931.4 8953.4 8960.2 8987.4 5354.2 5499.8 5588.9 5627.3 5647.9 1975.1 1999.6 2020.8 2033.0 2042.3 27760.7 28431.7 28639.0 28641.6 28678.3 7704.7 7872.5 7878.2 8047.8 8078.0 21843.5 21848.1 21861.1 21881.1 21897.8 8656.5 8871.6 8916.2 8923.6 8929.8 7845.1 7909.7 8060.8 8143.3 8146.0 5446.9 5956.7 6083.8 6198.1 6213.3 1647.0 1775.7 1777.8 1790.9 1812.7 926.3 959.4 959.5 960.8 978.5 8932.6 9000.1 9009.3 9216.3 9284.8 1055.3 1076.6 1108.5 1114.9 1135.7 5456.7 5582.6 5626.5 6114.8 6173.5 23291.3 23751.5 23879.0 24019.5 24179.9 23500.2 24154.5 24174.9 24183.4 24216.8 12655.6 12827.0 12849.6 12880.0 12927.5 8991.6 9003.5 9233.4 9576.7 9639.2 19445.2 19593.0 20214.0 20525.2 21037.1 20434.7 20689.3 20923.4 20974.9 21088.3 12824.3 12903.0 12904.6 12918.0 13136.0 11823.4 14586.8 14703.6 14751.9 14766.3 11222.4 12330.3 13085.3 13095.9 13107.0 11764.8 12013.5 12176.2 12646.4 12831.8 9881.7 10084.5 10105.2 10113.4 10127.1 6967.7 7031.6 7321.3 7445.7 7456.9 7556.0 7664.8 7758.8 7789.1 7805.6 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | [#4] prototype.html Cycles:180 Average:5731.60 Median:6472.97 stddev:1618.28 (25.0%) stddev-sans-first:1575.00 09:14:00 INFO - PID 3477 | Values: 528.6 556.0 560.6 561.5 562.4 6269.2 6343.2 6466.2 6471.3 6474.6 6231.6 6249.4 6319.2 6340.2 6372.4 5045.3 5076.8 5120.0 5123.7 5130.5 4746.6 4935.0 5015.7 5068.2 5075.7 4846.6 4865.1 4907.4 4921.2 4941.7 4923.5 4927.3 4961.7 4965.7 4989.7 4436.3 4477.8 4479.1 4479.5 4513.1 6097.7 6155.0 6169.8 6239.0 6279.7 5898.4 5908.9 5911.1 5956.5 6000.2 6635.3 6661.3 6661.4 6694.3 6715.0 5063.0 5100.2 5104.2 5150.9 5155.9 6818.4 6839.6 6889.2 6986.3 7038.4 5230.2 5267.0 5267.8 5272.0 5286.2 5288.4 5313.6 5337.2 5358.9 5371.3 5941.8 5945.3 5960.8 5968.9 5971.5 6590.5 6671.0 6681.7 6737.5 6859.7 1821.4 1853.9 1856.2 1859.7 1878.0 1271.0 1299.0 1309.5 1313.4 1329.5 6303.4 6479.6 6575.7 6579.6 6615.8 6771.2 6810.7 6816.3 6935.5 6976.5 6446.3 6540.6 6551.3 6560.7 6602.0 3661.8 3663.0 3674.3 3686.2 3687.1 7027.5 7109.9 7113.3 7131.7 7176.2 7120.8 7127.1 7128.3 7144.6 7157.8 7057.4 7081.5 7100.0 7136.9 7155.7 6883.3 6926.4 6926.7 6956.2 6982.7 6746.8 6795.3 6834.6 6841.6 6846.3 7095.9 7105.5 7121.9 7122.1 7158.9 5252.9 5265.9 5281.0 5287.8 5297.2 6751.2 6860.5 6888.0 6978.3 6986.8 6657.6 6716.5 6731.1 6745.5 6764.6 6698.8 6713.1 6744.0 6749.2 6797.7 6583.0 6617.8 6661.9 6695.0 6739.3 6772.8 6781.0 6790.2 6795.0 6804.3 6487.1 6488.7 6536.7 6575.9 6619.9 09:14:00 INFO - PID 3477 | 09:14:00 INFO - PID 3477 | [#5] yui.html Cycles:180 Average:26442.91 Median:18218.00 stddev:38062.65 (208.9%) stddev-sans-first:38121.28 09:14:00 INFO - PID 3477 | Values: 944.9 946.1 973.7 984.7 998.6 16652.8 16731.5 16771.6 16783.4 16813.3 17592.0 19014.1 19071.8 19218.9 19225.0 1032.0 1057.1 1066.0 1067.6 1069.3 1025.6 1069.5 1069.9 1074.0 1079.1 1129.5 1129.7 1136.0 1137.5 1149.6 1122.4 1125.3 1126.1 1127.4 1136.8 826.7 827.7 828.0 830.4 833.0 17989.9 17999.1 18100.4 18185.0 18198.2 19073.8 19079.2 19268.3 19449.2 19458.4 15586.7 15656.2 15832.9 15856.1 15963.6 3638.3 3659.5 3660.5 3662.3 3665.2 135112.0 137236.0 143121.0 145212.0 148504.0 14666.3 14725.6 14764.9 14788.6 15322.2 32866.2 33079.0 33127.7 33436.0 33540.5 9007.6 9143.8 9192.2 9218.5 9222.4 3795.5 3940.9 4148.5 4522.8 4592.1 5707.0 5817.8 5838.6 5851.2 5852.1 1051.8 1084.4 1094.0 1103.4 1106.1 685.6 707.1 712.9 714.5 715.9 11554.1 11810.6 11818.3 11937.2 12280.9 708.0 714.6 716.4 719.3 731.5 5465.3 5502.5 5510.8 5596.8 5638.9 123963.4 124781.0 130189.3 131918.0 133439.0 110639.4 112323.4 113349.0 114589.4 118796.4 100678.0 101229.5 102786.5 103071.0 105877.5 12210.1 12280.3 12589.4 12650.6 12789.0 47013.5 47356.5 47986.3 49539.8 50640.7 91560.0 92227.0 93125.5 94681.0 94855.0 19463.7 19947.9 20469.5 20562.9 20604.4 21315.7 21592.2 21773.6 22175.7 22383.2 18237.8 18242.4 18359.6 18409.1 18870.2 19624.5 20042.8 20059.1 20269.8 20503.9 15948.8 15958.1 15976.7 16121.7 16132.9 12949.4 12962.6 13294.9 13358.1 13391.8 14209.5 14603.3 14677.6 15016.7 15263.2 09:14:00 INFO - PID 3477 | -------- Summary: end -------- 09:14:00 INFO - PID 3477 | 09:14:01 INFO - TEST-INFO | 3477: exit 0 09:14:01 INFO - TEST-OK | dromaeo_css | took 1109935ms 09:14:01 INFO - TEST-START | kraken 09:14:01 INFO - Initialising browser for kraken test... 09:14:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html -profile /tmp/tmpHxIgNl/profile 09:14:01 INFO - TEST-INFO | started process 3831 (/builds/slave/test/build/application/firefox/firefox http://localhost:43401/getInfo.html) 09:14:06 INFO - TEST-INFO | 3831: exit 0 09:14:06 INFO - Browser initialized. 09:14:06 INFO - Running cycle 1/1 for kraken test... 09:14:06 INFO - TEST-INFO | started process 3993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHxIgNl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:07 INFO - PID 3993 | 1503072847118 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 09:14:18 INFO - PID 3993 | RSS: Main: 154562560 09:14:18 INFO - PID 3993 | 09:14:20 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:21 INFO - PID 3993 | RSS: Main: 162316288 09:14:21 INFO - PID 3993 | 09:14:23 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-dft) 09:14:24 INFO - PID 3993 | RSS: Main: 162603008 09:14:24 INFO - PID 3993 | 09:14:27 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-fft) 09:14:27 INFO - PID 3993 | RSS: Main: 162553856 09:14:27 INFO - PID 3993 | 09:14:30 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43401/tests/kraken/driver.html?testName=audio-oscillator) 09:14:30 INFO - PID 3993 | RSS: Main: 162918400 09:14:30 INFO - PID 3993 | 09:14:32 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:33 INFO - PID 3993 | RSS: Main: 162779136 09:14:33 INFO - PID 3993 | 09:14:36 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:37 INFO - PID 3993 | RSS: Main: 162910208 09:14:37 INFO - PID 3993 | 09:14:40 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43401/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:40 INFO - PID 3993 | RSS: Main: 165486592 09:14:40 INFO - PID 3993 | 09:14:43 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43401/tests/kraken/driver.html?testName=json-parse-financial) 09:14:44 INFO - PID 3993 | RSS: Main: 166080512 09:14:44 INFO - PID 3993 | 09:14:45 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:46 INFO - PID 3993 | RSS: Main: 166199296 09:14:46 INFO - PID 3993 | 09:14:48 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:48 INFO - PID 3993 | RSS: Main: 165863424 09:14:48 INFO - PID 3993 | 09:14:50 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:51 INFO - PID 3993 | RSS: Main: 163270656 09:14:51 INFO - PID 3993 | 09:14:53 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:54 INFO - PID 3993 | RSS: Main: 163086336 09:14:54 INFO - PID 3993 | 09:14:57 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:57 INFO - PID 3993 | RSS: Main: 163176448 09:14:57 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | Cycle 1(1): loaded http://localhost:43401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43401/tests/kraken/driver.html?testName=ai-astar) 09:14:59 INFO - PID 3993 | RSS: Main: 164716544 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | __start_tp_report 09:14:59 INFO - PID 3993 | _x_x_mozilla_page_load 09:14:59 INFO - PID 3993 | _x_x_mozilla_page_load_details 09:14:59 INFO - PID 3993 | |i|pagename|runs| 09:14:59 INFO - PID 3993 | |0;ai-astar;96;106;100;106;106;108;106;99;106;108 09:14:59 INFO - PID 3993 | |1;audio-beat-detection;134;112;137;163;119;140;140;120;166;114 09:14:59 INFO - PID 3993 | |2;audio-dft;162;162;162;163;162;162;160;162;162;162 09:14:59 INFO - PID 3993 | |3;audio-fft;75;74;73;193;77;76;78;74;156;75 09:14:59 INFO - PID 3993 | |4;audio-oscillator;79;77;127;77;78;77;121;77;77;125 09:14:59 INFO - PID 3993 | |5;imaging-gaussian-blur;114;118;117;116;117;117;114;114;114;114 09:14:59 INFO - PID 3993 | |6;imaging-darkroom;148;148;148;148;148;148;147;147;147;148 09:14:59 INFO - PID 3993 | |7;imaging-desaturate;94;93;96;94;94;95;94;94;95;95 09:14:59 INFO - PID 3993 | |8;json-parse-financial;45;52;45;49;44;49;46;45;45;45 09:14:59 INFO - PID 3993 | |9;json-stringify-tinderbox;52;52;52;52;51;52;53;52;52;53 09:14:59 INFO - PID 3993 | |10;stanford-crypto-aes;74;80;73;77;72;72;73;79;75;72 09:14:59 INFO - PID 3993 | |11;stanford-crypto-ccm;115;111;113;122;115;116;119;120;112;139 09:14:59 INFO - PID 3993 | |12;stanford-crypto-pbkdf2;160;156;157;162;176;160;155;165;158;169 09:14:59 INFO - PID 3993 | |13;stanford-crypto-sha256-iterative;60;67;58;58;64;58;57;73;57;56 09:14:59 INFO - PID 3993 | __end_tp_report 09:14:59 INFO - PID 3993 | __start_cc_report 09:14:59 INFO - PID 3993 | _x_x_mozilla_cycle_collect,789 09:14:59 INFO - PID 3993 | __end_cc_report 09:14:59 INFO - PID 3993 | __startTimestamp1503072899838__endTimestamp 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | ------- Summary: start ------- 09:14:59 INFO - PID 3993 | Number of tests: 14 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#0] ai-astar Cycles:10 Average:104.10 Median:107.00 stddev:4.18 (3.9%) stddev-sans-first:3.24 09:14:59 INFO - PID 3993 | Values: 96.0 106.0 100.0 106.0 106.0 108.0 106.0 99.0 106.0 108.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:138.50 stddev:19.00 (13.7%) stddev-sans-first:20.15 09:14:59 INFO - PID 3993 | Values: 134.0 112.0 137.0 163.0 119.0 140.0 140.0 120.0 166.0 114.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:14:59 INFO - PID 3993 | Values: 162.0 162.0 162.0 163.0 162.0 162.0 160.0 162.0 162.0 162.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:42.77 (57.0%) stddev-sans-first:44.74 09:14:59 INFO - PID 3993 | Values: 75.0 74.0 73.0 193.0 77.0 76.0 78.0 74.0 156.0 75.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:77.00 stddev:22.71 (29.5%) stddev-sans-first:23.63 09:14:59 INFO - PID 3993 | Values: 79.0 77.0 127.0 77.0 78.0 77.0 121.0 77.0 77.0 125.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:116.50 stddev:1.65 (1.4%) stddev-sans-first:1.66 09:14:59 INFO - PID 3993 | Values: 114.0 118.0 117.0 116.0 117.0 117.0 114.0 114.0 114.0 114.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:14:59 INFO - PID 3993 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 148.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 09:14:59 INFO - PID 3993 | Values: 94.0 93.0 96.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:45.50 stddev:2.59 (5.7%) stddev-sans-first:2.69 09:14:59 INFO - PID 3993 | Values: 45.0 52.0 45.0 49.0 44.0 49.0 46.0 45.0 45.0 45.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#9] json-stringify-tinderbox Cycles:10 Average:52.10 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 09:14:59 INFO - PID 3993 | Values: 52.0 52.0 52.0 52.0 51.0 52.0 53.0 52.0 52.0 53.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:2.98 (4.0%) stddev-sans-first:3.15 09:14:59 INFO - PID 3993 | Values: 74.0 80.0 73.0 77.0 72.0 72.0 73.0 79.0 75.0 72.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:117.50 stddev:8.12 (6.9%) stddev-sans-first:8.53 09:14:59 INFO - PID 3993 | Values: 115.0 111.0 113.0 122.0 115.0 116.0 119.0 120.0 112.0 139.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:161.00 stddev:6.56 (4.1%) stddev-sans-first:6.93 09:14:59 INFO - PID 3993 | Values: 160.0 156.0 157.0 162.0 176.0 160.0 155.0 165.0 158.0 169.0 09:14:59 INFO - PID 3993 | 09:14:59 INFO - PID 3993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:59.00 stddev:5.51 (9.3%) stddev-sans-first:5.84 09:14:59 INFO - PID 3993 | Values: 60.0 67.0 58.0 58.0 64.0 58.0 57.0 73.0 57.0 56.0 09:14:59 INFO - PID 3993 | -------- Summary: end -------- 09:14:59 INFO - PID 3993 | 09:15:00 INFO - PID 3993 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:15:00 INFO - TEST-INFO | 3993: exit 0 09:15:00 INFO - TEST-OK | kraken | took 59461ms 09:15:00 INFO - SUITE-END | took 1169s 09:15:01 INFO - Completed test suite (00:19:29) 09:15:01 INFO - javascript benchmark 09:15:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9087.996718556811, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3614.8734794282195, 3616.13212828921, 3616.6021737608858, 3617.7467577269585, 3641.8725344612944, 6414.550981431302, 6420.133282006934, 6449.709763060662, 6484.837879053026, 6499.1876015498065, 6399.520035997296, 6405.839854003652, 6491.383318584739, 6499.4150526452495, 6526.118973938505, 5489.1217405215175, 5578.191162281487, 5578.9163162552595, 5686.914696279559, 5703.372629010826, 5631.18347839563, 5689.431056894319, 5692.288463942007, 5721.713914304268, 5727.57043221758, 5593.664380137205, 5656.632318899279, 5657.943420565783, 5672.12082127271, 5734.913976290359, 5532.336119665626, 5584.776608935637, 5590.2732644756325, 5668.57485688575, 5671.376148623648, 5599.356074051496, 5645.0, 5646.943530564683, 5675.404082571353, 5685.289338832646, 6363.981762917957, 6365.49076073913, 6388.265349484822, 6415.230172379298, 6450.225972883237, 6732.057511948331, 6851.38337549618, 6854.2117656469645, 6924.6537673116145, 6949.200841903195, 6956.65216739161, 6989.986451964488, 6994.195667498201, 7000.3699667029705, 7016.193137789169, 6331.240251169797, 6375.93624063758, 6443.355664433566, 6515.120458738057, 6543.770968016144, 7036.19083805369, 7038.964805175941, 7040.0, 7044.36600705939, 7045.11936007999, 6715.865682686319, 6728.0, 6741.426978706767, 6745.3591908768585, 6778.389944904884, 6861.245263021064, 6949.583025018515, 6977.33715297046, 7045.7533986311255, 7075.292470752986, 6861.55399899005, 6870.793876183722, 6936.514443988974, 6938.098047253825, 6939.895901561481, 6885.208201056943, 6894.620795856175, 6960.025596416505, 6962.443004559623, 6964.756233531802, 5009.198528235538, 5078.060558796635, 5078.822241221614, 5082.263071854561, 5083.288339632454, 4569.428821397325, 4599.632029437637, 4604.677672562955, 4642.0, 4675.836345727883, 6560.40956313934, 6568.1789776277965, 6573.638449885302, 6661.700223489955, 6665.466762658975, 6804.115464989619, 6856.382925536626, 6941.34057264559, 7004.3696067354185, 7010.824729381806, 6412.551121421456, 6445.387688169616, 6447.0, 6455.128557644658, 6458.903116453257, 5721.084626459747, 5739.598228124075, 5743.9425605744245, 5743.9425605744245, 5747.4252574742195, 6947.270536593584, 6981.650917454209, 7012.948057791372, 7014.123234595676, 7055.753048643272, 6648.235452922976, 6829.658517074027, 6866.965665171642, 6978.267281935527, 7043.647817609201, 7076.186238582629, 7103.2541583133025, 7110.57336559808, 7185.568865868065, 7185.964070179615, 6790.898136527857, 6845.452363810983, 6888.242293347627, 6906.758263460755, 6946.548474349152, 6893.172819261721, 6989.790306290819, 7093.0, 7097.254788247366, 7102.254263302279, 6784.626845523544, 6794.456443484411, 6840.657967101724, 6851.623160726208, 6852.486063545154, 6651.235107962646, 6775.525713200029, 6780.1524809398825, 6856.382925536725, 6859.759908403182, 6652.234992975869, 6662.100616416722, 6663.167104111986, 6669.233038200669, 6678.3989440950545, 6715.959026350728, 6743.494237932076, 6860.794176174722, 6870.27862074475, 6921.0, 6543.378379053982, 6598.670066496752, 6599.769008084694, 6643.169603799525, 6682.899756503753], "value": 6307.610800631895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.1403707456636, 929.0802105915142, 938.4369378372975, 974.7709288317244, 979.6277414582457, 34948.12629684256, 35634.0, 35673.82163089184, 43176.784116079456, 44165.89585260362, 43675.34486982698, 44059.0, 44284.335734964, 44493.7775311123, 44544.33183502242, 7626.389888808882, 7705.537667739925, 7827.882581761278, 7959.16428774979, 7964.761057168294, 7783.610819459032, 7809.921900780976, 7848.646810893495, 7880.448368614199, 7897.0, 7809.297163255306, 7866.0, 7873.409494287923, 7898.091719452279, 7933.286004259616, 7851.136374998802, 7880.290773830383, 7890.763277101696, 7909.802254943615, 7916.762497125095, 7780.494267872627, 7826.804329891798, 7834.529928204326, 7834.960825195838, 7835.764927052198, 39546.40680389797, 39887.60112398868, 39887.60112398897, 39968.80015599933, 39991.20017599632, 3644.5626524816926, 3650.0692323457347, 3680.907977300562, 3681.0, 3683.0239986403626, 32362.352752944807, 32414.35171296561, 32519.67480325214, 32541.0, 32547.186320341945, 4886.462489126193, 4952.975235123838, 4986.975065124688, 5035.395752509686, 5039.77321020555, 208688.0, 209410.95294523583, 210942.0, 211462.0, 211685.0, 51435.7428212864, 51824.74087629538, 51972.480275196765, 51981.0, 51993.48006519886, 54496.45503544914, 55072.44927550753, 55078.0, 55229.447705523235, 55230.72384638051, 16126.75809862853, 18060.729089063676, 18461.446156615322, 18495.53761155982, 18495.630087398178, 13819.930900345635, 14763.557093287003, 15236.162011089275, 15238.314275857612, 15271.236438178046, 15170.013949093274, 15314.923425382802, 15344.539663810103, 15357.846421535865, 15457.613559661098, 5795.884082318415, 6050.848728781728, 6097.17688112108, 6194.876102477925, 6226.62640241587, 1095.1840878545534, 1100.6973082402403, 1105.4141305108305, 1109.2567979453625, 1129.7345123895877, 24920.5015899681, 25056.874715626305, 25068.623970640456, 25112.0, 25126.497470050497, 1220.975580488403, 1224.2226186371718, 1233.5189276182296, 1239.9938000309942, 1250.2560976219136, 13303.93348033273, 13330.600081997556, 13496.932515337361, 13595.252261125535, 17443.040632765067, 300493.0, 301967.0, 303491.0, 303939.0, 304126.0, 60057.39942600606, 60921.39078609246, 61282.0, 61407.38592614017, 61493.0, 1485.6657252118187, 1505.7063872544747, 1539.4765779634754, 1555.673308605183, 1560.968780624404, 29475.852620737616, 29649.25876853096, 29922.25194370158, 30239.546406804355, 30321.090367289016, 41313.1737365245, 41391.79304103581, 41457.1708565833, 41711.37432938569, 41723.0, 170576.14711926362, 170960.0, 171676.0, 171883.0, 171940.0, 36200.0, 38129.0, 39557.0, 39609.40585891157, 39610.60389396069, 47944.0, 48699.269510958075, 48777.5122248773, 48958.26562601635, 48998.75500622474, 36036.09909752277, 36328.0, 36385.0, 36658.63341366552, 36786.63213367832, 35694.28611427705, 36010.819945900104, 36106.8194659025, 36125.0968725784, 36166.0, 41154.0, 41221.1755764889, 41247.381289280085, 41418.0, 41546.58453415548, 43244.78377608092, 44710.55289447064, 44970.0, 45124.54875451335, 45142.32286515639, 31617.367652646357, 32335.51496727598, 32455.350892982482, 32766.1808454781, 33538.0], "value": 18797.855403157097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4448646029504, 600.6216083867163, 602.1209034809178, 602.1990752299442, 625.2621906150741, 22775.20286789963, 23607.763922360773, 24168.274951751453, 24211.999999999978, 24235.636465453033, 27266.863665681645, 27652.0, 27728.584071238896, 27921.16236512908, 27966.440671186563, 6558.278589355179, 6673.432758215557, 6701.966490167542, 6709.664516774166, 6720.0, 6144.8463788405425, 6387.425131738142, 6401.9039714404325, 6409.2949775524885, 6600.976848588452, 6314.368563143695, 6339.873202535947, 6365.2998170201245, 6365.586236894587, 6369.108324834527, 6342.460890824285, 6349.555531112824, 6351.809445716636, 6354.523410744213, 6356.110144579739, 5933.643981361132, 5944.286685597756, 5948.2862056553495, 5950.0479923212515, 5954.345022047572, 29245.415091698047, 31970.520442193152, 32575.185620359443, 32644.6735532644, 32933.0, 2183.9781602183934, 2219.0679914435977, 2227.0535022615322, 2227.6769868369156, 2228.0, 20454.59090818175, 20660.17359305641, 20755.481112972146, 20805.271815486536, 20832.166713331448, 2436.8903399346896, 2475.7029156501335, 2475.987620061906, 2489.8879550420274, 2519.6220566914926, 160895.0, 163040.18479907524, 163858.0, 164289.17855410767, 165042.9999999988, 16026.278817453243, 16189.838101619069, 16212.594685132966, 16591.170441477876, 16904.830951690325, 25503.23490295294, 25506.23481295564, 25611.359716006875, 25685.871570642026, 25786.0, 10972.670819875417, 11007.394593297286, 11123.27698699582, 11140.275882067639, 11276.605318813803, 9615.56729947154, 9896.752581185528, 10228.590856365661, 10229.43738094412, 10383.013613706686, 9513.381630194015, 10005.899941000642, 10036.347637403545, 10092.192624590016, 10322.277440579237, 2627.8160528763187, 2652.840829550233, 2728.6179934809143, 2776.155025289988, 2870.6124673168856, 1050.4380156616173, 1072.265498133781, 1079.5789642039454, 1080.195254535376, 1090.4547726136932, 22289.0, 22395.21616743406, 22523.0, 22525.0, 22596.09615615357, 1129.0741591894732, 1133.5564586819687, 1137.6587023892798, 1138.9316641001567, 1141.7659379827116, 12074.577389791491, 12208.145429819828, 12307.138500305071, 12452.626421207378, 12580.874191258154, 564274.0, 566065.0, 577081.0, 577841.0, 602262.0, 137951.0, 140231.0, 140334.0, 140679.0, 141209.0, 1261.5962891874697, 1284.640300715801, 1298.2210673595955, 1305.106002388367, 1317.413750880868, 19591.31430399929, 19685.40943771689, 19778.30775922836, 19857.0, 19902.90048549806, 63035.793747218624, 64512.67743661252, 64860.67569662121, 65383.0, 66035.66982165059, 83628.16371836203, 83823.58088209764, 83962.0, 84050.15949840423, 84454.0, 15373.769393458884, 15636.061836289859, 15685.372585096467, 15747.0, 15800.209989500248, 24334.0, 24594.877025614758, 24794.380140496633, 24820.25539233826, 24963.0, 19483.318083866998, 19593.0, 20062.398128056182, 20099.19603215855, 20220.494487637927, 16557.58606034859, 16968.83031169722, 17444.47666570005, 17484.12579371001, 18001.1899464527, 19025.33411330597, 20243.696344555137, 20276.290329838386, 20281.69577456369, 20376.0, 15397.84602154009, 15474.922625386802, 15480.5355839325, 15483.612909676898, 15486.457973970857, 18987.43037708871, 19246.518837028627, 19412.417627471197, 19710.704339434633, 19811.0], "value": 12895.351875942577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.3889585821885, 1513.8713209377202, 1527.343242405765, 1542.1749364090215, 1548.7599422089572, 15770.921145394272, 16331.34674613017, 16382.83617163828, 16404.425845095426, 16410.753838692428, 15805.52583422499, 16846.494605161864, 17094.145292735346, 17118.14409279534, 17129.74305385417, 2976.776741744367, 2977.478941185295, 3043.8478076096217, 3050.054483110243, 3053.4656435123875, 2954.542045982876, 3017.125033740224, 3028.4700177468967, 3054.144839444959, 3064.5709600655928, 2972.1380799568205, 3000.3999200159947, 3039.7264246217837, 3043.269615292336, 3049.649290331618, 2856.742893139617, 2872.569114632801, 2908.185708001763, 2908.8836446542114, 2914.111196085193, 2963.68881267466, 2973.3310005248863, 2985.5521671749193, 2985.7611391088662, 2987.686292939232, 15693.764593531107, 15874.0, 15993.440229592024, 16006.679866402723, 16039.037657740573, 8639.352048596318, 8931.419457735292, 8953.373263871532, 8960.193582577534, 8987.41581797181, 5354.223637572569, 5499.780008799643, 5588.888222235532, 5627.324721033461, 5647.887042259173, 1975.0815870620231, 1999.6200721862945, 2020.7676117246558, 2033.0, 2042.2954080842085, 27760.722392776217, 28431.71568284332, 28639.0, 28641.57037644437, 28678.283042923886, 7704.6532906019365, 7872.488288261245, 7878.212178782191, 8047.758567242992, 8077.959610201911, 21843.453913651967, 21848.126074956825, 21861.12555497794, 21881.12475500962, 21897.781022189894, 8656.523891186045, 8871.600777964877, 8916.242119419792, 8923.643054277885, 8929.776755581162, 7845.0978137513775, 7909.6836126555445, 8060.798480037929, 8143.348532117535, 8146.022477302761, 5446.8910621787345, 5956.7319470623925, 6083.8479038023515, 6198.101275315054, 6213.254409470893, 1647.044714065839, 1775.7336399539913, 1777.8133296003991, 1790.9373171938919, 1812.6737187306148, 926.323783637948, 959.3955807841155, 959.5250351076262, 960.8366577681811, 978.4814048554277, 8932.553372331358, 9000.09999000108, 9009.279257659502, 9216.2626989842, 9284.767880803034, 1055.2824079625775, 1076.617800680747, 1108.4734750993214, 1114.8717897441898, 1135.6649788312468, 5456.672599644034, 5582.609217354746, 5626.465485778845, 6114.785982490592, 6173.536984726074, 23291.3012609622, 23751.524969500515, 23879.0, 24019.51960960771, 24179.879100604383, 23500.177493787636, 24154.51690966171, 24174.87912560426, 24183.39541511441, 24216.757832421452, 12655.620331390073, 12827.0, 12849.614511564481, 12880.03399745023, 12927.482900684055, 8991.595378207865, 9003.54982250898, 9233.399829011092, 9576.712698619052, 9639.228861691188, 19445.222191112196, 19593.0, 20214.0, 20525.152736253807, 21037.053332599764, 20434.69347959752, 20689.27587534429, 20923.37229883106, 20974.895125524275, 21088.261910833047, 12824.294663793207, 12903.032272579407, 12904.612861614167, 12918.031147664151, 13136.0, 11823.408829558659, 14586.781198281822, 14703.55889323322, 14751.92624036873, 14766.33551490164, 11222.438878056228, 12330.321832299309, 13085.280309583064, 13095.869041309465, 13107.0, 11764.823527647264, 12013.45939432745, 12176.208546444454, 12646.367681615699, 12831.807522887351, 9881.654142104991, 10084.546195421077, 10105.24210684187, 10113.393196408239, 10127.088562029452, 6967.686454109476, 7031.578105313493, 7321.341079302675, 7445.739399121005, 7456.925430745623, 7555.962220189083, 7664.770056898302, 7758.7672369829, 7789.10425301075, 7805.609719514116], "value": 7338.3662042433925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.632600342762, 555.9527440167585, 560.6215804332074, 561.5451484297718, 562.403851916968, 6269.185005949232, 6343.238811342634, 6466.191726034246, 6471.288158302583, 6474.643894585796, 6231.626102433857, 6249.375062493748, 6319.241690997075, 6340.175777148964, 6372.362763723625, 5045.344105266319, 5076.771545280453, 5120.0, 5123.743812809364, 5130.4613015633195, 4746.596539294164, 4934.975325123387, 5015.724135172564, 5068.163752980754, 5075.695458272516, 4846.563809257166, 4865.124277630025, 4907.386576677915, 4921.163402221613, 4941.728204948727, 4923.532264434873, 4927.334809800667, 4961.727105009223, 4965.72688502134, 4989.65072444929, 4436.334549817521, 4477.776111194427, 4479.081788233404, 4479.507254202035, 4513.0973805238755, 6097.664628445434, 6155.0, 6169.7840575580085, 6239.0, 6279.654618995954, 5898.380670029671, 5908.852278693024, 5911.113333000041, 5956.493698035672, 6000.18997435345, 6635.336466353374, 6661.301368151139, 6661.4004739573675, 6694.297098804653, 6714.966425167843, 5063.0, 5100.209467532539, 5104.183330667075, 5150.892558100027, 5155.871103222412, 6818.352256535622, 6839.555428897106, 6889.24324297306, 6986.3451888282125, 7038.436925046035, 5230.163173892235, 5267.0, 5267.78928842842, 5271.973640131851, 5286.180642000496, 5288.418273989858, 5313.57491400687, 5337.19942008694, 5358.855498721271, 5371.274877891513, 5941.821745347646, 5945.256842894638, 5960.821175364746, 5968.880622387528, 5971.492423144082, 6590.472762179014, 6670.966645166744, 6681.732730690718, 6737.450386411055, 6859.657017149123, 1821.3807305515923, 1853.9073046347628, 1856.2203874372526, 1859.6652602531674, 1877.9812201877805, 1271.0, 1298.9935050324689, 1309.5154792726753, 1313.3695826003382, 1329.5080820096625, 6303.432691057827, 6479.5788273763, 6575.706556222287, 6579.605223686594, 6615.834604134839, 6771.187457505131, 6810.659467026629, 6816.318368163144, 6935.514513984073, 6976.476764242702, 6446.323136070739, 6540.574862633914, 6551.312112228243, 6560.704768285439, 6601.966990165019, 3661.8169091545315, 3663.0, 3674.3202507536193, 3686.207465394953, 3687.11509237781, 7027.543209691354, 7109.857802843914, 7113.253108423644, 7131.679074441663, 7176.210616832144, 7120.750773722895, 7127.144742630814, 7128.322809333105, 7144.6425179215785, 7157.785266442015, 7057.36483716468, 7081.46888983318, 7100.041494398293, 7136.93029021578, 7155.713771449084, 6883.3116688330765, 6926.411255043377, 6926.722931082701, 6956.2000369958105, 6982.7206911725, 6746.797596072126, 6795.3204679531655, 6834.589924604539, 6841.589504629738, 6846.349596788297, 7095.858082838417, 7105.467089968376, 7121.928780712126, 7122.145342558926, 7158.928410715826, 5252.894942101213, 5265.947340526545, 5280.973595132154, 5287.762050707651, 5297.205419187153, 6751.156105486814, 6860.485463590151, 6887.965560172167, 6978.267281935527, 6986.794837845838, 6657.633830139195, 6716.462682985251, 6731.091302674272, 6745.460363171032, 6764.594124352555, 6698.789399498057, 6713.093732346266, 6744.0, 6749.190097188369, 6797.66011699423, 6583.0, 6617.8014659560295, 6661.933380666132, 6694.966525167343, 6739.326067393222, 6772.830679233059, 6780.966095169492, 6790.219124800711, 6795.048693182859, 6804.319568043156, 6487.124238227968, 6488.740450382121, 6536.705848236746, 6575.901361479678, 6619.855568605067], "value": 5262.868028503548, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.8755980383346, 946.1012038563366, 973.7419583810287, 984.7242772023832, 998.6105418886635, 16652.83347166528, 16731.498055058368, 16771.580710482245, 16783.41258055968, 16813.327466901326, 17592.0, 19014.14436350364, 19071.809281907175, 19218.903905480453, 19225.0, 1031.9948400257988, 1057.1067448006422, 1065.9626913058005, 1067.5996501312009, 1069.2675517270657, 1025.6410256410272, 1069.4545781651375, 1069.8662667166604, 1074.049466222391, 1079.0773888325486, 1129.5030186717818, 1129.6667483092508, 1135.9716007099848, 1137.4710759496832, 1149.591894877319, 1122.421952694363, 1125.3079356195922, 1126.0822429719751, 1127.402476687357, 1136.7612801311734, 826.68999125328, 827.6523859978823, 828.0, 830.3689196210863, 832.9875051874227, 17989.910050449795, 17999.100044997696, 18100.366487173018, 18185.0, 18198.181081851348, 19073.809261907343, 19079.236830526763, 19268.325608603773, 19449.222031118738, 19458.416247512596, 15586.688266234725, 15656.217189140498, 15832.920835395864, 15856.127912964783, 15963.600909977344, 3638.272345530904, 3659.5242618459697, 3660.4509323601405, 3662.34077865984, 3665.2486240320936, 135112.0, 137236.0, 143121.0, 145212.0, 148504.0, 14666.266686665624, 14725.631859203391, 14764.926175369055, 14788.556343309718, 15322.15728134941, 32866.17834554155, 33079.0, 33127.66872331294, 33436.0, 33540.49689254663, 9007.594658240263, 9143.77140571491, 9192.21866141372, 9218.492982886006, 9222.354435189472, 3795.544534655859, 3940.940885886714, 4148.481439820022, 4522.751248681288, 4592.10453961481, 5706.9714651426475, 5817.767289308465, 5838.620489668158, 5851.21008663825, 5852.063669812809, 1051.8264486359817, 1084.4035780320792, 1093.9671809845718, 1103.382106020631, 1106.1206340958956, 685.5920727167328, 707.1019804847814, 712.9108861392326, 714.5284112485734, 715.9248278930742, 11554.133439992034, 11810.645680629596, 11818.290902545874, 11937.164398492196, 12280.877191228152, 707.9787606371817, 714.6391072508454, 716.3552802477708, 719.3022767915114, 731.5318196354337, 5465.289512363367, 5502.532284755761, 5510.779568817283, 5596.804111856066, 5638.915416268759, 123963.3801830985, 124781.0, 130189.34905325413, 131918.0, 133439.0, 110639.44680276708, 112323.43838280757, 113349.0, 114589.42705286421, 118796.40601796936, 100678.0, 101229.49385253027, 102786.48606757067, 103071.0, 105877.47061264644, 12210.145289829981, 12280.263184208976, 12589.433475493808, 12650.557230496888, 12789.0, 47013.52986470229, 47356.52643473659, 47986.28020579624, 49539.752301238266, 50640.74679626578, 91560.0, 92227.0, 93125.5343723277, 94681.0, 94855.0, 19463.70804437963, 19947.900260498605, 20469.488262793548, 20562.897185513975, 20604.38186854397, 21315.68026479573, 21592.244271450425, 21773.56452870902, 22175.667364989862, 22383.216587419363, 18237.81762182361, 18242.36151734736, 18359.632807344045, 18409.079546022378, 18870.24519019279, 19624.509387265432, 20042.799572004093, 20059.09734062, 20269.797302026793, 20503.897480512504, 15948.8405115952, 15958.12230327343, 15976.680466390839, 16121.67756644884, 16132.919335403249, 12949.352532373156, 12962.611121666365, 13294.933525332312, 13358.064935454426, 13391.799123012968, 14209.502667407005, 14603.342849571582, 14677.633059173606, 15016.6996660064, 15263.23683815827], "value": 9540.136578852915, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 100.0, 106.0, 106.0, 108.0, 106.0, 99.0, 106.0, 108.0], "value": 104.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 112.0, 137.0, 163.0, 119.0, 140.0, 140.0, 120.0, 166.0, 114.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 160.0, 162.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 193.0, 77.0, 76.0, 78.0, 74.0, 156.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 127.0, 77.0, 78.0, 77.0, 121.0, 77.0, 77.0, 125.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 116.0, 117.0, 117.0, 114.0, 114.0, 114.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 96.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 52.0, 45.0, 49.0, 44.0, 49.0, 46.0, 45.0, 45.0, 45.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 51.0, 52.0, 53.0, 52.0, 52.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 73.0, 77.0, 72.0, 72.0, 73.0, 79.0, 75.0, 72.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 113.0, 122.0, 115.0, 116.0, 119.0, 120.0, 112.0, 139.0], "value": 118.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 156.0, 157.0, 162.0, 176.0, 160.0, 155.0, 165.0, 158.0, 169.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 58.0, 58.0, 64.0, 58.0, 57.0, 73.0, 57.0, 56.0], "value": 60.8, "unit": "score"}]}]} 09:15:01 INFO - Return code: 0 09:15:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:15:01 INFO - # TBPL SUCCESS # 09:15:01 INFO - Running post-action listener: _package_coverage_data 09:15:01 INFO - Running post-action listener: _resource_record_post_action 09:15:01 INFO - [mozharness: 2017-08-18 16:15:01.137271Z] Finished run-tests step (success) 09:15:01 INFO - Running post-run listener: _resource_record_post_run 09:15:01 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 6291456; Write bytes: 386764800; Read time: 2864; Write time: 271048 09:15:01 INFO - TinderboxPrint: CPU usage
13.0% 09:15:01 INFO - TinderboxPrint: I/O read bytes / time
6,291,456 / 2,864 09:15:01 INFO - TinderboxPrint: I/O write bytes / time
386,764,800 / 271,048 09:15:01 INFO - TinderboxPrint: CPU idle
8,216.5 (87.0%) 09:15:01 INFO - TinderboxPrint: CPU user
1,181.2 (12.5%) 09:15:01 INFO - TinderboxPrint: Swap in / out
0 / 0 09:15:01 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110211072; Read time: 36; Write time: 110428 09:15:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:15:01 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 3919872; Write bytes: 276553728; Read time: 2388; Write time: 160620 09:15:01 INFO - Running post-run listener: _upload_blobber_files 09:15:01 INFO - Blob upload gear active. 09:15:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:15:01 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 09:15:01 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'] 09:15:01 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 09:15:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:15:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:15:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:02 INFO - (blobuploader) - INFO - Done attempting. 09:15:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:15:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:04 INFO - (blobuploader) - INFO - Done attempting. 09:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:10 INFO - (blobuploader) - INFO - Done attempting. 09:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:11 INFO - (blobuploader) - INFO - Done attempting. 09:15:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:15:11 INFO - Return code: 0 09:15:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:15:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:15:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/78eb08cc4fde6a32d1a1986ce8d602537513e99dc52ffc12a3cd642154f46989c1454d7d8397e73e16f94e2909a56004f3c91f4349fc5a5321d6477031748668", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b67d8c2c12b183175e903a4189e2b05d89776c74fb7a771b902af9e98764fb4b623ca5c1ee6fa77a03f38b3720c0fc2eb4fe0739e73538543cef4c081a514a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ecedc81aedb5232b88544016952c9c859af6c2775fbd7cf2e051f9b35ac24bb18517d6ee9fe14196733aade7e2a5339d08037a6762404cac3e12316cc888bf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/18e909be01f99e585f6d630bf63c81aebf115e149b910db279c1faeb16be9718435404a81e2be28275f90492cc09e0d25d37e07fcaf6bb7174b2eea471f2fdff"} 09:15:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:15:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:15:11 INFO - Contents: 09:15:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/78eb08cc4fde6a32d1a1986ce8d602537513e99dc52ffc12a3cd642154f46989c1454d7d8397e73e16f94e2909a56004f3c91f4349fc5a5321d6477031748668", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b67d8c2c12b183175e903a4189e2b05d89776c74fb7a771b902af9e98764fb4b623ca5c1ee6fa77a03f38b3720c0fc2eb4fe0739e73538543cef4c081a514a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ecedc81aedb5232b88544016952c9c859af6c2775fbd7cf2e051f9b35ac24bb18517d6ee9fe14196733aade7e2a5339d08037a6762404cac3e12316cc888bf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/18e909be01f99e585f6d630bf63c81aebf115e149b910db279c1faeb16be9718435404a81e2be28275f90492cc09e0d25d37e07fcaf6bb7174b2eea471f2fdff"} 09:15:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:15:11 INFO - Copying logs to upload dir... 09:15:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:15:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.989899 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-18 09:15:11.246662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 09:15:11.254277) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459 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/78eb08cc4fde6a32d1a1986ce8d602537513e99dc52ffc12a3cd642154f46989c1454d7d8397e73e16f94e2909a56004f3c91f4349fc5a5321d6477031748668", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b67d8c2c12b183175e903a4189e2b05d89776c74fb7a771b902af9e98764fb4b623ca5c1ee6fa77a03f38b3720c0fc2eb4fe0739e73538543cef4c081a514a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ecedc81aedb5232b88544016952c9c859af6c2775fbd7cf2e051f9b35ac24bb18517d6ee9fe14196733aade7e2a5339d08037a6762404cac3e12316cc888bf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/18e909be01f99e585f6d630bf63c81aebf115e149b910db279c1faeb16be9718435404a81e2be28275f90492cc09e0d25d37e07fcaf6bb7174b2eea471f2fdff"} build_url:https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/DEuWB2k6QUiZM6PwgNLnRg/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/78eb08cc4fde6a32d1a1986ce8d602537513e99dc52ffc12a3cd642154f46989c1454d7d8397e73e16f94e2909a56004f3c91f4349fc5a5321d6477031748668", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b67d8c2c12b183175e903a4189e2b05d89776c74fb7a771b902af9e98764fb4b623ca5c1ee6fa77a03f38b3720c0fc2eb4fe0739e73538543cef4c081a514a9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3ecedc81aedb5232b88544016952c9c859af6c2775fbd7cf2e051f9b35ac24bb18517d6ee9fe14196733aade7e2a5339d08037a6762404cac3e12316cc888bf3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/18e909be01f99e585f6d630bf63c81aebf115e149b910db279c1faeb16be9718435404a81e2be28275f90492cc09e0d25d37e07fcaf6bb7174b2eea471f2fdff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 09:15:11.283212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 09:15:11.283499) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503071655.578807-548855459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 09:15:11.365479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 09:15:11.365757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 09:15:11.369067) ========= ========= Total master_lag: 1.50 =========