builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1503538195.8 results: success (0) revision: c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.796383) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.796817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.797103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.812969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.813221) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 18:29:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-08-23 18:29:56 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.971410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:55.971721) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016828 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.023314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.023612) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de --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 c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de --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=6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 18:29:56,526 truncating revision to first 12 chars 2017-08-23 18:29:56,526 Setting DEBUG logging. 2017-08-23 18:29:56,526 attempt 1/10 2017-08-23 18:29:56,526 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c9f31d1cd425?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 18:29:56,996 unpacking tar archive at: mozilla-beta-c9f31d1cd425/testing/mozharness/ program finished with exit code 0 elapsedTime=0.817391 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.948043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.948341) ========= script_repo_revision: c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.948737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.952016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 18:29:56.963590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-08-23 18:29:56.963866) ========= /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=6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:57 INFO - MultiFileLogger online at 20170823 18:29:57 in /builds/slave/test 18:29:57 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 18:29:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:57 INFO - {'append_to_log': False, 18:29:57 INFO - 'base_work_dir': '/builds/slave/test', 18:29:57 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:29:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:57 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:29:57 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:57 INFO - 'code_coverage': False, 18:29:57 INFO - 'config_files': ('talos/linux_config.py',), 18:29:57 INFO - 'default_actions': ('clobber', 18:29:57 INFO - 'read-buildbot-config', 18:29:57 INFO - 'download-and-extract', 18:29:57 INFO - 'populate-webroot', 18:29:57 INFO - 'create-virtualenv', 18:29:57 INFO - 'install', 18:29:57 INFO - 'setup-mitmproxy', 18:29:57 INFO - 'run-tests'), 18:29:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:57 INFO - 'disable_ccov_upload': False, 18:29:57 INFO - 'download_minidump_stackwalk': True, 18:29:57 INFO - 'download_symbols': 'ondemand', 18:29:57 INFO - 'enable_stylo': False, 18:29:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:57 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:57 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:57 INFO - 'gecko_profile': False, 18:29:57 INFO - 'gecko_profile_interval': 0, 18:29:57 INFO - 'installer_path': 'installer.exe', 18:29:57 INFO - 'log_level': 'info', 18:29:57 INFO - 'log_name': 'talos', 18:29:57 INFO - 'log_to_console': True, 18:29:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:57 INFO - 'opt_config_files': (), 18:29:57 INFO - 'pip_index': False, 18:29:57 INFO - 'suite': 'dromaeojs-e10s', 18:29:57 INFO - 'system_bits': '32', 18:29:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:57 INFO - 'title': 'talos-linux64-ix-023', 18:29:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:57 INFO - 'use_talos_json': True, 18:29:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:57 INFO - 'work_dir': 'build'} 18:29:57 INFO - [mozharness: 2017-08-24 01:29:57.568216Z] Running clobber step. 18:29:57 INFO - Running pre-action listener: _resource_record_pre_action 18:29:57 INFO - Running main action method: clobber 18:29:57 INFO - rmtree: /builds/slave/test/build 18:29:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:58 INFO - Running post-action listener: _resource_record_post_action 18:29:58 INFO - [mozharness: 2017-08-24 01:29:58.619111Z] Finished clobber step (success) 18:29:58 INFO - [mozharness: 2017-08-24 01:29:58.619215Z] Running read-buildbot-config step. 18:29:58 INFO - Running pre-action listener: _resource_record_pre_action 18:29:58 INFO - Running main action method: read_buildbot_config 18:29:58 INFO - Using buildbot properties: 18:29:58 INFO - { 18:29:58 INFO - "project": "", 18:29:58 INFO - "product": "firefox", 18:29:58 INFO - "who": "rjesup@wgate.com", 18:29:58 INFO - "installer_path": "public/build/target.tar.bz2", 18:29:58 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:29:58 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:29:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:29:58 INFO - "stage_platform": "linux64", 18:29:58 INFO - "basedir": "/builds/slave/test", 18:29:58 INFO - "buildnumber": 60, 18:29:58 INFO - "platform": "ubuntu64_hw", 18:29:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:29:58 INFO - "slavebuilddir": "test", 18:29:58 INFO - "taskId": "S3Ui49l3QvuYP7J97Bm7kg", 18:29:58 INFO - "branch": "mozilla-beta", 18:29:58 INFO - "script_repo_revision": "production", 18:29:58 INFO - "revision": "c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de", 18:29:58 INFO - "slavename": "talos-linux64-ix-023", 18:29:58 INFO - "repo_path": "releases/mozilla-beta" 18:29:58 INFO - } 18:29:58 INFO - Finding installer, test and symbols from parent task. 18:29:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3Ui49l3QvuYP7J97Bm7kg'}, attempt #1 18:29:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3Ui49l3QvuYP7J97Bm7kg'}, attempt #1 18:29:59 INFO - Task dependencies: FXKmGW-ISvGwTLfarjOYBA 18:29:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA'}, attempt #1 18:29:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2 18:29:59 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.test_packages.json 18:29:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.crashreporter-symbols.zip 18:29:59 INFO - Running post-action listener: _resource_record_post_action 18:29:59 INFO - [mozharness: 2017-08-24 01:29:59.974405Z] Finished read-buildbot-config step (success) 18:29:59 INFO - [mozharness: 2017-08-24 01:29:59.974628Z] Running download-and-extract step. 18:29:59 INFO - Running pre-action listener: _resource_record_pre_action 18:29:59 INFO - Running main action method: download_and_extract 18:29:59 INFO - mkdir: /builds/slave/test/build/tests 18:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:29:59 INFO - trying https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.test_packages.json 18:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:30:00 INFO - Downloaded 989 bytes. 18:30:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:30:00 INFO - Using the following test package requirements: 18:30:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:30:00 INFO - u'common': [u'target.common.tests.zip'], 18:30:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:30:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:30:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:30:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:30:00 INFO - u'mozbase': [u'target.common.tests.zip'], 18:30:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:30:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:30:00 INFO - u'web-platform': [u'target.common.tests.zip', 18:30:00 INFO - u'target.web-platform.tests.tar.gz'], 18:30:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:30:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:30:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.common.tests.zip 18:30:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:30:00 INFO - Fetch https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.common.tests.zip into memory 18:30:01 INFO - Content-Length response header: 72857554 18:30:01 INFO - Bytes received: 72857554 18:30:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:30:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.common.tests.zip 18:30:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:30:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.common.tests.zip into memory 18:30:14 INFO - Content-Length response header: 72857554 18:30:14 INFO - Bytes received: 72857554 18:30:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.talos.tests.zip 18:30:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:30:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.talos.tests.zip into memory 18:30:28 INFO - Content-Length response header: 14496472 18:30:28 INFO - Bytes received: 14496472 18:30:28 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')]} 18:30:28 INFO - trying https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2 18:30:28 INFO - Downloading https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:30:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:30:29 INFO - Downloaded 54100419 bytes. 18:30:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2 18:30:29 INFO - mkdir: /builds/slave/test/properties 18:30:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:30:29 INFO - Writing to file /builds/slave/test/properties/build_url 18:30:29 INFO - Contents: 18:30:29 INFO - build_url:https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2 18:30:29 INFO - Running post-action listener: _resource_record_post_action 18:30:29 INFO - Running post-action listener: set_extra_try_arguments 18:30:29 INFO - [mozharness: 2017-08-24 01:30:29.801132Z] Finished download-and-extract step (success) 18:30:29 INFO - [mozharness: 2017-08-24 01:30:29.801230Z] Running populate-webroot step. 18:30:29 INFO - Running pre-action listener: _resource_record_pre_action 18:30:29 INFO - Running main action method: populate_webroot 18:30:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:30:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:30:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:30:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:30:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:30:29 INFO - 'tests': ['damp', 'tps']}, 18:30:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:30:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:30:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:30:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:30:29 INFO - 'other-e10s': {'tests': ['a11yr', 18:30:29 INFO - 'ts_paint', 18:30:29 INFO - 'tpaint', 18:30:29 INFO - 'sessionrestore', 18:30:29 INFO - 'sessionrestore_many_windows', 18:30:29 INFO - 'sessionrestore_no_auto_restore', 18:30:29 INFO - 'tabpaint']}, 18:30:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:30:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:30:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:30:29 INFO - 'talos_options': ['--mitmproxy', 18:30:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:30:29 INFO - '--firstNonBlankPaint'], 18:30:29 INFO - 'tests': ['quantum_pageload_google', 18:30:29 INFO - 'quantum_pageload_youtube', 18:30:29 INFO - 'quantum_pageload_amazon', 18:30:29 INFO - 'quantum_pageload_facebook']}, 18:30:29 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:30:29 INFO - 'talos_options': ['--stylo', 18:30:29 INFO - '--mitmproxy', 18:30:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:30:29 INFO - '--firstNonBlankPaint'], 18:30:29 INFO - 'tests': ['quantum_pageload_google', 18:30:29 INFO - 'quantum_pageload_youtube', 18:30:29 INFO - 'quantum_pageload_amazon', 18:30:29 INFO - 'quantum_pageload_facebook']}, 18:30:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:30:29 INFO - 'tsvgr_opacity', 18:30:29 INFO - 'tart', 18:30:29 INFO - 'tscrollx', 18:30:29 INFO - 'cart', 18:30:29 INFO - 'tsvg_static']}, 18:30:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:30:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:30:29 INFO - 'talos_options': ['--stylo', 18:30:29 INFO - '--stylo-threads=1', 18:30:29 INFO - '--mitmproxy', 18:30:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:30:29 INFO - '--firstNonBlankPaint'], 18:30:29 INFO - 'tests': ['tp6_google', 18:30:29 INFO - 'tp6_youtube', 18:30:29 INFO - 'tp6_amazon', 18:30:29 INFO - 'tp6_facebook']}, 18:30:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:30:29 INFO - 'talos_options': ['--xperf_path', 18:30:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:30:29 INFO - 'tests': ['tp5n']}}} 18:30:29 INFO - Running post-action listener: _resource_record_post_action 18:30:29 INFO - [mozharness: 2017-08-24 01:30:29.809886Z] Finished populate-webroot step (success) 18:30:29 INFO - [mozharness: 2017-08-24 01:30:29.809977Z] Running create-virtualenv step. 18:30:29 INFO - Running pre-action listener: _resource_record_pre_action 18:30:29 INFO - Running main action method: create_virtualenv 18:30:29 INFO - Creating virtualenv /builds/slave/test/build/venv 18:30:29 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 18:30:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:30:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:30:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:30:29 INFO - Using real prefix '/usr' 18:30:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:30:30 INFO - Installing distribute.............................................................................................................................................................................................done. 18:30:32 INFO - Installing pip.................done. 18:30:32 INFO - Return code: 0 18:30:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:30:32 INFO - Reading from file tmpfile_stdout 18:30:32 INFO - Output received: 18:30:32 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) 18:30:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:30:32 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')]} 18:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:32 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')]} 18:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:32 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:32 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 18:30:32 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 18:30:32 INFO - Using env: {'DISPLAY': ':0', 18:30:32 INFO - 'HOME': '/home/cltbld', 18:30:32 INFO - 'LANG': 'en_US.UTF-8', 18:30:32 INFO - 'LANGUAGE': 'en_US:en', 18:30:32 INFO - 'LOGNAME': 'cltbld', 18:30:32 INFO - 'MAIL': '/var/mail/cltbld', 18:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:32 INFO - 'MOZ_NO_REMOTE': '1', 18:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:32 INFO - 'NO_EM_RESTART': '1', 18:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:32 INFO - 'PWD': '/builds/slave/test', 18:30:32 INFO - 'SHELL': '/bin/bash', 18:30:32 INFO - 'SHLVL': '1', 18:30:32 INFO - 'TERM': 'linux', 18:30:32 INFO - 'TMOUT': '86400', 18:30:32 INFO - 'USER': 'cltbld', 18:30:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:32 INFO - '_': '/tools/buildbot/bin/python'} 18:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:32 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 18:30:32 INFO - Cleaning up... 18:30:32 INFO - Return code: 0 18:30:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:30:32 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')]} 18:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:32 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')]} 18:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:32 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:32 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 18:30:32 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 18:30:32 INFO - Using env: {'DISPLAY': ':0', 18:30:32 INFO - 'HOME': '/home/cltbld', 18:30:32 INFO - 'LANG': 'en_US.UTF-8', 18:30:32 INFO - 'LANGUAGE': 'en_US:en', 18:30:32 INFO - 'LOGNAME': 'cltbld', 18:30:32 INFO - 'MAIL': '/var/mail/cltbld', 18:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:32 INFO - 'MOZ_NO_REMOTE': '1', 18:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:32 INFO - 'NO_EM_RESTART': '1', 18:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:32 INFO - 'PWD': '/builds/slave/test', 18:30:32 INFO - 'SHELL': '/bin/bash', 18:30:32 INFO - 'SHLVL': '1', 18:30:32 INFO - 'TERM': 'linux', 18:30:32 INFO - 'TMOUT': '86400', 18:30:32 INFO - 'USER': 'cltbld', 18:30:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:32 INFO - '_': '/tools/buildbot/bin/python'} 18:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:32 INFO - Downloading/unpacking psutil>=3.1.1 18:30:32 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 18:30:32 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 18:30:32 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 18:30:32 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 18:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:30:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:34 INFO - Installing collected packages: psutil 18:30:34 INFO - Running setup.py install for psutil 18:30:34 INFO - building 'psutil._psutil_linux' extension 18:30:34 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 18:30:34 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 18:30:34 INFO - building 'psutil._psutil_posix' extension 18:30:34 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 18:30:34 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 18:30:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:30:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:30:34 INFO - Successfully installed psutil 18:30:34 INFO - Cleaning up... 18:30:34 INFO - Return code: 0 18:30:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:34 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:34 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 18:30:34 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 18:30:34 INFO - Using env: {'DISPLAY': ':0', 18:30:34 INFO - 'HOME': '/home/cltbld', 18:30:34 INFO - 'LANG': 'en_US.UTF-8', 18:30:34 INFO - 'LANGUAGE': 'en_US:en', 18:30:34 INFO - 'LOGNAME': 'cltbld', 18:30:34 INFO - 'MAIL': '/var/mail/cltbld', 18:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:34 INFO - 'MOZ_NO_REMOTE': '1', 18:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:34 INFO - 'NO_EM_RESTART': '1', 18:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:34 INFO - 'PWD': '/builds/slave/test', 18:30:34 INFO - 'SHELL': '/bin/bash', 18:30:34 INFO - 'SHLVL': '1', 18:30:34 INFO - 'TERM': 'linux', 18:30:34 INFO - 'TMOUT': '86400', 18:30:34 INFO - 'USER': 'cltbld', 18:30:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:34 INFO - '_': '/tools/buildbot/bin/python'} 18:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:30:34 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 18:30:34 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 18:30:34 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 18:30:34 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 18:30:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:30:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:30:36 INFO - Installing collected packages: mozsystemmonitor 18:30:36 INFO - Running setup.py install for mozsystemmonitor 18:30:36 INFO - Successfully installed mozsystemmonitor 18:30:36 INFO - Cleaning up... 18:30:36 INFO - Return code: 0 18:30:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:30:36 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')]} 18:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:36 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')]} 18:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:36 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:36 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 18:30:36 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 18:30:36 INFO - Using env: {'DISPLAY': ':0', 18:30:36 INFO - 'HOME': '/home/cltbld', 18:30:36 INFO - 'LANG': 'en_US.UTF-8', 18:30:36 INFO - 'LANGUAGE': 'en_US:en', 18:30:36 INFO - 'LOGNAME': 'cltbld', 18:30:36 INFO - 'MAIL': '/var/mail/cltbld', 18:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:36 INFO - 'MOZ_NO_REMOTE': '1', 18:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:36 INFO - 'NO_EM_RESTART': '1', 18:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:36 INFO - 'PWD': '/builds/slave/test', 18:30:36 INFO - 'SHELL': '/bin/bash', 18:30:36 INFO - 'SHLVL': '1', 18:30:36 INFO - 'TERM': 'linux', 18:30:36 INFO - 'TMOUT': '86400', 18:30:36 INFO - 'USER': 'cltbld', 18:30:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:36 INFO - '_': '/tools/buildbot/bin/python'} 18:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:36 INFO - Downloading/unpacking jsonschema==2.5.1 18:30:36 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 18:30:36 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 18:30:36 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 18:30:36 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 18:30:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:30:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 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 18:30:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:30:37 INFO - warning: no files found matching '*.txt' 18:30:37 INFO - no previously-included directories found matching 'build' 18:30:37 INFO - no previously-included directories found matching 'dist' 18:30:37 INFO - no previously-included directories found matching '.git*' 18:30:37 INFO - Installing collected packages: jsonschema, functools32 18:30:37 INFO - Running setup.py install for functools32 18:30:37 INFO - warning: no files found matching '*.txt' 18:30:37 INFO - no previously-included directories found matching 'build' 18:30:37 INFO - no previously-included directories found matching 'dist' 18:30:37 INFO - no previously-included directories found matching '.git*' 18:30:37 INFO - Successfully installed jsonschema functools32 18:30:37 INFO - Cleaning up... 18:30:37 INFO - Return code: 0 18:30:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:30:37 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')]} 18:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:37 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')]} 18:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:37 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:37 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 18:30:37 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 18:30:37 INFO - Using env: {'DISPLAY': ':0', 18:30:37 INFO - 'HOME': '/home/cltbld', 18:30:37 INFO - 'LANG': 'en_US.UTF-8', 18:30:37 INFO - 'LANGUAGE': 'en_US:en', 18:30:37 INFO - 'LOGNAME': 'cltbld', 18:30:37 INFO - 'MAIL': '/var/mail/cltbld', 18:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:37 INFO - 'MOZ_NO_REMOTE': '1', 18:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:37 INFO - 'NO_EM_RESTART': '1', 18:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:37 INFO - 'PWD': '/builds/slave/test', 18:30:37 INFO - 'SHELL': '/bin/bash', 18:30:37 INFO - 'SHLVL': '1', 18:30:37 INFO - 'TERM': 'linux', 18:30:37 INFO - 'TMOUT': '86400', 18:30:37 INFO - 'USER': 'cltbld', 18:30:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:37 INFO - '_': '/tools/buildbot/bin/python'} 18:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:30:38 INFO - Cleaning up... 18:30:38 INFO - Return code: 0 18:30:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:30:38 INFO - Using env: {'DISPLAY': ':0', 18:30:38 INFO - 'HOME': '/home/cltbld', 18:30:38 INFO - 'LANG': 'en_US.UTF-8', 18:30:38 INFO - 'LANGUAGE': 'en_US:en', 18:30:38 INFO - 'LOGNAME': 'cltbld', 18:30:38 INFO - 'MAIL': '/var/mail/cltbld', 18:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:38 INFO - 'MOZ_NO_REMOTE': '1', 18:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:38 INFO - 'NO_EM_RESTART': '1', 18:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:38 INFO - 'PWD': '/builds/slave/test', 18:30:38 INFO - 'SHELL': '/bin/bash', 18:30:38 INFO - 'SHLVL': '1', 18:30:38 INFO - 'TERM': 'linux', 18:30:38 INFO - 'TMOUT': '86400', 18:30:38 INFO - 'USER': 'cltbld', 18:30:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:38 INFO - '_': '/tools/buildbot/bin/python'} 18:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 18:30:38 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 18:30:38 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 18:30:38 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 18:30:38 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 18:30:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:30:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:30:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:39 INFO - Downloading docopt-0.6.1.tar.gz 18:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:30:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:30:40 INFO - Running setup.py install for blobuploader 18:30:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:30:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:30:40 INFO - Running setup.py install for requests 18:30:40 INFO - Running setup.py install for docopt 18:30:40 INFO - Successfully installed blobuploader requests docopt 18:30:40 INFO - Cleaning up... 18:30:40 INFO - Return code: 0 18:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:40 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')]} 18:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:40 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')]} 18:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:40 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:40 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 18:30:40 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 18:30:40 INFO - Using env: {'DISPLAY': ':0', 18:30:40 INFO - 'HOME': '/home/cltbld', 18:30:40 INFO - 'LANG': 'en_US.UTF-8', 18:30:40 INFO - 'LANGUAGE': 'en_US:en', 18:30:40 INFO - 'LOGNAME': 'cltbld', 18:30:40 INFO - 'MAIL': '/var/mail/cltbld', 18:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:40 INFO - 'MOZ_NO_REMOTE': '1', 18:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:40 INFO - 'NO_EM_RESTART': '1', 18:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:40 INFO - 'PWD': '/builds/slave/test', 18:30:40 INFO - 'SHELL': '/bin/bash', 18:30:40 INFO - 'SHLVL': '1', 18:30:40 INFO - 'TERM': 'linux', 18:30:40 INFO - 'TMOUT': '86400', 18:30:40 INFO - 'USER': 'cltbld', 18:30:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:40 INFO - '_': '/tools/buildbot/bin/python'} 18:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:40 INFO - Running setup.py (path:/tmp/pip-_jiA5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:40 INFO - Running setup.py (path:/tmp/pip-9x61az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:41 INFO - Running setup.py (path:/tmp/pip-G4MoJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:41 INFO - Running setup.py (path:/tmp/pip-NzdUEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:41 INFO - Running setup.py (path:/tmp/pip-EBp53G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:41 INFO - Running setup.py (path:/tmp/pip-6gWM9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:41 INFO - Running setup.py (path:/tmp/pip-VIsp2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:41 INFO - Running setup.py (path:/tmp/pip-0IEseo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:41 INFO - Running setup.py (path:/tmp/pip-cBJjy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:41 INFO - Running setup.py (path:/tmp/pip-pcO7q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:41 INFO - Running setup.py (path:/tmp/pip-TfIde3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:41 INFO - Running setup.py (path:/tmp/pip-k6mfTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:41 INFO - Running setup.py (path:/tmp/pip-HqBBgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:41 INFO - Running setup.py (path:/tmp/pip-ojsZEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:41 INFO - Running setup.py (path:/tmp/pip-cZ9Z6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:41 INFO - Running setup.py (path:/tmp/pip-QVIuur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:42 INFO - Running setup.py (path:/tmp/pip-YRSvox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:30:42 INFO - Running setup.py install for manifestparser 18:30:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Running setup.py install for mozcrash 18:30:42 INFO - Running setup.py install for mozdebug 18:30:42 INFO - Running setup.py install for mozdevice 18:30:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Running setup.py install for mozfile 18:30:42 INFO - Running setup.py install for mozhttpd 18:30:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Running setup.py install for mozinfo 18:30:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Running setup.py install for mozInstall 18:30:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:30:42 INFO - Running setup.py install for mozleak 18:30:43 INFO - Running setup.py install for mozlog 18:30:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Running setup.py install for moznetwork 18:30:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Running setup.py install for mozprocess 18:30:43 INFO - Running setup.py install for mozprofile 18:30:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Running setup.py install for mozrunner 18:30:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Running setup.py install for mozscreenshot 18:30:43 INFO - Running setup.py install for moztest 18:30:43 INFO - Running setup.py install for mozversion 18:30:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:30:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:30:43 INFO - Cleaning up... 18:30:43 INFO - Return code: 0 18:30:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:43 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:43 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 18:30:43 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 18:30:43 INFO - Using env: {'DISPLAY': ':0', 18:30:43 INFO - 'HOME': '/home/cltbld', 18:30:43 INFO - 'LANG': 'en_US.UTF-8', 18:30:43 INFO - 'LANGUAGE': 'en_US:en', 18:30:43 INFO - 'LOGNAME': 'cltbld', 18:30:43 INFO - 'MAIL': '/var/mail/cltbld', 18:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:43 INFO - 'MOZ_NO_REMOTE': '1', 18:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:43 INFO - 'NO_EM_RESTART': '1', 18:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:43 INFO - 'PWD': '/builds/slave/test', 18:30:43 INFO - 'SHELL': '/bin/bash', 18:30:43 INFO - 'SHLVL': '1', 18:30:43 INFO - 'TERM': 'linux', 18:30:43 INFO - 'TMOUT': '86400', 18:30:43 INFO - 'USER': 'cltbld', 18:30:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:43 INFO - '_': '/tools/buildbot/bin/python'} 18:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:30:44 INFO - Running setup.py (path:/tmp/pip-64yK4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:30:44 INFO - Running setup.py (path:/tmp/pip-fqcpjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:30:44 INFO - Running setup.py (path:/tmp/pip-4DaEZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:30:44 INFO - Running setup.py (path:/tmp/pip-V9YdfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:30:44 INFO - Running setup.py (path:/tmp/pip-W5dA06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:30:44 INFO - Running setup.py (path:/tmp/pip-bouLGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:30:44 INFO - Running setup.py (path:/tmp/pip-zy7quP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:30:44 INFO - Running setup.py (path:/tmp/pip-wIUwo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:30:44 INFO - Running setup.py (path:/tmp/pip-zWsrR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:30:44 INFO - Running setup.py (path:/tmp/pip-zAngYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:30:44 INFO - Running setup.py (path:/tmp/pip-ntfFif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:30:44 INFO - Running setup.py (path:/tmp/pip-72e2bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:30:44 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)) 18:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:30:45 INFO - Running setup.py (path:/tmp/pip-5GgT2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:30:45 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)) 18:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:30:45 INFO - Running setup.py (path:/tmp/pip-HIKFPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:30:45 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)) 18:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:45 INFO - Running setup.py (path:/tmp/pip-woZKMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:30:45 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)) 18:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:30:45 INFO - Running setup.py (path:/tmp/pip-JjTSnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:30:45 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)) 18:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:30:45 INFO - Running setup.py (path:/tmp/pip-6vjM4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 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)) 18:30:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:46 INFO - Downloading blessings-1.6.tar.gz 18:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:30:46 INFO - Installing collected packages: blessings 18:30:46 INFO - Running setup.py install for blessings 18:30:46 INFO - Successfully installed blessings 18:30:46 INFO - Cleaning up... 18:30:46 INFO - Return code: 0 18:30:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:46 INFO - Reading from file tmpfile_stdout 18:30:46 INFO - Current package versions: 18:30:46 INFO - argparse == 1.2.1 18:30:46 INFO - blessings == 1.6 18:30:46 INFO - blobuploader == 1.2.4 18:30:46 INFO - docopt == 0.6.1 18:30:46 INFO - functools32 == 3.2.3-2 18:30:46 INFO - jsonschema == 2.5.1 18:30:46 INFO - manifestparser == 1.1 18:30:46 INFO - mozInstall == 1.13 18:30:46 INFO - mozcrash == 1.0 18:30:46 INFO - mozdebug == 0.1 18:30:46 INFO - mozdevice == 0.51 18:30:46 INFO - mozfile == 1.2 18:30:46 INFO - mozhttpd == 0.7 18:30:46 INFO - mozinfo == 0.10 18:30:46 INFO - mozleak == 0.1 18:30:46 INFO - mozlog == 3.5 18:30:46 INFO - moznetwork == 0.27 18:30:46 INFO - mozprocess == 0.25 18:30:46 INFO - mozprofile == 0.28 18:30:46 INFO - mozrunner == 6.13 18:30:46 INFO - mozscreenshot == 0.1 18:30:46 INFO - mozsystemmonitor == 0.3 18:30:46 INFO - moztest == 0.8 18:30:46 INFO - mozversion == 1.4 18:30:46 INFO - psutil == 3.1.1 18:30:46 INFO - requests == 1.2.3 18:30:46 INFO - wsgiref == 0.1.2 18:30:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:46 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:46 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 18:30:46 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 18:30:46 INFO - Using env: {'DISPLAY': ':0', 18:30:46 INFO - 'HOME': '/home/cltbld', 18:30:46 INFO - 'LANG': 'en_US.UTF-8', 18:30:46 INFO - 'LANGUAGE': 'en_US:en', 18:30:46 INFO - 'LOGNAME': 'cltbld', 18:30:46 INFO - 'MAIL': '/var/mail/cltbld', 18:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:46 INFO - 'MOZ_NO_REMOTE': '1', 18:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:46 INFO - 'NO_EM_RESTART': '1', 18:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:46 INFO - 'PWD': '/builds/slave/test', 18:30:46 INFO - 'SHELL': '/bin/bash', 18:30:46 INFO - 'SHLVL': '1', 18:30:46 INFO - 'TERM': 'linux', 18:30:46 INFO - 'TMOUT': '86400', 18:30:46 INFO - 'USER': 'cltbld', 18:30:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:46 INFO - '_': '/tools/buildbot/bin/python'} 18:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 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)) 18:30:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:30:48 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)) 18:30:48 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)) 18:30:48 INFO - Installing collected packages: simplejson 18:30:48 INFO - Running setup.py install for simplejson 18:30:48 INFO - building 'simplejson._speedups' extension 18:30:48 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 18:30:49 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 18:30:49 INFO - Successfully installed simplejson 18:30:49 INFO - Cleaning up... 18:30:49 INFO - Return code: 0 18:30:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:30:49 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')]} 18:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:30:49 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')]} 18:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:30:49 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 0xa041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd73eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', '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 18:30:49 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 18:30:49 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 18:30:49 INFO - Using env: {'DISPLAY': ':0', 18:30:49 INFO - 'HOME': '/home/cltbld', 18:30:49 INFO - 'LANG': 'en_US.UTF-8', 18:30:49 INFO - 'LANGUAGE': 'en_US:en', 18:30:49 INFO - 'LOGNAME': 'cltbld', 18:30:49 INFO - 'MAIL': '/var/mail/cltbld', 18:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:49 INFO - 'MOZ_NO_REMOTE': '1', 18:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:49 INFO - 'NO_EM_RESTART': '1', 18:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:49 INFO - 'PWD': '/builds/slave/test', 18:30:49 INFO - 'SHELL': '/bin/bash', 18:30:49 INFO - 'SHLVL': '1', 18:30:49 INFO - 'TERM': 'linux', 18:30:49 INFO - 'TMOUT': '86400', 18:30:49 INFO - 'USER': 'cltbld', 18:30:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:49 INFO - '_': '/tools/buildbot/bin/python'} 18:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:30:49 INFO - Cleaning up... 18:30:49 INFO - Return code: 0 18:30:49 INFO - Running post-action listener: _resource_record_post_action 18:30:49 INFO - Running post-action listener: _start_resource_monitoring 18:30:49 INFO - Starting resource monitoring. 18:30:49 INFO - [mozharness: 2017-08-24 01:30:49.630456Z] Finished create-virtualenv step (success) 18:30:49 INFO - [mozharness: 2017-08-24 01:30:49.630972Z] Running install step. 18:30:49 INFO - Running pre-action listener: _resource_record_pre_action 18:30:49 INFO - Running main action method: install 18:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:30:49 INFO - Reading from file tmpfile_stdout 18:30:49 INFO - Detecting whether we're running mozinstall >=1.0... 18:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:30:49 INFO - Reading from file tmpfile_stdout 18:30:49 INFO - Output received: 18:30:49 INFO - Usage: mozinstall [options] installer 18:30:49 INFO - Options: 18:30:49 INFO - -h, --help show this help message and exit 18:30:49 INFO - -d DEST, --destination=DEST 18:30:50 INFO - Directory to install application into. [default: 18:30:50 INFO - "/builds/slave/test"] 18:30:50 INFO - --app=APP Application being installed. [default: firefox] 18:30:50 INFO - mkdir: /builds/slave/test/build/application 18:30:50 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'] 18:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:31:04 INFO - Reading from file tmpfile_stdout 18:31:04 INFO - Output received: 18:31:04 INFO - /builds/slave/test/build/application/firefox/firefox 18:31:04 INFO - Running post-action listener: _resource_record_post_action 18:31:04 INFO - [mozharness: 2017-08-24 01:31:04.766521Z] Finished install step (success) 18:31:04 INFO - [mozharness: 2017-08-24 01:31:04.766865Z] Running setup-mitmproxy step. 18:31:04 INFO - Running pre-action listener: _resource_record_pre_action 18:31:04 INFO - Running main action method: setup_mitmproxy 18:31:04 INFO - Skipping: mitmproxy is not required 18:31:04 INFO - Running post-action listener: _resource_record_post_action 18:31:04 INFO - [mozharness: 2017-08-24 01:31:04.768482Z] Finished setup-mitmproxy step (success) 18:31:04 INFO - [mozharness: 2017-08-24 01:31:04.768796Z] Running run-tests step. 18:31:04 INFO - Running pre-action listener: _resource_record_pre_action 18:31:04 INFO - Running pre-action listener: _set_gcov_prefix 18:31:04 INFO - Running main action method: run_tests 18:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:31:04 INFO - Python 2.7.3 18:31:04 INFO - Return code: 0 18:31:04 INFO - grabbing minidump binary from tooltool 18:31: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')]} 18:31:04 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 0xd71050>, '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 0xd71f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd723e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:31:04 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 18:31:04 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 18:31:04 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 18:31:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:31:04 INFO - Return code: 0 18:31:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:31:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:31:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:31:04 INFO - ENV: RUST_BACKTRACE is now 1 18:31:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:31:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:31:04 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/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:31:04 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/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:31:04 INFO - Using env: {'DISPLAY': ':0', 18:31:04 INFO - 'HOME': '/home/cltbld', 18:31:04 INFO - 'LANG': 'en_US.UTF-8', 18:31:04 INFO - 'LANGUAGE': 'en_US:en', 18:31:04 INFO - 'LOGNAME': 'cltbld', 18:31:04 INFO - 'MAIL': '/var/mail/cltbld', 18:31:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:31:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:04 INFO - 'MOZ_NO_REMOTE': '1', 18:31:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:04 INFO - 'NO_EM_RESTART': '1', 18:31:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:04 INFO - 'PWD': '/builds/slave/test', 18:31:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:31:04 INFO - 'RUST_BACKTRACE': '1', 18:31:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:31:04 INFO - 'SHELL': '/bin/bash', 18:31:04 INFO - 'SHLVL': '1', 18:31:04 INFO - 'TERM': 'linux', 18:31:04 INFO - 'TMOUT': '86400', 18:31:04 INFO - 'USER': 'cltbld', 18:31:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860', 18:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:04 INFO - '_': '/tools/buildbot/bin/python'} 18:31:04 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/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:31:05 INFO - mozversion application_buildid: 20170824001739 18:31:05 INFO - mozversion application_changeset: c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de 18:31:05 INFO - mozversion application_display_name: Firefox 18:31:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:31:05 INFO - mozversion application_name: Firefox 18:31:05 INFO - mozversion application_remotingname: firefox 18:31:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:31:05 INFO - mozversion application_vendor: Mozilla 18:31:05 INFO - mozversion application_version: 56.0 18:31:05 INFO - mozversion platform_buildid: 20170824001739 18:31:05 INFO - mozversion platform_changeset: c9f31d1cd425266f7a7440b09dc03e2fb4dcf1de 18:31:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:31:05 INFO - mozversion platform_version: 56.0 18:31:05 INFO - using testdate: 1503538265 18:31:05 INFO - actual date: 1503538265 18:31:05 INFO - starting webserver on 'localhost:57804' 18:31:05 INFO - SUITE-START | Running 2 tests 18:31:05 INFO - TEST-START | dromaeo_css 18:31:05 INFO - Initialising browser for dromaeo_css test... 18:31:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57804/getInfo.html -profile /tmp/tmpktXblP/profile 18:31:05 INFO - TEST-INFO | started process 5683 (/builds/slave/test/build/application/firefox/firefox http://localhost:57804/getInfo.html) 18:31:10 INFO - TEST-INFO | 5683: exit 0 18:31:10 INFO - Browser initialized. 18:31:10 INFO - Running cycle 1/1 for dromaeo_css test... 18:31:10 INFO - TEST-INFO | started process 5849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpktXblP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:10 INFO - PID 5849 | 1503538270746 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:4395 < 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 18:31:21 INFO - PID 5849 | RSS: Main: 150794240 18:31:21 INFO - PID 5849 | 18:34:19 INFO - PID 5849 | Cycle 1(1): loaded http://localhost:57804/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57804/tests/dromaeo/cssquery-ext.html) 18:34:20 INFO - PID 5849 | RSS: Main: 158498816 18:34:20 INFO - PID 5849 | 18:37:22 INFO - PID 5849 | Cycle 1(1): loaded http://localhost:57804/tests/dromaeo/cssquery-ext.html (next: http://localhost:57804/tests/dromaeo/cssquery-jquery.html) 18:37:22 INFO - PID 5849 | RSS: Main: 156893184 18:37:22 INFO - PID 5849 | 18:40:24 INFO - PID 5849 | Cycle 1(1): loaded http://localhost:57804/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57804/tests/dromaeo/cssquery-mootools.html) 18:40:24 INFO - PID 5849 | RSS: Main: 158937088 18:40:24 INFO - PID 5849 | 18:43:26 INFO - PID 5849 | Cycle 1(1): loaded http://localhost:57804/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57804/tests/dromaeo/cssquery-prototype.html) 18:43:27 INFO - PID 5849 | RSS: Main: 158642176 18:43:27 INFO - PID 5849 | 18:46:30 INFO - PID 5849 | Cycle 1(1): loaded http://localhost:57804/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57804/tests/dromaeo/cssquery-yui.html) 18:46:31 INFO - PID 5849 | RSS: Main: 160796672 18:46:31 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | Cycle 1(1): loaded http://localhost:57804/tests/dromaeo/cssquery-yui.html (next: http://localhost:57804/tests/dromaeo/cssquery-dojo.html) 18:49:32 INFO - PID 5849 | RSS: Main: 163647488 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | __start_tp_report 18:49:32 INFO - PID 5849 | _x_x_mozilla_page_load 18:49:32 INFO - PID 5849 | _x_x_mozilla_page_load_details 18:49:32 INFO - PID 5849 | |i|pagename|runs| 18:49:32 INFO - PID 5849 | |0;dojo.html;3601.657842504963;3631.4915911772373;3639.3267245559573;3643.3077715234112;3692.243090166516;6366.745330186787;6436.645984470852;6469.547131700783;6497.772577959772;6504.44712199463;6392;6405.42351188393;6487.545871788977;6495.837604059889;6512.544121911468;5516.365617953927;5545.500904918556;5549.528290095326;5561.499465048145;5664.943350566504;5594.860128496779;5620.831375058755;5654.46282603152;5663.943360566383;5668.603197776158;5614.466625670555;5615.382307946143;5649.576281778883;5674.744636491348;5693.316801983747;5563.109902415594;5601.747921343549;5630.296212973379;5637.267155269829;5639.3232812062815;5530.751116199781;5578.3584887738025;5614.9157762633595;5622.606417550773;5648.181013752983;6288.842778930518;6301.716422760941;6358.936410635927;6397.744090236385;6418.390252926011;6875.140607424072;6906.965465172692;6914.308569143096;6953.096097507342;6970.989206565019;7003.929960700379;7031.82420439488;7076.150861896605;7090.361867431904;7090.397316228127;6461.224653041618;6466;6510.479161667055;6557.93442065578;6569.802905912782;7019;7097.787066388017;7111.502194846311;7124;7127.82180445493;6762.425193858478;6772.966135169293;6781;6799.762008329685;6852.862942741117;6883.105196324546;6937.7224911004005;6963.059986901805;6984.266652001568;7018.613976231254;6819.488538359643;6937.202221744564;6944.409725173316;6983.301669832976;7008.579485230903;6741.1910570731825;6854.485913556503;6860.5197636164985;6934.029235906977;7011.964940175369;5116.846494605168;5124.666896651705;5126.384833819965;5153.3558305211845;5161;4620.861374158781;4628.490866004737;4636.884077898079;4653.930191047137;4653.95346046542;6655.900161497581;6660.367265109807;6661.600303981777;6734.528582999241;6740.258571557125;6813.318668133147;6920.9307906920285;6932.861342773217;6942.791716248521;7024.1571011478945;6551.6069035858;6617.7683781067435;6617.966910165418;6618.139641846529;6633;5849.385814489502;5858.384869588632;5872.677002764804;5917.940820591739;5948.196993405922;7103.715851365991;7174.246704095995;7181.461390395742;7183.353498185188;7193.172785129777;6862.725490980305;6868.484863635347;6897.48268879836;6930.13373328334;6935.895961560682;7128.572285662877;7158.785236442915;7249;7254.419646428168;7278.927210728037;6871.931280687129;6910.44716422695;6911.619860907497;6950.930490695028;6969.337912898267;7087.681054352463;7130.750423735144;7132.500724949411;7134.714611415485;7158.248383919822;6851.314868513109;6865.622390768555;6917.757878474229;6931.965340173267;6943.097397338515;6673.132492775908;6751;6769.559978601375;6796.592204467748;6810.965945170243;6778.4577233822165;6794.116764820542;6851.3491218334175;6854.485913556603;6867.450603951572;6770.052192693125;6856.897146542706;6922.896156557555;6930.653467326512;6946.16646002483;6506.967465162644;6630.104935833793;6652.800415987528;6731.697073631796;6749.055132281386 18:49:32 INFO - PID 5849 | |1;ext.html;930.2418528898943;953.6995846308413;969.5394687523426;998.0119681515303;998.1316254858274;44864.775676121615;46001.07997840041;46037.30944035834;46083;46085.53914460854;42333.36499952503;42362;42440.78779606106;42482.15035699284;42532.57467425325;7054.5061845670825;7177.318154775288;7202.639868006605;7206.819829504252;7209.927900721004;7319.487635865492;7410.40716742662;7416.369608583277;7418.109826820789;7420.628968551551;7845.137034926153;8091.4740541864885;8093;8095;8095.757127286161;7961.243681850215;7991.560464174497;7994.280514753642;7997.040355157389;7999.880001799977;7859.214078592152;7897.5656338901335;7922.683092676286;7930.801729956797;7931.484453510503;42013.1597368054;42410.57589424128;42616.57383426188;42723.35914961278;42761.786191068844;3803.315403227418;3838.3282925488206;3841.8463261469788;3842;3845.3462911304864;33512.16219594505;33578;33597.328053439036;33611.831940840384;33627.6637233627;5032.723200223986;5188.688678679254;5227.686338819683;5235.110031294689;5246;199603;200348;210171;210878;220628;53465;53518.46481535213;53552.464475355526;53621;53652.46347536553;55127;55178;55184.44815551873;55235.723821380634;55320.72339638276;18105.456836294932;18147.818521814876;18175;18215.544611384823;18440.17019234138;15203.163825989455;15215;15227.162506062274;15238.085714857145;15308.693826123637;15371.846281537266;15407.845921540866;15529;15532.534023979299;15694.529164125095;6049.304330002018;6206.813795586139;6229.563930524911;6230.563860529719;6311.211098612674;1097.4183682648209;1111.2499063132516;1112.0825319111766;1114.5207560748793;1116.2353787655481;25436.745632543807;25507.36231594188;25521;25710.228693139237;25763.742362576508;1207.5350989868964;1216.9330686812134;1231.1012960538858;1233.3956361382857;1259.200407741091;13173.736525269633;13179.209247445184;13309.800352994713;13346.06577539563;13417.194968301934;277063;277213;278174;278585;278969;56101.719491402284;56489.71755141198;56714;56782;56785;1585.5084923673467;1601.3417726573832;1616.5473667373155;1617.0782653887406;1631.208863701104;24778.25665230046;30304;30609.54085688672;30861.691383085883;30999;59564.404355955885;61065.38934610597;61801.381986179564;61916;62290.377096228454;245431;247190;247356;247547;247742;33520;37534.43698344472;38743.2251354977;40754;40789.796051019555;50361.49638503715;51233.23150152825;51377.229341559156;51429.48570514247;51446.742766285926;36773.44839827351;36886.815565922;36982.44526332054;37097.443538347485;37683.62316376911;38760.418593720555;39253.80373098116;39318;39540.20919581535;39560;43476;44306.3354049696;45197;45228.09543809171;45507.54492455033;38067.80966095152;38118.61881381151;38217.80891095527;38266.04334891539;39170.4124438128;27890.86054569714;28090.57864131999;28314.43371132607;28480.287992800346;28495.870743266412 18:49:32 INFO - PID 5849 | |2;jquery.html;604.1360853978808;608.6986941463977;612.1674522649198;624.6689254695013;627.3788948940548;24568.508629827393;24928.87535562324;25359.112431064917;25367.619485707706;25467;26498;27810.443791124166;27922;27943;27950.580741288897;6377.075324078018;6543.640099794509;6556.967215163918;6557.606543607375;6560.114384558071;6112.633242005471;6315.684215789215;6405.071264666621;6410.07053977173;6417.101605775195;6337.619742815423;6342.904856427134;6346.11154438379;6347.492200623939;6363.7454501819875;6286.3399343069;6294.464970477515;6343.46080583151;6347.650879201642;6354.650494222816;5920.200772895647;5940.168376427304;5955.196048533436;5962.25471816023;5970.55220858433;29541;30073;30765.538516922265;30970.53544196839;31103.37793244145;2348.553774782803;2384.225126833786;2392.557376885282;2393.054743376357;2393.246127469859;20057.297994570265;20401.387958361272;20501.077451514717;20501.38495845127;20616.793832061638;2383.212590557082;2457.127719659513;2484.4534202475425;2487.353288145095;2489.987550062238;140203;146309;153720;156212;161186;15862.096548414034;16562.254698538596;16582.834171658127;16594.75107873359;16678.33286668544;24860.627090593654;24922.37694057627;24923.50152996966;24943.87528062348;24994.87502562512;10998.835017474585;11255.212135150461;11354.716132096764;11420.600278990196;11558.248713833575;10372.377657340583;10451.111655509214;10503.264771466076;10618.787624247472;10660.147188224923;9581.425114493153;9851.310408271353;9947.80104397908;9984.101430871257;10089.293749437616;2808.4383123375405;2809.620701205352;2831.235566397061;2877.3813630069217;2946.4401763664837;1049.197364016528;1057.0961827637414;1071.6945670483874;1071.9088877445504;1081.453865797767;20864.37406877796;21206.893965530384;21273.36179914605;21619.162371198625;21763.67354489684;1145.1999860341552;1145.352875625269;1151.4645689754136;1156.2888823373564;1157.571698471571;11582.71043223926;11858.466369013415;11894.643160705193;11916.165868389304;12082;624512;639699;677246;683909;686250;128875;134068.32965835108;142350;149569;149805.25097374662;1329.6609364611961;1356.2540602668494;1374.223563686494;1386.6256110850013;1392.1716578635696;22390.440238994157;22439.21462748796;22455;22632.434189145402;22710.205142819923;66771.99842002471;67143.32856671371;67367.98948015686;68205.65897170482;69043.65478172577;85483.5725821367;86292.2741545153;87104;87504;89321.55339223263;15440.227988600749;16061.437849675205;16087.115208663636;16096.597585060466;16123.274452649424;24733.752662473144;24800.131995380074;24848.751512484643;24989.500209996062;25147.371315717253;20254;20330.491737706674;20355.898220508803;20506.17975280972;20573.279935202198;17642.5589360267;17943.82056179474;18171.636567268317;18182.81817181811;18653.533661658566;20547.38357849267;20615;20617.69073463929;20800;20819.271325503534;15609;15710.685786284439;15712.76430853561;15800.76298855541;15847.603809904844;20068.598628027066;20185;20216.98915054212;20397.69403458979;20418.387448376572 18:49:32 INFO - PID 5849 | |3;mootools.html;1455.9708805823882;1510.886683498738;1511.5843143135644;1529.2583097197858;1532.97700534492;15933.760993585105;16523.091229982347;16526.752098718513;16533.834661653378;16596.419125330616;16054.919725401356;17117.22972466239;17130.82869171308;17149.74275385867;17186.57033574158;2997.5054116070933;3011.1719277198727;3064.050144455226;3071.2936024714218;3072.308730535623;2898.304406942329;2980.8509574521295;2985.910422687312;2994.6705862355125;2996.6703662597097;3020.8187508749434;3028.530577760451;3030.348475077858;3052.5879006334194;3054.6639869614437;2909.0836386538385;2933.296008957856;2941;2943.205334559668;2962.007727411309;2888.234617826278;2899.5795609636693;2923.6637786654383;2928.282570770175;2951.4687356275863;16200.594985125348;16454.67090658192;16480.83519164805;16506.75239871403;16523.421680241136;8759.12408759119;9061.048589898097;9115.316351273616;9117.31620128493;9120.133587309196;5757.769689212427;5791.536677065825;5847.532197424196;5868.911966320508;5875.38308477608;1915.8850468971766;1921.951951201217;1941.8737782044122;1966.3412756726514;1970.7832138464757;27792.02727904534;27840.30399240015;28029.85985070082;28066;28078.298042548897;7077.327653872874;7159.928400715926;7289.890651640229;7465.925340746523;7473.327400533978;19348.129334179997;19351;19381.806181938002;19433.125509352114;19442.70835937462;8675;8834.955825220834;8835.381523293436;8838.823223535494;8842.778930526789;8032.598370081472;8064.274215320649;8153.7553873383895;8168.469049511763;8180.836383272302;5454.754536045887;6156.199694039746;6161.291451483047;6189.226346706661;6245.812625621239;1578.5895667126629;1706.2918888661316;1732.4542769027717;1750.2561411400359;1764.109124891947;966.9806603867884;975.2007546077476;976.345848281653;991.3159919655415;1004.4073996342194;9397.718068457958;9640.42157470554;9675.90324096764;9810.411375317504;9869.506524673738;1067.4982758103679;1077.42357838556;1090.923635345534;1096.446294621211;1124.9493772780245;5249.448807875195;5345.786168553292;5948.702564871739;6069.878602427927;6081.209442772411;22687.88656056709;23399.53200935972;23424.64863027056;23505.412364690677;23591.410214744425;21832.345029649136;22560.435989100402;22713.886430568073;23113.07547698073;23430.7656923432;12437.440315185839;12641.2415255085;12649.430775614936;12681.556145534862;12720.93639531815;9524.476153811607;9741.220702343937;9762.658306959222;9775.657851975147;10199.28604997643;20164.193432262546;20312.187512499924;20318.695219571422;20998.160073596886;21347.25284615031;20580.382588522367;20605.484862878548;20761.792382075986;20887.16451341929;20937;15008.924955375152;15105.697886041999;15307.846921530641;15334.386624534895;15343.156126413154;15270.541883743506;15391.461298854487;15394.769078464056;15421.151836649093;15515.534533963999;10996.615118470816;11751.236169648946;11768.176227663982;11871.347075910908;12027;12149.514019439124;12201.08491863096;12225.938870305592;12320.260784352968;12337.136400451882;11132.666020019413;11190.160737944523;11260.549578016788;11270.436478176221;11276.32342059479;7955.443118981616;7963;8037.8392432152195;8282.71010514629;8295.377846661404;8460.57697115154;8520.914790852012;8564.74305770828;8568.828623427371;8574.3997920145 18:49:32 INFO - PID 5849 | |4;prototype.html;488.2580849213251;504.63918298416627;508.1894378466346;513.394194850077;537.8655336165958;6147.692615369236;6258.84352891178;6282.277538083122;6284.5600807943465;6319.905201421977;6029.1257767623665;6107.175531303273;6145.6927153642255;6177.505799536038;6193.225846769154;4753.599432286707;4790.904181916359;4797.7121372717575;4799.200299887542;4800.543948324904;4697.859064228079;4775.976120119394;4786.712797232177;4794.352762377087;4831.710097394168;4756.35789168463;4781.976090119544;4783.13903497372;4785.9521404785855;4815.422149342084;4777.761111944389;4805.375301210837;4830.0339932013385;4835.806567737304;4836.588889944359;4336.3712261722185;4337.089211265638;4350.694132109987;4366.497852746943;4372.141839718107;6082.543809214327;6138.693065346715;6174.228221472316;6178.69106544671;6188.504919606421;5780.7687692492245;5789.392113828029;5793.420657934215;5811.041178205591;5818.301803783531;6429.871402571969;6569.540132190748;6591.571547849422;6636.535442519025;6706.329367063304;4906.828261010847;4924.655274130812;4927.630427717935;4948.901021979576;4978.377702787152;6918.411934985532;6954.23503414624;6965.6316852269965;6975.267596902354;7015.263397343308;4926.359573255454;4974.303597496353;4986.700797952134;4998.475160108136;5020.297158397827;5035.194368901031;5048.823291184791;5077.492250774893;5081.796728130834;5082.771275292621;5492.615516913857;5648.237487939158;5685.317761868602;5687.203791469197;5716.513316707163;6489.448396886223;6524.608523488606;6585.341465853377;6592.747377998165;6612.008198770223;1684.9494515164565;1713.4260022892222;1740.408261191201;1755.6576467588952;1771.5659663382296;1203.3441774233063;1212.175720510044;1223.247702662856;1233.543588872123;1234.3396282988558;6227.750889964442;6256.968715156395;6328.6519241442165;6356.491480681534;6368.426841584187;6607;6688.030235615808;6693.698783554654;6702.530822842355;6714.563553369016;6314.936850631435;6362.363763623601;6363.9045414318825;6395.52033597482;6404.935950640434;3572.374834404021;3592.7305452091196;3599.892003239907;3603.85584576614;3608.8376023079027;6989.161300643956;7024.894626580605;7057.329553692391;7115.2528984455885;7154.320339567733;6863.759768408082;6892.483063770237;6906;7022.262662420474;7022.964885175541;7024.402925751267;7045.436365090678;7073.82315442118;7121.9643901780155;7153.92846071543;6720.294369091175;6781.355771201728;6815.250322464426;6837.418819400406;6858.588484690935;6646.302138275605;6705.631190284386;6784.914413693786;6788.9660551696925;6806.55757375769;6966.407855332353;7025.630002149532;7053.576785392893;7109.786706398816;7187.2453392393045;5028.547430731252;5055.115354812967;5096.362954630671;5102.69383836971;5109.080365534091;6847.349501797321;6875.07186529812;6889.586624802528;6899.447204534355;6938.5143039986715;6669.533132680665;6700.899486507608;6701.984107151899;6714.261431242462;6734.259231484435;6467.967660161669;6494.415502604599;6621;6686.966565167143;6783.762568310085;6440;6572.277049524644;6635.767748128792;6664.833379165366;6693;6558.311377305315;6586.847301722275;6629.7348106075215;6630.176701407152;6630.801075967729;6428.325025872403;6436.742530298736;6499.0901273820755;6535.607863528204;6537.771178008747 18:49:32 INFO - PID 5849 | |5;yui.html;965.8358079126548;970.1947383671551;984.242133557161;999.9450030248343;1014.8426993815956;18311;18378.90810545947;18399.816001839976;18412.815871841278;18829.340973065944;18729.063546822672;18785.718214226763;22242.88878555605;22310.77689223107;22321.10715571379;1070.325694812267;1104.469854469855;1104.475374197258;1105.1545567640762;1105.3865104866795;1069.90370866622;1106.2919731371928;1114.30912834043;1118.485496671532;1119.5465836336257;1159.2928313728662;1172.1209093180114;1173.3487914207612;1173.6361727864346;1176.74699939513;1145.2212495503054;1156.9305841649527;1157.0338767129458;1157.7915975124474;1161.3322339654733;846.7883029242689;852.4629483425402;854.1885209051426;854.2781349759443;856.1395797223812;19506.609867802563;19652.41042768719;19654.80345196544;20308.390748277576;21147.577048458945;20613.39265628524;21111.577768444546;21507.247246346302;21618.783812161833;21780.782192178034;16624;17038.062906540134;17069.7439538407;17109.418261819643;17473.21370538329;3697.371446854041;3749.1189570450924;3750.774953502799;3769.6418840210135;3770.509833721626;133774;134376;135877;136008;138033;17030.403935862432;17188.656226875642;17222.311107555557;17290.04904730252;17395.826041739674;31811.20471988219;33314.66685333164;33344.83327583395;33362.833185833915;33446.16384590405;9249.815003700023;9367.344285900057;9416.62333506652;9664.371815831948;9731.221502279801;4625.838095666635;4675.976620116878;4684.718916864999;4686.835960741358;4741.431028276629;5732.598718089694;5837.066069428956;5853.414658534112;5867.794627188028;5901.114832775118;1178.2753606532092;1189.339916346436;1198.1972078707288;1198.4487135917402;1211.055376806075;746.5110352718978;752.9058867641545;770.3875419041875;779.4037561265636;781.6013832945125;12792.552260670831;13293.933530332286;13297.601071967856;13376.197428154343;13426.261555614536;743.7917383132732;760.4144808497426;762.8092976755811;768.4121646940096;773.6015951784835;5897.76408943646;5939.772999760184;6004.0693692477735;6155.84610384744;6176.413240742122;124633.37683311525;128774.35612822064;129366;129691.35154324168;132253.33873330572;113223.43388283171;115409.99999999833;115568;115752.42123789327;118609.40695296468;92149.07850921404;92159.53920230355;93020;93407.53296233612;95993.52003239939;11619.186656933933;11623.825642615537;11761.000314973324;11781.469833857325;11922.642320730392;48714.756426217646;48837.51162488329;49612;49737.75131124321;50656.493435065175;61937.690311548155;62079;62113.68943155436;63545.36454635394;63635.045474318846;16628;16636.417725379553;16741.49775506737;17014.659706806044;17090.145492725067;17563.1218439075;17742.467725968243;17879.28482860671;17926.641467170324;18020;17157.31370745156;17258.395956141474;17402.39091631787;17434.912825435793;17477.82522174762;16690.833091668926;16708.16459177012;16720.41478548245;16734.4142954996;16947;16601.833981660027;16712.913660612023;16756.664866702355;16898.493045208663;17035.148242587573;13391.263480508665;13545.86454135446;13564.79652805189;13632;13719.03706838599;13090.541831035867;13130.212187268795;13232.206067635972;13258.270795106362;13504.459821607026 18:49:32 INFO - PID 5849 | __end_tp_report 18:49:32 INFO - PID 5849 | __start_cc_report 18:49:32 INFO - PID 5849 | _x_x_mozilla_cycle_collect,322 18:49:32 INFO - PID 5849 | __end_cc_report 18:49:32 INFO - PID 5849 | __startTimestamp1503539372788__endTimestamp 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | ------- Summary: start ------- 18:49:32 INFO - PID 5849 | Number of tests: 6 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | [#0] dojo.html Cycles:165 Average:6405.86 Median:6751.00 stddev:809.71 (12.0%) stddev-sans-first:781.73 18:49:32 INFO - PID 5849 | Values: 3601.7 3631.5 3639.3 3643.3 3692.2 6366.7 6436.6 6469.5 6497.8 6504.4 6392.0 6405.4 6487.5 6495.8 6512.5 5516.4 5545.5 5549.5 5561.5 5664.9 5594.9 5620.8 5654.5 5663.9 5668.6 5614.5 5615.4 5649.6 5674.7 5693.3 5563.1 5601.7 5630.3 5637.3 5639.3 5530.8 5578.4 5614.9 5622.6 5648.2 6288.8 6301.7 6358.9 6397.7 6418.4 6875.1 6907.0 6914.3 6953.1 6971.0 7003.9 7031.8 7076.2 7090.4 7090.4 6461.2 6466.0 6510.5 6557.9 6569.8 7019.0 7097.8 7111.5 7124.0 7127.8 6762.4 6773.0 6781.0 6799.8 6852.9 6883.1 6937.7 6963.1 6984.3 7018.6 6819.5 6937.2 6944.4 6983.3 7008.6 6741.2 6854.5 6860.5 6934.0 7012.0 5116.8 5124.7 5126.4 5153.4 5161.0 4620.9 4628.5 4636.9 4653.9 4654.0 6655.9 6660.4 6661.6 6734.5 6740.3 6813.3 6920.9 6932.9 6942.8 7024.2 6551.6 6617.8 6618.0 6618.1 6633.0 5849.4 5858.4 5872.7 5917.9 5948.2 7103.7 7174.2 7181.5 7183.4 7193.2 6862.7 6868.5 6897.5 6930.1 6935.9 7128.6 7158.8 7249.0 7254.4 7278.9 6871.9 6910.4 6911.6 6950.9 6969.3 7087.7 7130.8 7132.5 7134.7 7158.2 6851.3 6865.6 6917.8 6932.0 6943.1 6673.1 6751.0 6769.6 6796.6 6811.0 6778.5 6794.1 6851.3 6854.5 6867.5 6770.1 6856.9 6922.9 6930.7 6946.2 6507.0 6630.1 6652.8 6731.7 6749.1 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | [#1] ext.html Cycles:180 Average:43821.18 Median:39429.10 stddev:63979.33 (162.3%) stddev-sans-first:64077.76 18:49:32 INFO - PID 5849 | Values: 930.2 953.7 969.5 998.0 998.1 44864.8 46001.1 46037.3 46083.0 46085.5 42333.4 42362.0 42440.8 42482.2 42532.6 7054.5 7177.3 7202.6 7206.8 7209.9 7319.5 7410.4 7416.4 7418.1 7420.6 7845.1 8091.5 8093.0 8095.0 8095.8 7961.2 7991.6 7994.3 7997.0 7999.9 7859.2 7897.6 7922.7 7930.8 7931.5 42013.2 42410.6 42616.6 42723.4 42761.8 3803.3 3838.3 3841.8 3842.0 3845.3 33512.2 33578.0 33597.3 33611.8 33627.7 5032.7 5188.7 5227.7 5235.1 5246.0 199603.0 200348.0 210171.0 210878.0 220628.0 53465.0 53518.5 53552.5 53621.0 53652.5 55127.0 55178.0 55184.4 55235.7 55320.7 18105.5 18147.8 18175.0 18215.5 18440.2 15203.2 15215.0 15227.2 15238.1 15308.7 15371.8 15407.8 15529.0 15532.5 15694.5 6049.3 6206.8 6229.6 6230.6 6311.2 1097.4 1111.2 1112.1 1114.5 1116.2 25436.7 25507.4 25521.0 25710.2 25763.7 1207.5 1216.9 1231.1 1233.4 1259.2 13173.7 13179.2 13309.8 13346.1 13417.2 277063.0 277213.0 278174.0 278585.0 278969.0 56101.7 56489.7 56714.0 56782.0 56785.0 1585.5 1601.3 1616.5 1617.1 1631.2 24778.3 30304.0 30609.5 30861.7 30999.0 59564.4 61065.4 61801.4 61916.0 62290.4 245431.0 247190.0 247356.0 247547.0 247742.0 33520.0 37534.4 38743.2 40754.0 40789.8 50361.5 51233.2 51377.2 51429.5 51446.7 36773.4 36886.8 36982.4 37097.4 37683.6 38760.4 39253.8 39318.0 39540.2 39560.0 43476.0 44306.3 45197.0 45228.1 45507.5 38067.8 38118.6 38217.8 38266.0 39170.4 27890.9 28090.6 28314.4 28480.3 28495.9 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | [#2] jquery.html Cycles:180 Average:42266.27 Median:12529.38 stddev:110626.93 (882.9%) stddev-sans-first:110893.04 18:49:32 INFO - PID 5849 | Values: 604.1 608.7 612.2 624.7 627.4 24568.5 24928.9 25359.1 25367.6 25467.0 26498.0 27810.4 27922.0 27943.0 27950.6 6377.1 6543.6 6557.0 6557.6 6560.1 6112.6 6315.7 6405.1 6410.1 6417.1 6337.6 6342.9 6346.1 6347.5 6363.7 6286.3 6294.5 6343.5 6347.7 6354.7 5920.2 5940.2 5955.2 5962.3 5970.6 29541.0 30073.0 30765.5 30970.5 31103.4 2348.6 2384.2 2392.6 2393.1 2393.2 20057.3 20401.4 20501.1 20501.4 20616.8 2383.2 2457.1 2484.5 2487.4 2490.0 140203.0 146309.0 153720.0 156212.0 161186.0 15862.1 16562.3 16582.8 16594.8 16678.3 24860.6 24922.4 24923.5 24943.9 24994.9 10998.8 11255.2 11354.7 11420.6 11558.2 10372.4 10451.1 10503.3 10618.8 10660.1 9581.4 9851.3 9947.8 9984.1 10089.3 2808.4 2809.6 2831.2 2877.4 2946.4 1049.2 1057.1 1071.7 1071.9 1081.5 20864.4 21206.9 21273.4 21619.2 21763.7 1145.2 1145.4 1151.5 1156.3 1157.6 11582.7 11858.5 11894.6 11916.2 12082.0 624512.0 639699.0 677246.0 683909.0 686250.0 128875.0 134068.3 142350.0 149569.0 149805.3 1329.7 1356.3 1374.2 1386.6 1392.2 22390.4 22439.2 22455.0 22632.4 22710.2 66772.0 67143.3 67368.0 68205.7 69043.7 85483.6 86292.3 87104.0 87504.0 89321.6 15440.2 16061.4 16087.1 16096.6 16123.3 24733.8 24800.1 24848.8 24989.5 25147.4 20254.0 20330.5 20355.9 20506.2 20573.3 17642.6 17943.8 18171.6 18182.8 18653.5 20547.4 20615.0 20617.7 20800.0 20819.3 15609.0 15710.7 15712.8 15800.8 15847.6 20068.6 20185.0 20217.0 20397.7 20418.4 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | [#3] mootools.html Cycles:180 Average:10336.04 Median:23548.41 stddev:7213.33 (30.6%) stddev-sans-first:7202.71 18:49:32 INFO - PID 5849 | Values: 1456.0 1510.9 1511.6 1529.3 1533.0 15933.8 16523.1 16526.8 16533.8 16596.4 16054.9 17117.2 17130.8 17149.7 17186.6 2997.5 3011.2 3064.1 3071.3 3072.3 2898.3 2980.9 2985.9 2994.7 2996.7 3020.8 3028.5 3030.3 3052.6 3054.7 2909.1 2933.3 2941.0 2943.2 2962.0 2888.2 2899.6 2923.7 2928.3 2951.5 16200.6 16454.7 16480.8 16506.8 16523.4 8759.1 9061.0 9115.3 9117.3 9120.1 5757.8 5791.5 5847.5 5868.9 5875.4 1915.9 1922.0 1941.9 1966.3 1970.8 27792.0 27840.3 28029.9 28066.0 28078.3 7077.3 7159.9 7289.9 7465.9 7473.3 19348.1 19351.0 19381.8 19433.1 19442.7 8675.0 8835.0 8835.4 8838.8 8842.8 8032.6 8064.3 8153.8 8168.5 8180.8 5454.8 6156.2 6161.3 6189.2 6245.8 1578.6 1706.3 1732.5 1750.3 1764.1 967.0 975.2 976.3 991.3 1004.4 9397.7 9640.4 9675.9 9810.4 9869.5 1067.5 1077.4 1090.9 1096.4 1124.9 5249.4 5345.8 5948.7 6069.9 6081.2 22687.9 23399.5 23424.6 23505.4 23591.4 21832.3 22560.4 22713.9 23113.1 23430.8 12437.4 12641.2 12649.4 12681.6 12720.9 9524.5 9741.2 9762.7 9775.7 10199.3 20164.2 20312.2 20318.7 20998.2 21347.3 20580.4 20605.5 20761.8 20887.2 20937.0 15008.9 15105.7 15307.8 15334.4 15343.2 15270.5 15391.5 15394.8 15421.2 15515.5 10996.6 11751.2 11768.2 11871.3 12027.0 12149.5 12201.1 12225.9 12320.3 12337.1 11132.7 11190.2 11260.5 11270.4 11276.3 7955.4 7963.0 8037.8 8282.7 8295.4 8460.6 8520.9 8564.7 8568.8 8574.4 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | [#4] prototype.html Cycles:180 Average:5603.10 Median:6299.75 stddev:1625.15 (25.8%) stddev-sans-first:1583.72 18:49:32 INFO - PID 5849 | Values: 488.3 504.6 508.2 513.4 537.9 6147.7 6258.8 6282.3 6284.6 6319.9 6029.1 6107.2 6145.7 6177.5 6193.2 4753.6 4790.9 4797.7 4799.2 4800.5 4697.9 4776.0 4786.7 4794.4 4831.7 4756.4 4782.0 4783.1 4786.0 4815.4 4777.8 4805.4 4830.0 4835.8 4836.6 4336.4 4337.1 4350.7 4366.5 4372.1 6082.5 6138.7 6174.2 6178.7 6188.5 5780.8 5789.4 5793.4 5811.0 5818.3 6429.9 6569.5 6591.6 6636.5 6706.3 4906.8 4924.7 4927.6 4948.9 4978.4 6918.4 6954.2 6965.6 6975.3 7015.3 4926.4 4974.3 4986.7 4998.5 5020.3 5035.2 5048.8 5077.5 5081.8 5082.8 5492.6 5648.2 5685.3 5687.2 5716.5 6489.4 6524.6 6585.3 6592.7 6612.0 1684.9 1713.4 1740.4 1755.7 1771.6 1203.3 1212.2 1223.2 1233.5 1234.3 6227.8 6257.0 6328.7 6356.5 6368.4 6607.0 6688.0 6693.7 6702.5 6714.6 6314.9 6362.4 6363.9 6395.5 6404.9 3572.4 3592.7 3599.9 3603.9 3608.8 6989.2 7024.9 7057.3 7115.3 7154.3 6863.8 6892.5 6906.0 7022.3 7023.0 7024.4 7045.4 7073.8 7122.0 7153.9 6720.3 6781.4 6815.3 6837.4 6858.6 6646.3 6705.6 6784.9 6789.0 6806.6 6966.4 7025.6 7053.6 7109.8 7187.2 5028.5 5055.1 5096.4 5102.7 5109.1 6847.3 6875.1 6889.6 6899.4 6938.5 6669.5 6700.9 6702.0 6714.3 6734.3 6468.0 6494.4 6621.0 6687.0 6783.8 6440.0 6572.3 6635.8 6664.8 6693.0 6558.3 6586.8 6629.7 6630.2 6630.8 6428.3 6436.7 6499.1 6535.6 6537.8 18:49:32 INFO - PID 5849 | 18:49:32 INFO - PID 5849 | [#5] yui.html Cycles:180 Average:25280.27 Median:17520.47 stddev:35910.89 (205.0%) stddev-sans-first:35965.22 18:49:32 INFO - PID 5849 | Values: 965.8 970.2 984.2 999.9 1014.8 18311.0 18378.9 18399.8 18412.8 18829.3 18729.1 18785.7 22242.9 22310.8 22321.1 1070.3 1104.5 1104.5 1105.2 1105.4 1069.9 1106.3 1114.3 1118.5 1119.5 1159.3 1172.1 1173.3 1173.6 1176.7 1145.2 1156.9 1157.0 1157.8 1161.3 846.8 852.5 854.2 854.3 856.1 19506.6 19652.4 19654.8 20308.4 21147.6 20613.4 21111.6 21507.2 21618.8 21780.8 16624.0 17038.1 17069.7 17109.4 17473.2 3697.4 3749.1 3750.8 3769.6 3770.5 133774.0 134376.0 135877.0 136008.0 138033.0 17030.4 17188.7 17222.3 17290.0 17395.8 31811.2 33314.7 33344.8 33362.8 33446.2 9249.8 9367.3 9416.6 9664.4 9731.2 4625.8 4676.0 4684.7 4686.8 4741.4 5732.6 5837.1 5853.4 5867.8 5901.1 1178.3 1189.3 1198.2 1198.4 1211.1 746.5 752.9 770.4 779.4 781.6 12792.6 13293.9 13297.6 13376.2 13426.3 743.8 760.4 762.8 768.4 773.6 5897.8 5939.8 6004.1 6155.8 6176.4 124633.4 128774.4 129366.0 129691.4 132253.3 113223.4 115410.0 115568.0 115752.4 118609.4 92149.1 92159.5 93020.0 93407.5 95993.5 11619.2 11623.8 11761.0 11781.5 11922.6 48714.8 48837.5 49612.0 49737.8 50656.5 61937.7 62079.0 62113.7 63545.4 63635.0 16628.0 16636.4 16741.5 17014.7 17090.1 17563.1 17742.5 17879.3 17926.6 18020.0 17157.3 17258.4 17402.4 17434.9 17477.8 16690.8 16708.2 16720.4 16734.4 16947.0 16601.8 16712.9 16756.7 16898.5 17035.1 13391.3 13545.9 13564.8 13632.0 13719.0 13090.5 13130.2 13232.2 13258.3 13504.5 18:49:32 INFO - PID 5849 | -------- Summary: end -------- 18:49:32 INFO - PID 5849 | 18:49:33 INFO - TEST-INFO | 5849: exit 0 18:49:33 INFO - TEST-OK | dromaeo_css | took 1108339ms 18:49:33 INFO - TEST-START | kraken 18:49:33 INFO - Initialising browser for kraken test... 18:49:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57804/getInfo.html -profile /tmp/tmpUuE1x_/profile 18:49:33 INFO - TEST-INFO | started process 6205 (/builds/slave/test/build/application/firefox/firefox http://localhost:57804/getInfo.html) 18:49:38 INFO - TEST-INFO | 6205: exit 0 18:49:38 INFO - Browser initialized. 18:49:38 INFO - Running cycle 1/1 for kraken test... 18:49:38 INFO - TEST-INFO | started process 6371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUuE1x_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:38 INFO - PID 6371 | 1503539378875 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:4395 < 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 18:49:49 INFO - PID 6371 | RSS: Main: 150749184 18:49:49 INFO - PID 6371 | 18:49:52 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57804/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:53 INFO - PID 6371 | RSS: Main: 157306880 18:49:53 INFO - PID 6371 | 18:49:55 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57804/tests/kraken/driver.html?testName=audio-dft) 18:49:56 INFO - PID 6371 | RSS: Main: 157974528 18:49:56 INFO - PID 6371 | 18:49:59 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57804/tests/kraken/driver.html?testName=audio-fft) 18:49:59 INFO - PID 6371 | RSS: Main: 158580736 18:49:59 INFO - PID 6371 | 18:50:01 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57804/tests/kraken/driver.html?testName=audio-oscillator) 18:50:02 INFO - PID 6371 | RSS: Main: 158322688 18:50:02 INFO - PID 6371 | 18:50:04 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57804/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:50:05 INFO - PID 6371 | RSS: Main: 157831168 18:50:05 INFO - PID 6371 | 18:50:08 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57804/tests/kraken/driver.html?testName=imaging-darkroom) 18:50:08 INFO - PID 6371 | RSS: Main: 158052352 18:50:08 INFO - PID 6371 | 18:50:12 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57804/tests/kraken/driver.html?testName=imaging-desaturate) 18:50:12 INFO - PID 6371 | RSS: Main: 160620544 18:50:12 INFO - PID 6371 | 18:50:15 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57804/tests/kraken/driver.html?testName=json-parse-financial) 18:50:16 INFO - PID 6371 | RSS: Main: 161386496 18:50:16 INFO - PID 6371 | 18:50:17 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57804/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:50:18 INFO - PID 6371 | RSS: Main: 161353728 18:50:18 INFO - PID 6371 | 18:50:19 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:50:20 INFO - PID 6371 | RSS: Main: 161030144 18:50:20 INFO - PID 6371 | 18:50:22 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:50:23 INFO - PID 6371 | RSS: Main: 161116160 18:50:23 INFO - PID 6371 | 18:50:25 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:50:26 INFO - PID 6371 | RSS: Main: 161366016 18:50:26 INFO - PID 6371 | 18:50:29 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:50:29 INFO - PID 6371 | RSS: Main: 161521664 18:50:29 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | Cycle 1(1): loaded http://localhost:57804/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57804/tests/kraken/driver.html?testName=ai-astar) 18:50:31 INFO - PID 6371 | RSS: Main: 163262464 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | __start_tp_report 18:50:31 INFO - PID 6371 | _x_x_mozilla_page_load 18:50:31 INFO - PID 6371 | _x_x_mozilla_page_load_details 18:50:31 INFO - PID 6371 | |i|pagename|runs| 18:50:31 INFO - PID 6371 | |0;ai-astar;101;106;92;104;104;107;107;107;105;107 18:50:31 INFO - PID 6371 | |1;audio-beat-detection;136;111;150;177;112;136;139;111;160;114 18:50:31 INFO - PID 6371 | |2;audio-dft;162;162;163;162;161;162;160;161;163;161 18:50:31 INFO - PID 6371 | |3;audio-fft;76;75;76;182;74;75;75;75;174;74 18:50:31 INFO - PID 6371 | |4;audio-oscillator;78;77;135;77;78;77;127;78;77;125 18:50:31 INFO - PID 6371 | |5;imaging-gaussian-blur;114;114;114;115;114;114;114;115;114;113 18:50:31 INFO - PID 6371 | |6;imaging-darkroom;148;147;147;146;147;147;147;148;148;147 18:50:31 INFO - PID 6371 | |7;imaging-desaturate;95;95;99;94;94;94;94;93;94;94 18:50:31 INFO - PID 6371 | |8;json-parse-financial;46;47;46;46;49;46;55;53;45;50 18:50:31 INFO - PID 6371 | |9;json-stringify-tinderbox;52;53;53;52;52;53;53;53;52;53 18:50:31 INFO - PID 6371 | |10;stanford-crypto-aes;73;73;73;72;72;73;72;74;73;71 18:50:31 INFO - PID 6371 | |11;stanford-crypto-ccm;123;118;120;115;111;121;116;117;114;150 18:50:31 INFO - PID 6371 | |12;stanford-crypto-pbkdf2;157;161;161;158;171;161;156;162;155;156 18:50:31 INFO - PID 6371 | |13;stanford-crypto-sha256-iterative;65;62;68;60;58;64;59;61;58;58 18:50:31 INFO - PID 6371 | __end_tp_report 18:50:31 INFO - PID 6371 | __start_cc_report 18:50:31 INFO - PID 6371 | _x_x_mozilla_cycle_collect,811 18:50:31 INFO - PID 6371 | __end_cc_report 18:50:31 INFO - PID 6371 | __startTimestamp1503539431681__endTimestamp 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | ------- Summary: start ------- 18:50:31 INFO - PID 6371 | Number of tests: 14 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#0] ai-astar Cycles:10 Average:104.00 Median:107.00 stddev:4.64 (4.3%) stddev-sans-first:4.80 18:50:31 INFO - PID 6371 | Values: 101.0 106.0 92.0 104.0 104.0 107.0 107.0 107.0 105.0 107.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:137.50 stddev:22.98 (16.7%) stddev-sans-first:24.37 18:50:31 INFO - PID 6371 | Values: 136.0 111.0 150.0 177.0 112.0 136.0 139.0 111.0 160.0 114.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 18:50:31 INFO - PID 6371 | Values: 162.0 162.0 163.0 162.0 161.0 162.0 160.0 161.0 163.0 161.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.00 stddev:43.47 (58.0%) stddev-sans-first:45.53 18:50:31 INFO - PID 6371 | Values: 76.0 75.0 76.0 182.0 74.0 75.0 75.0 75.0 174.0 74.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:77.00 stddev:25.04 (32.5%) stddev-sans-first:25.97 18:50:31 INFO - PID 6371 | Values: 78.0 77.0 135.0 77.0 78.0 77.0 127.0 78.0 77.0 125.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:50:31 INFO - PID 6371 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 113.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 18:50:31 INFO - PID 6371 | Values: 148.0 147.0 147.0 146.0 147.0 147.0 147.0 148.0 148.0 147.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 18:50:31 INFO - PID 6371 | Values: 95.0 95.0 99.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#8] json-parse-financial Cycles:10 Average:48.30 Median:48.00 stddev:3.40 (7.1%) stddev-sans-first:3.50 18:50:31 INFO - PID 6371 | Values: 46.0 47.0 46.0 46.0 49.0 46.0 55.0 53.0 45.0 50.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#9] json-stringify-tinderbox Cycles:10 Average:52.60 Median:53.00 stddev:0.52 (1.0%) stddev-sans-first:0.50 18:50:31 INFO - PID 6371 | Values: 52.0 53.0 53.0 52.0 52.0 53.0 53.0 53.0 52.0 53.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:73.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 18:50:31 INFO - PID 6371 | Values: 73.0 73.0 73.0 72.0 72.0 73.0 72.0 74.0 73.0 71.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:119.00 stddev:10.95 (9.2%) stddev-sans-first:11.57 18:50:31 INFO - PID 6371 | Values: 123.0 118.0 120.0 115.0 111.0 121.0 116.0 117.0 114.0 150.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:161.00 stddev:4.69 (2.9%) stddev-sans-first:4.86 18:50:31 INFO - PID 6371 | Values: 157.0 161.0 161.0 158.0 171.0 161.0 156.0 162.0 155.0 156.0 18:50:31 INFO - PID 6371 | 18:50:31 INFO - PID 6371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:3.43 (5.6%) stddev-sans-first:3.37 18:50:31 INFO - PID 6371 | Values: 65.0 62.0 68.0 60.0 58.0 64.0 59.0 61.0 58.0 58.0 18:50:31 INFO - PID 6371 | -------- Summary: end -------- 18:50:31 INFO - PID 6371 | 18:50:32 INFO - PID 6371 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:50:32 INFO - TEST-INFO | 6371: exit 0 18:50:32 INFO - TEST-OK | kraken | took 59057ms 18:50:32 INFO - SUITE-END | took 1167s 18:50:32 INFO - Completed test suite (00:19:27) 18:50:32 INFO - javascript benchmark 18:50:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9138.370468451723, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3601.657842504963, 3631.4915911772373, 3639.3267245559573, 3643.3077715234112, 3692.243090166516, 6366.745330186787, 6436.645984470852, 6469.547131700783, 6497.772577959772, 6504.44712199463, 6392.0, 6405.42351188393, 6487.545871788977, 6495.837604059889, 6512.544121911468, 5516.365617953927, 5545.500904918556, 5549.528290095326, 5561.499465048145, 5664.943350566504, 5594.860128496779, 5620.831375058755, 5654.46282603152, 5663.943360566383, 5668.603197776158, 5614.466625670555, 5615.382307946143, 5649.576281778883, 5674.744636491348, 5693.316801983747, 5563.109902415594, 5601.747921343549, 5630.296212973379, 5637.267155269829, 5639.3232812062815, 5530.751116199781, 5578.3584887738025, 5614.9157762633595, 5622.606417550773, 5648.181013752983, 6288.842778930518, 6301.716422760941, 6358.936410635927, 6397.744090236385, 6418.390252926011, 6875.140607424072, 6906.965465172692, 6914.308569143096, 6953.096097507342, 6970.989206565019, 7003.929960700379, 7031.82420439488, 7076.150861896605, 7090.361867431904, 7090.397316228127, 6461.224653041618, 6466.0, 6510.479161667055, 6557.93442065578, 6569.802905912782, 7019.0, 7097.787066388017, 7111.502194846311, 7124.0, 7127.82180445493, 6762.425193858478, 6772.966135169293, 6781.0, 6799.762008329685, 6852.862942741117, 6883.105196324546, 6937.7224911004005, 6963.059986901805, 6984.266652001568, 7018.613976231254, 6819.488538359643, 6937.202221744564, 6944.409725173316, 6983.301669832976, 7008.579485230903, 6741.1910570731825, 6854.485913556503, 6860.5197636164985, 6934.029235906977, 7011.964940175369, 5116.846494605168, 5124.666896651705, 5126.384833819965, 5153.3558305211845, 5161.0, 4620.861374158781, 4628.490866004737, 4636.884077898079, 4653.930191047137, 4653.95346046542, 6655.900161497581, 6660.367265109807, 6661.600303981777, 6734.528582999241, 6740.258571557125, 6813.318668133147, 6920.9307906920285, 6932.861342773217, 6942.791716248521, 7024.1571011478945, 6551.6069035858, 6617.7683781067435, 6617.966910165418, 6618.139641846529, 6633.0, 5849.385814489502, 5858.384869588632, 5872.677002764804, 5917.940820591739, 5948.196993405922, 7103.715851365991, 7174.246704095995, 7181.461390395742, 7183.353498185188, 7193.172785129777, 6862.725490980305, 6868.484863635347, 6897.48268879836, 6930.13373328334, 6935.895961560682, 7128.572285662877, 7158.785236442915, 7249.0, 7254.419646428168, 7278.927210728037, 6871.931280687129, 6910.44716422695, 6911.619860907497, 6950.930490695028, 6969.337912898267, 7087.681054352463, 7130.750423735144, 7132.500724949411, 7134.714611415485, 7158.248383919822, 6851.314868513109, 6865.622390768555, 6917.757878474229, 6931.965340173267, 6943.097397338515, 6673.132492775908, 6751.0, 6769.559978601375, 6796.592204467748, 6810.965945170243, 6778.4577233822165, 6794.116764820542, 6851.3491218334175, 6854.485913556603, 6867.450603951572, 6770.052192693125, 6856.897146542706, 6922.896156557555, 6930.653467326512, 6946.16646002483, 6506.967465162644, 6630.104935833793, 6652.800415987528, 6731.697073631796, 6749.055132281386], "value": 6345.413945523499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.2418528898943, 953.6995846308413, 969.5394687523426, 998.0119681515303, 998.1316254858274, 44864.775676121615, 46001.07997840041, 46037.30944035834, 46083.0, 46085.53914460854, 42333.36499952503, 42362.0, 42440.78779606106, 42482.15035699284, 42532.57467425325, 7054.5061845670825, 7177.318154775288, 7202.639868006605, 7206.819829504252, 7209.927900721004, 7319.487635865492, 7410.40716742662, 7416.369608583277, 7418.109826820789, 7420.628968551551, 7845.137034926153, 8091.4740541864885, 8093.0, 8095.0, 8095.757127286161, 7961.243681850215, 7991.560464174497, 7994.280514753642, 7997.040355157389, 7999.880001799977, 7859.214078592152, 7897.5656338901335, 7922.683092676286, 7930.801729956797, 7931.484453510503, 42013.1597368054, 42410.57589424128, 42616.57383426188, 42723.35914961278, 42761.786191068844, 3803.315403227418, 3838.3282925488206, 3841.8463261469788, 3842.0, 3845.3462911304864, 33512.16219594505, 33578.0, 33597.328053439036, 33611.831940840384, 33627.6637233627, 5032.723200223986, 5188.688678679254, 5227.686338819683, 5235.110031294689, 5246.0, 199603.0, 200348.0, 210171.0, 210878.0, 220628.0, 53465.0, 53518.46481535213, 53552.464475355526, 53621.0, 53652.46347536553, 55127.0, 55178.0, 55184.44815551873, 55235.723821380634, 55320.72339638276, 18105.456836294932, 18147.818521814876, 18175.0, 18215.544611384823, 18440.17019234138, 15203.163825989455, 15215.0, 15227.162506062274, 15238.085714857145, 15308.693826123637, 15371.846281537266, 15407.845921540866, 15529.0, 15532.534023979299, 15694.529164125095, 6049.304330002018, 6206.813795586139, 6229.563930524911, 6230.563860529719, 6311.211098612674, 1097.4183682648209, 1111.2499063132516, 1112.0825319111766, 1114.5207560748793, 1116.2353787655481, 25436.745632543807, 25507.36231594188, 25521.0, 25710.228693139237, 25763.742362576508, 1207.5350989868964, 1216.9330686812134, 1231.1012960538858, 1233.3956361382857, 1259.200407741091, 13173.736525269633, 13179.209247445184, 13309.800352994713, 13346.06577539563, 13417.194968301934, 277063.0, 277213.0, 278174.0, 278585.0, 278969.0, 56101.719491402284, 56489.71755141198, 56714.0, 56782.0, 56785.0, 1585.5084923673467, 1601.3417726573832, 1616.5473667373155, 1617.0782653887406, 1631.208863701104, 24778.25665230046, 30304.0, 30609.54085688672, 30861.691383085883, 30999.0, 59564.404355955885, 61065.38934610597, 61801.381986179564, 61916.0, 62290.377096228454, 245431.0, 247190.0, 247356.0, 247547.0, 247742.0, 33520.0, 37534.43698344472, 38743.2251354977, 40754.0, 40789.796051019555, 50361.49638503715, 51233.23150152825, 51377.229341559156, 51429.48570514247, 51446.742766285926, 36773.44839827351, 36886.815565922, 36982.44526332054, 37097.443538347485, 37683.62316376911, 38760.418593720555, 39253.80373098116, 39318.0, 39540.20919581535, 39560.0, 43476.0, 44306.3354049696, 45197.0, 45228.09543809171, 45507.54492455033, 38067.80966095152, 38118.61881381151, 38217.80891095527, 38266.04334891539, 39170.4124438128, 27890.86054569714, 28090.57864131999, 28314.43371132607, 28480.287992800346, 28495.870743266412], "value": 19248.97333377005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.1360853978808, 608.6986941463977, 612.1674522649198, 624.6689254695013, 627.3788948940548, 24568.508629827393, 24928.87535562324, 25359.112431064917, 25367.619485707706, 25467.0, 26498.0, 27810.443791124166, 27922.0, 27943.0, 27950.580741288897, 6377.075324078018, 6543.640099794509, 6556.967215163918, 6557.606543607375, 6560.114384558071, 6112.633242005471, 6315.684215789215, 6405.071264666621, 6410.07053977173, 6417.101605775195, 6337.619742815423, 6342.904856427134, 6346.11154438379, 6347.492200623939, 6363.7454501819875, 6286.3399343069, 6294.464970477515, 6343.46080583151, 6347.650879201642, 6354.650494222816, 5920.200772895647, 5940.168376427304, 5955.196048533436, 5962.25471816023, 5970.55220858433, 29541.0, 30073.0, 30765.538516922265, 30970.53544196839, 31103.37793244145, 2348.553774782803, 2384.225126833786, 2392.557376885282, 2393.054743376357, 2393.246127469859, 20057.297994570265, 20401.387958361272, 20501.077451514717, 20501.38495845127, 20616.793832061638, 2383.212590557082, 2457.127719659513, 2484.4534202475425, 2487.353288145095, 2489.987550062238, 140203.0, 146309.0, 153720.0, 156212.0, 161186.0, 15862.096548414034, 16562.254698538596, 16582.834171658127, 16594.75107873359, 16678.33286668544, 24860.627090593654, 24922.37694057627, 24923.50152996966, 24943.87528062348, 24994.87502562512, 10998.835017474585, 11255.212135150461, 11354.716132096764, 11420.600278990196, 11558.248713833575, 10372.377657340583, 10451.111655509214, 10503.264771466076, 10618.787624247472, 10660.147188224923, 9581.425114493153, 9851.310408271353, 9947.80104397908, 9984.101430871257, 10089.293749437616, 2808.4383123375405, 2809.620701205352, 2831.235566397061, 2877.3813630069217, 2946.4401763664837, 1049.197364016528, 1057.0961827637414, 1071.6945670483874, 1071.9088877445504, 1081.453865797767, 20864.37406877796, 21206.893965530384, 21273.36179914605, 21619.162371198625, 21763.67354489684, 1145.1999860341552, 1145.352875625269, 1151.4645689754136, 1156.2888823373564, 1157.571698471571, 11582.71043223926, 11858.466369013415, 11894.643160705193, 11916.165868389304, 12082.0, 624512.0, 639699.0, 677246.0, 683909.0, 686250.0, 128875.0, 134068.32965835108, 142350.0, 149569.0, 149805.25097374662, 1329.6609364611961, 1356.2540602668494, 1374.223563686494, 1386.6256110850013, 1392.1716578635696, 22390.440238994157, 22439.21462748796, 22455.0, 22632.434189145402, 22710.205142819923, 66771.99842002471, 67143.32856671371, 67367.98948015686, 68205.65897170482, 69043.65478172577, 85483.5725821367, 86292.2741545153, 87104.0, 87504.0, 89321.55339223263, 15440.227988600749, 16061.437849675205, 16087.115208663636, 16096.597585060466, 16123.274452649424, 24733.752662473144, 24800.131995380074, 24848.751512484643, 24989.500209996062, 25147.371315717253, 20254.0, 20330.491737706674, 20355.898220508803, 20506.17975280972, 20573.279935202198, 17642.5589360267, 17943.82056179474, 18171.636567268317, 18182.81817181811, 18653.533661658566, 20547.38357849267, 20615.0, 20617.69073463929, 20800.0, 20819.271325503534, 15609.0, 15710.685786284439, 15712.76430853561, 15800.76298855541, 15847.603809904844, 20068.598628027066, 20185.0, 20216.98915054212, 20397.69403458979, 20418.387448376572], "value": 13096.36645648135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.9708805823882, 1510.886683498738, 1511.5843143135644, 1529.2583097197858, 1532.97700534492, 15933.760993585105, 16523.091229982347, 16526.752098718513, 16533.834661653378, 16596.419125330616, 16054.919725401356, 17117.22972466239, 17130.82869171308, 17149.74275385867, 17186.57033574158, 2997.5054116070933, 3011.1719277198727, 3064.050144455226, 3071.2936024714218, 3072.308730535623, 2898.304406942329, 2980.8509574521295, 2985.910422687312, 2994.6705862355125, 2996.6703662597097, 3020.8187508749434, 3028.530577760451, 3030.348475077858, 3052.5879006334194, 3054.6639869614437, 2909.0836386538385, 2933.296008957856, 2941.0, 2943.205334559668, 2962.007727411309, 2888.234617826278, 2899.5795609636693, 2923.6637786654383, 2928.282570770175, 2951.4687356275863, 16200.594985125348, 16454.67090658192, 16480.83519164805, 16506.75239871403, 16523.421680241136, 8759.12408759119, 9061.048589898097, 9115.316351273616, 9117.31620128493, 9120.133587309196, 5757.769689212427, 5791.536677065825, 5847.532197424196, 5868.911966320508, 5875.38308477608, 1915.8850468971766, 1921.951951201217, 1941.8737782044122, 1966.3412756726514, 1970.7832138464757, 27792.02727904534, 27840.30399240015, 28029.85985070082, 28066.0, 28078.298042548897, 7077.327653872874, 7159.928400715926, 7289.890651640229, 7465.925340746523, 7473.327400533978, 19348.129334179997, 19351.0, 19381.806181938002, 19433.125509352114, 19442.70835937462, 8675.0, 8834.955825220834, 8835.381523293436, 8838.823223535494, 8842.778930526789, 8032.598370081472, 8064.274215320649, 8153.7553873383895, 8168.469049511763, 8180.836383272302, 5454.754536045887, 6156.199694039746, 6161.291451483047, 6189.226346706661, 6245.812625621239, 1578.5895667126629, 1706.2918888661316, 1732.4542769027717, 1750.2561411400359, 1764.109124891947, 966.9806603867884, 975.2007546077476, 976.345848281653, 991.3159919655415, 1004.4073996342194, 9397.718068457958, 9640.42157470554, 9675.90324096764, 9810.411375317504, 9869.506524673738, 1067.4982758103679, 1077.42357838556, 1090.923635345534, 1096.446294621211, 1124.9493772780245, 5249.448807875195, 5345.786168553292, 5948.702564871739, 6069.878602427927, 6081.209442772411, 22687.88656056709, 23399.53200935972, 23424.64863027056, 23505.412364690677, 23591.410214744425, 21832.345029649136, 22560.435989100402, 22713.886430568073, 23113.07547698073, 23430.7656923432, 12437.440315185839, 12641.2415255085, 12649.430775614936, 12681.556145534862, 12720.93639531815, 9524.476153811607, 9741.220702343937, 9762.658306959222, 9775.657851975147, 10199.28604997643, 20164.193432262546, 20312.187512499924, 20318.695219571422, 20998.160073596886, 21347.25284615031, 20580.382588522367, 20605.484862878548, 20761.792382075986, 20887.16451341929, 20937.0, 15008.924955375152, 15105.697886041999, 15307.846921530641, 15334.386624534895, 15343.156126413154, 15270.541883743506, 15391.461298854487, 15394.769078464056, 15421.151836649093, 15515.534533963999, 10996.615118470816, 11751.236169648946, 11768.176227663982, 11871.347075910908, 12027.0, 12149.514019439124, 12201.08491863096, 12225.938870305592, 12320.260784352968, 12337.136400451882, 11132.666020019413, 11190.160737944523, 11260.549578016788, 11270.436478176221, 11276.32342059479, 7955.443118981616, 7963.0, 8037.8392432152195, 8282.71010514629, 8295.377846661404, 8460.57697115154, 8520.914790852012, 8564.74305770828, 8568.828623427371, 8574.3997920145], "value": 7415.702890753892, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.2580849213251, 504.63918298416627, 508.1894378466346, 513.394194850077, 537.8655336165958, 6147.692615369236, 6258.84352891178, 6282.277538083122, 6284.5600807943465, 6319.905201421977, 6029.1257767623665, 6107.175531303273, 6145.6927153642255, 6177.505799536038, 6193.225846769154, 4753.599432286707, 4790.904181916359, 4797.7121372717575, 4799.200299887542, 4800.543948324904, 4697.859064228079, 4775.976120119394, 4786.712797232177, 4794.352762377087, 4831.710097394168, 4756.35789168463, 4781.976090119544, 4783.13903497372, 4785.9521404785855, 4815.422149342084, 4777.761111944389, 4805.375301210837, 4830.0339932013385, 4835.806567737304, 4836.588889944359, 4336.3712261722185, 4337.089211265638, 4350.694132109987, 4366.497852746943, 4372.141839718107, 6082.543809214327, 6138.693065346715, 6174.228221472316, 6178.69106544671, 6188.504919606421, 5780.7687692492245, 5789.392113828029, 5793.420657934215, 5811.041178205591, 5818.301803783531, 6429.871402571969, 6569.540132190748, 6591.571547849422, 6636.535442519025, 6706.329367063304, 4906.828261010847, 4924.655274130812, 4927.630427717935, 4948.901021979576, 4978.377702787152, 6918.411934985532, 6954.23503414624, 6965.6316852269965, 6975.267596902354, 7015.263397343308, 4926.359573255454, 4974.303597496353, 4986.700797952134, 4998.475160108136, 5020.297158397827, 5035.194368901031, 5048.823291184791, 5077.492250774893, 5081.796728130834, 5082.771275292621, 5492.615516913857, 5648.237487939158, 5685.317761868602, 5687.203791469197, 5716.513316707163, 6489.448396886223, 6524.608523488606, 6585.341465853377, 6592.747377998165, 6612.008198770223, 1684.9494515164565, 1713.4260022892222, 1740.408261191201, 1755.6576467588952, 1771.5659663382296, 1203.3441774233063, 1212.175720510044, 1223.247702662856, 1233.543588872123, 1234.3396282988558, 6227.750889964442, 6256.968715156395, 6328.6519241442165, 6356.491480681534, 6368.426841584187, 6607.0, 6688.030235615808, 6693.698783554654, 6702.530822842355, 6714.563553369016, 6314.936850631435, 6362.363763623601, 6363.9045414318825, 6395.52033597482, 6404.935950640434, 3572.374834404021, 3592.7305452091196, 3599.892003239907, 3603.85584576614, 3608.8376023079027, 6989.161300643956, 7024.894626580605, 7057.329553692391, 7115.2528984455885, 7154.320339567733, 6863.759768408082, 6892.483063770237, 6906.0, 7022.262662420474, 7022.964885175541, 7024.402925751267, 7045.436365090678, 7073.82315442118, 7121.9643901780155, 7153.92846071543, 6720.294369091175, 6781.355771201728, 6815.250322464426, 6837.418819400406, 6858.588484690935, 6646.302138275605, 6705.631190284386, 6784.914413693786, 6788.9660551696925, 6806.55757375769, 6966.407855332353, 7025.630002149532, 7053.576785392893, 7109.786706398816, 7187.2453392393045, 5028.547430731252, 5055.115354812967, 5096.362954630671, 5102.69383836971, 5109.080365534091, 6847.349501797321, 6875.07186529812, 6889.586624802528, 6899.447204534355, 6938.5143039986715, 6669.533132680665, 6700.899486507608, 6701.984107151899, 6714.261431242462, 6734.259231484435, 6467.967660161669, 6494.415502604599, 6621.0, 6686.966565167143, 6783.762568310085, 6440.0, 6572.277049524644, 6635.767748128792, 6664.833379165366, 6693.0, 6558.311377305315, 6586.847301722275, 6629.7348106075215, 6630.176701407152, 6630.801075967729, 6428.325025872403, 6436.742530298736, 6499.0901273820755, 6535.607863528204, 6537.771178008747], "value": 5120.831913422129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [965.8358079126548, 970.1947383671551, 984.242133557161, 999.9450030248343, 1014.8426993815956, 18311.0, 18378.90810545947, 18399.816001839976, 18412.815871841278, 18829.340973065944, 18729.063546822672, 18785.718214226763, 22242.88878555605, 22310.77689223107, 22321.10715571379, 1070.325694812267, 1104.469854469855, 1104.475374197258, 1105.1545567640762, 1105.3865104866795, 1069.90370866622, 1106.2919731371928, 1114.30912834043, 1118.485496671532, 1119.5465836336257, 1159.2928313728662, 1172.1209093180114, 1173.3487914207612, 1173.6361727864346, 1176.74699939513, 1145.2212495503054, 1156.9305841649527, 1157.0338767129458, 1157.7915975124474, 1161.3322339654733, 846.7883029242689, 852.4629483425402, 854.1885209051426, 854.2781349759443, 856.1395797223812, 19506.609867802563, 19652.41042768719, 19654.80345196544, 20308.390748277576, 21147.577048458945, 20613.39265628524, 21111.577768444546, 21507.247246346302, 21618.783812161833, 21780.782192178034, 16624.0, 17038.062906540134, 17069.7439538407, 17109.418261819643, 17473.21370538329, 3697.371446854041, 3749.1189570450924, 3750.774953502799, 3769.6418840210135, 3770.509833721626, 133774.0, 134376.0, 135877.0, 136008.0, 138033.0, 17030.403935862432, 17188.656226875642, 17222.311107555557, 17290.04904730252, 17395.826041739674, 31811.20471988219, 33314.66685333164, 33344.83327583395, 33362.833185833915, 33446.16384590405, 9249.815003700023, 9367.344285900057, 9416.62333506652, 9664.371815831948, 9731.221502279801, 4625.838095666635, 4675.976620116878, 4684.718916864999, 4686.835960741358, 4741.431028276629, 5732.598718089694, 5837.066069428956, 5853.414658534112, 5867.794627188028, 5901.114832775118, 1178.2753606532092, 1189.339916346436, 1198.1972078707288, 1198.4487135917402, 1211.055376806075, 746.5110352718978, 752.9058867641545, 770.3875419041875, 779.4037561265636, 781.6013832945125, 12792.552260670831, 13293.933530332286, 13297.601071967856, 13376.197428154343, 13426.261555614536, 743.7917383132732, 760.4144808497426, 762.8092976755811, 768.4121646940096, 773.6015951784835, 5897.76408943646, 5939.772999760184, 6004.0693692477735, 6155.84610384744, 6176.413240742122, 124633.37683311525, 128774.35612822064, 129366.0, 129691.35154324168, 132253.33873330572, 113223.43388283171, 115409.99999999833, 115568.0, 115752.42123789327, 118609.40695296468, 92149.07850921404, 92159.53920230355, 93020.0, 93407.53296233612, 95993.52003239939, 11619.186656933933, 11623.825642615537, 11761.000314973324, 11781.469833857325, 11922.642320730392, 48714.756426217646, 48837.51162488329, 49612.0, 49737.75131124321, 50656.493435065175, 61937.690311548155, 62079.0, 62113.68943155436, 63545.36454635394, 63635.045474318846, 16628.0, 16636.417725379553, 16741.49775506737, 17014.659706806044, 17090.145492725067, 17563.1218439075, 17742.467725968243, 17879.28482860671, 17926.641467170324, 18020.0, 17157.31370745156, 17258.395956141474, 17402.39091631787, 17434.912825435793, 17477.82522174762, 16690.833091668926, 16708.16459177012, 16720.41478548245, 16734.4142954996, 16947.0, 16601.833981660027, 16712.913660612023, 16756.664866702355, 16898.493045208663, 17035.148242587573, 13391.263480508665, 13545.86454135446, 13564.79652805189, 13632.0, 13719.03706838599, 13090.541831035867, 13130.212187268795, 13232.206067635972, 13258.270795106362, 13504.459821607026], "value": 9586.800341886934, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 92.0, 104.0, 104.0, 107.0, 107.0, 107.0, 105.0, 107.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 111.0, 150.0, 177.0, 112.0, 136.0, 139.0, 111.0, 160.0, 114.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 160.0, 161.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 182.0, 74.0, 75.0, 75.0, 75.0, 174.0, 74.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 135.0, 77.0, 78.0, 77.0, 127.0, 78.0, 77.0, 125.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 99.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 46.0, 46.0, 49.0, 46.0, 55.0, 53.0, 45.0, 50.0], "value": 48.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 72.0, 73.0, 72.0, 74.0, 73.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 118.0, 120.0, 115.0, 111.0, 121.0, 116.0, 117.0, 114.0, 150.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 161.0, 158.0, 171.0, 161.0, 156.0, 162.0, 155.0, 156.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 68.0, 60.0, 58.0, 64.0, 59.0, 61.0, 58.0, 58.0], "value": 61.3, "unit": "score"}]}]} 18:50:32 INFO - Return code: 0 18:50:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:50:32 INFO - # TBPL SUCCESS # 18:50:32 INFO - Running post-action listener: _package_coverage_data 18:50:32 INFO - Running post-action listener: _resource_record_post_action 18:50:32 INFO - [mozharness: 2017-08-24 01:50:32.950793Z] Finished run-tests step (success) 18:50:32 INFO - Running post-run listener: _resource_record_post_run 18:50:33 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 577536; Write bytes: 378310656; Read time: 60; Write time: 230688 18:50:33 INFO - TinderboxPrint: CPU usage
13.0% 18:50:33 INFO - TinderboxPrint: I/O read bytes / time
577,536 / 60 18:50:33 INFO - TinderboxPrint: I/O write bytes / time
378,310,656 / 230,688 18:50:33 INFO - TinderboxPrint: CPU idle
8,204.8 (87.0%) 18:50:33 INFO - TinderboxPrint: CPU user
1,181.3 (12.5%) 18:50:33 INFO - TinderboxPrint: Swap in / out
0 / 0 18:50:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 96301056; Read time: 0; Write time: 55636 18:50:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:50:33 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 573440; Write bytes: 268869632; Read time: 44; Write time: 172212 18:50:33 INFO - Running post-run listener: _upload_blobber_files 18:50:33 INFO - Blob upload gear active. 18:50:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:50:33 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 18:50:33 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'] 18:50:33 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 18:50:34 INFO - (blobuploader) - INFO - Open directory for files ... 18:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:34 INFO - (blobuploader) - INFO - Done attempting. 18:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:50:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:35 INFO - (blobuploader) - INFO - Done attempting. 18:50:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:50:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:50:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:36 INFO - (blobuploader) - INFO - Done attempting. 18:50:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:50:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:41 INFO - (blobuploader) - INFO - Done attempting. 18:50:41 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:41 INFO - Return code: 0 18:50:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6e2ee0d1d640e47ce8eca2b602c11395ca34c6e72983500f6a2a395be09ccd89faa894f9f885bdf2cf8fe9e8be8e9af04777e7826c50c84090b538b822da620", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/543fb7055e3f4f6633e35b40874bd09085a4e0e4bae1895e145ed89644d4085f58eefabe36c973555b292fe86b063290992377de916af4242b2785f886b4f398", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/56b4cfec562d7eec512f9deb02fcb38ac23fae39b6d610f1d2bac865fe84261ae850e4f2c5d43e70ed55fb924accb823394a7da0bfe317f0d0188a337acf456f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3361fc2993bc2307c11163cc2dba1b4f79869f2cbc17efa290cc06a5a6fce7844dee6d1afaea63195d1937d61cc6c1896b5def1e94b0100bac286c0385a6bc2d"} 18:50:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:41 INFO - Contents: 18:50:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6e2ee0d1d640e47ce8eca2b602c11395ca34c6e72983500f6a2a395be09ccd89faa894f9f885bdf2cf8fe9e8be8e9af04777e7826c50c84090b538b822da620", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/543fb7055e3f4f6633e35b40874bd09085a4e0e4bae1895e145ed89644d4085f58eefabe36c973555b292fe86b063290992377de916af4242b2785f886b4f398", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/56b4cfec562d7eec512f9deb02fcb38ac23fae39b6d610f1d2bac865fe84261ae850e4f2c5d43e70ed55fb924accb823394a7da0bfe317f0d0188a337acf456f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3361fc2993bc2307c11163cc2dba1b4f79869f2cbc17efa290cc06a5a6fce7844dee6d1afaea63195d1937d61cc6c1896b5def1e94b0100bac286c0385a6bc2d"} 18:50:41 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:41 INFO - Copying logs to upload dir... 18:50:41 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.778969 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-08-23 18:50:40.825150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 18:50:40.832138) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6e2ee0d1d640e47ce8eca2b602c11395ca34c6e72983500f6a2a395be09ccd89faa894f9f885bdf2cf8fe9e8be8e9af04777e7826c50c84090b538b822da620", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/543fb7055e3f4f6633e35b40874bd09085a4e0e4bae1895e145ed89644d4085f58eefabe36c973555b292fe86b063290992377de916af4242b2785f886b4f398", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/56b4cfec562d7eec512f9deb02fcb38ac23fae39b6d610f1d2bac865fe84261ae850e4f2c5d43e70ed55fb924accb823394a7da0bfe317f0d0188a337acf456f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3361fc2993bc2307c11163cc2dba1b4f79869f2cbc17efa290cc06a5a6fce7844dee6d1afaea63195d1937d61cc6c1896b5def1e94b0100bac286c0385a6bc2d"} build_url:https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010421 build_url: 'https://queue.taskcluster.net/v1/task/FXKmGW-ISvGwTLfarjOYBA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c6e2ee0d1d640e47ce8eca2b602c11395ca34c6e72983500f6a2a395be09ccd89faa894f9f885bdf2cf8fe9e8be8e9af04777e7826c50c84090b538b822da620", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/543fb7055e3f4f6633e35b40874bd09085a4e0e4bae1895e145ed89644d4085f58eefabe36c973555b292fe86b063290992377de916af4242b2785f886b4f398", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/56b4cfec562d7eec512f9deb02fcb38ac23fae39b6d610f1d2bac865fe84261ae850e4f2c5d43e70ed55fb924accb823394a7da0bfe317f0d0188a337acf456f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/3361fc2993bc2307c11163cc2dba1b4f79869f2cbc17efa290cc06a5a6fce7844dee6d1afaea63195d1937d61cc6c1896b5def1e94b0100bac286c0385a6bc2d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 18:50:40.858980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:50:40.859266) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503538195.152454-1052901860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:50:40.908253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 18:50:40.908519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 18:50:40.911788) ========= ========= Total master_lag: 0.30 =========