builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1503065573.06 results: success (0) revision: 006122d3bffe2e7e6a311d889282f0bd70e60620 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.057598) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.058062) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.058377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.074566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.074957) ========= 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=fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-18 07:12:53-- 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% 223M=0s 2017-08-18 07:12:53 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119717 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.210134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.213483) ========= 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=fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016339 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:53.266300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 07:12:53.266648) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 006122d3bffe2e7e6a311d889282f0bd70e60620 --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 006122d3bffe2e7e6a311d889282f0bd70e60620 --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=fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-18 07:12:53,755 truncating revision to first 12 chars 2017-08-18 07:12:53,755 Setting DEBUG logging. 2017-08-18 07:12:53,755 attempt 1/10 2017-08-18 07:12:53,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/006122d3bffe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-18 07:12:55,210 unpacking tar archive at: mozilla-beta-006122d3bffe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.773421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-18 07:12:55.057759) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:55.058094) ========= script_repo_revision: 006122d3bffe2e7e6a311d889282f0bd70e60620 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:55.058481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:55.058750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-18 07:12:55.070169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-18 07:12:55.070453) ========= /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=fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:12:55 INFO - MultiFileLogger online at 20170818 07:12:55 in /builds/slave/test 07:12:55 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 07:12:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:12:55 INFO - {'append_to_log': False, 07:12:55 INFO - 'base_work_dir': '/builds/slave/test', 07:12:55 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:12:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:12:55 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:12:55 INFO - 'buildbot_json_path': 'buildprops.json', 07:12:55 INFO - 'code_coverage': False, 07:12:55 INFO - 'config_files': ('talos/linux_config.py',), 07:12:55 INFO - 'default_actions': ('clobber', 07:12:55 INFO - 'read-buildbot-config', 07:12:55 INFO - 'download-and-extract', 07:12:55 INFO - 'populate-webroot', 07:12:55 INFO - 'create-virtualenv', 07:12:55 INFO - 'install', 07:12:55 INFO - 'setup-mitmproxy', 07:12:55 INFO - 'run-tests'), 07:12:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:12:55 INFO - 'disable_ccov_upload': False, 07:12:55 INFO - 'download_minidump_stackwalk': True, 07:12:55 INFO - 'download_symbols': 'ondemand', 07:12:55 INFO - 'enable_stylo': False, 07:12:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:12:55 INFO - 'tooltool.py': '/tools/tooltool.py', 07:12:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:12:55 INFO - '/tools/misc-python/virtualenv.py')}, 07:12:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:12:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:12:55 INFO - 'gecko_profile': False, 07:12:55 INFO - 'gecko_profile_interval': 0, 07:12:55 INFO - 'installer_path': 'installer.exe', 07:12:55 INFO - 'log_level': 'info', 07:12:55 INFO - 'log_name': 'talos', 07:12:55 INFO - 'log_to_console': True, 07:12:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:12:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:12:55 INFO - 'opt_config_files': (), 07:12:55 INFO - 'pip_index': False, 07:12:55 INFO - 'suite': 'dromaeojs-e10s', 07:12:55 INFO - 'system_bits': '32', 07:12:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:12:55 INFO - 'title': 'talos-linux64-ix-048', 07:12:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:12:55 INFO - 'use_talos_json': True, 07:12:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:12:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:12:55 INFO - 'work_dir': 'build'} 07:12:55 INFO - [mozharness: 2017-08-18 14:12:55.667083Z] Running clobber step. 07:12:55 INFO - Running pre-action listener: _resource_record_pre_action 07:12:55 INFO - Running main action method: clobber 07:12:55 INFO - rmtree: /builds/slave/test/build 07:12:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:12:56 INFO - Running post-action listener: _resource_record_post_action 07:12:56 INFO - [mozharness: 2017-08-18 14:12:56.701075Z] Finished clobber step (success) 07:12:56 INFO - [mozharness: 2017-08-18 14:12:56.701179Z] Running read-buildbot-config step. 07:12:56 INFO - Running pre-action listener: _resource_record_pre_action 07:12:56 INFO - Running main action method: read_buildbot_config 07:12:56 INFO - Using buildbot properties: 07:12:56 INFO - { 07:12:56 INFO - "project": "", 07:12:56 INFO - "product": "firefox", 07:12:56 INFO - "who": "ffxbld@noreply.mozilla.org", 07:12:56 INFO - "installer_path": "public/build/target.tar.bz2", 07:12:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:12:56 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:12:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:12:56 INFO - "stage_platform": "linux64", 07:12:56 INFO - "basedir": "/builds/slave/test", 07:12:56 INFO - "buildnumber": 53, 07:12:56 INFO - "platform": "ubuntu64_hw", 07:12:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:12:56 INFO - "slavebuilddir": "test", 07:12:56 INFO - "taskId": "W1I5iMX5S4GdXHDSRPOZWQ", 07:12:56 INFO - "branch": "mozilla-beta", 07:12:56 INFO - "script_repo_revision": "production", 07:12:56 INFO - "revision": "006122d3bffe2e7e6a311d889282f0bd70e60620", 07:12:56 INFO - "slavename": "talos-linux64-ix-048", 07:12:56 INFO - "repo_path": "releases/mozilla-beta" 07:12:56 INFO - } 07:12:56 INFO - Finding installer, test and symbols from parent task. 07:12:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1I5iMX5S4GdXHDSRPOZWQ'}, attempt #1 07:12:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1I5iMX5S4GdXHDSRPOZWQ'}, attempt #1 07:12:57 INFO - Task dependencies: Dk1apzgORRuEWgwuC-WsPQ 07:12:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ'}, attempt #1 07:12:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2 07:12:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.test_packages.json 07:12:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.crashreporter-symbols.zip 07:12:58 INFO - Running post-action listener: _resource_record_post_action 07:12:58 INFO - [mozharness: 2017-08-18 14:12:58.084011Z] Finished read-buildbot-config step (success) 07:12:58 INFO - [mozharness: 2017-08-18 14:12:58.084234Z] Running download-and-extract step. 07:12:58 INFO - Running pre-action listener: _resource_record_pre_action 07:12:58 INFO - Running main action method: download_and_extract 07:12:58 INFO - mkdir: /builds/slave/test/build/tests 07:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:12:58 INFO - trying https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.test_packages.json 07:12:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:12:58 INFO - Downloaded 989 bytes. 07:12:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:12:58 INFO - Using the following test package requirements: 07:12:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:12:58 INFO - u'common': [u'target.common.tests.zip'], 07:12:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:12:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:12:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:12:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:12:58 INFO - u'mozbase': [u'target.common.tests.zip'], 07:12:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:12:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:12:58 INFO - u'web-platform': [u'target.common.tests.zip', 07:12:58 INFO - u'target.web-platform.tests.tar.gz'], 07:12:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:12:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:12:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.common.tests.zip 07:12:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:12:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.common.tests.zip into memory 07:12:59 INFO - Content-Length response header: 72855596 07:12:59 INFO - Bytes received: 72855596 07:13:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:13:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.common.tests.zip 07:13:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:13:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.common.tests.zip into memory 07:13:12 INFO - Content-Length response header: 72855596 07:13:12 INFO - Bytes received: 72855596 07:13:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.talos.tests.zip 07:13:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:13:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.talos.tests.zip into memory 07:13:28 INFO - Content-Length response header: 14496472 07:13:28 INFO - Bytes received: 14496472 07:13: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')]} 07:13:28 INFO - trying https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2 07:13:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:13:30 INFO - Downloaded 53922242 bytes. 07:13:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2 07:13:30 INFO - mkdir: /builds/slave/test/properties 07:13:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:30 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:30 INFO - Contents: 07:13:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2 07:13:30 INFO - Running post-action listener: _resource_record_post_action 07:13:30 INFO - Running post-action listener: set_extra_try_arguments 07:13:30 INFO - [mozharness: 2017-08-18 14:13:30.183445Z] Finished download-and-extract step (success) 07:13:30 INFO - [mozharness: 2017-08-18 14:13:30.183652Z] Running populate-webroot step. 07:13:30 INFO - Running pre-action listener: _resource_record_pre_action 07:13:30 INFO - Running main action method: populate_webroot 07:13:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:13:30 INFO - 'tests': ['damp', 'tps']}, 07:13:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:13:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:13:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:13:30 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:30 INFO - 'ts_paint', 07:13:30 INFO - 'tpaint', 07:13:30 INFO - 'sessionrestore', 07:13:30 INFO - 'sessionrestore_many_windows', 07:13:30 INFO - 'sessionrestore_no_auto_restore', 07:13:30 INFO - 'tabpaint']}, 07:13:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:13:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:13:30 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:30 INFO - 'talos_options': ['--mitmproxy', 07:13:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:30 INFO - '--firstNonBlankPaint'], 07:13:30 INFO - 'tests': ['quantum_pageload_google', 07:13:30 INFO - 'quantum_pageload_youtube', 07:13:30 INFO - 'quantum_pageload_amazon', 07:13:30 INFO - 'quantum_pageload_facebook']}, 07:13:30 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:30 INFO - 'talos_options': ['--stylo', 07:13:30 INFO - '--mitmproxy', 07:13:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:30 INFO - '--firstNonBlankPaint'], 07:13:30 INFO - 'tests': ['quantum_pageload_google', 07:13:30 INFO - 'quantum_pageload_youtube', 07:13:30 INFO - 'quantum_pageload_amazon', 07:13:30 INFO - 'quantum_pageload_facebook']}, 07:13:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:30 INFO - 'tsvgr_opacity', 07:13:30 INFO - 'tart', 07:13:30 INFO - 'tscrollx', 07:13:30 INFO - 'cart', 07:13:30 INFO - 'tsvg_static']}, 07:13:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:13:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:30 INFO - 'talos_options': ['--stylo', 07:13:30 INFO - '--stylo-threads=1', 07:13:30 INFO - '--mitmproxy', 07:13:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:30 INFO - '--firstNonBlankPaint'], 07:13:30 INFO - 'tests': ['tp6_google', 07:13:30 INFO - 'tp6_youtube', 07:13:30 INFO - 'tp6_amazon', 07:13:30 INFO - 'tp6_facebook']}, 07:13:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:13:30 INFO - 'talos_options': ['--xperf_path', 07:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:30 INFO - 'tests': ['tp5n']}}} 07:13:30 INFO - Running post-action listener: _resource_record_post_action 07:13:30 INFO - [mozharness: 2017-08-18 14:13:30.195682Z] Finished populate-webroot step (success) 07:13:30 INFO - [mozharness: 2017-08-18 14:13:30.195773Z] Running create-virtualenv step. 07:13:30 INFO - Running pre-action listener: _resource_record_pre_action 07:13:30 INFO - Running main action method: create_virtualenv 07:13:30 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:30 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 07:13:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:13:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:13:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:30 INFO - Using real prefix '/usr' 07:13:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:32 INFO - Installing pip.................done. 07:13:32 INFO - Return code: 0 07:13:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:13:32 INFO - Reading from file tmpfile_stdout 07:13:32 INFO - Output received: 07:13: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) 07:13:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13: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')]} 07:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13: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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13: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 07:13: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 07:13:32 INFO - Using env: {'DISPLAY': ':0', 07:13:32 INFO - 'HOME': '/home/cltbld', 07:13:32 INFO - 'LANG': 'en_US.UTF-8', 07:13:32 INFO - 'LANGUAGE': 'en_US:en', 07:13:32 INFO - 'LOGNAME': 'cltbld', 07:13:32 INFO - 'MAIL': '/var/mail/cltbld', 07:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:32 INFO - 'MOZ_NO_REMOTE': '1', 07:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:32 INFO - 'NO_EM_RESTART': '1', 07:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:32 INFO - 'PWD': '/builds/slave/test', 07:13:32 INFO - 'SHELL': '/bin/bash', 07:13:32 INFO - 'SHLVL': '1', 07:13:32 INFO - 'TERM': 'linux', 07:13:32 INFO - 'TMOUT': '86400', 07:13:32 INFO - 'USER': 'cltbld', 07:13:32 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:32 INFO - '_': '/tools/buildbot/bin/python'} 07:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:33 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 07:13:33 INFO - Cleaning up... 07:13:33 INFO - Return code: 0 07:13:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:13:33 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')]} 07:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:33 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')]} 07:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:33 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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13:33 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 07:13:33 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 07:13:33 INFO - Using env: {'DISPLAY': ':0', 07:13:33 INFO - 'HOME': '/home/cltbld', 07:13:33 INFO - 'LANG': 'en_US.UTF-8', 07:13:33 INFO - 'LANGUAGE': 'en_US:en', 07:13:33 INFO - 'LOGNAME': 'cltbld', 07:13:33 INFO - 'MAIL': '/var/mail/cltbld', 07:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:33 INFO - 'MOZ_NO_REMOTE': '1', 07:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:33 INFO - 'NO_EM_RESTART': '1', 07:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:33 INFO - 'PWD': '/builds/slave/test', 07:13:33 INFO - 'SHELL': '/bin/bash', 07:13:33 INFO - 'SHLVL': '1', 07:13:33 INFO - 'TERM': 'linux', 07:13:33 INFO - 'TMOUT': '86400', 07:13:33 INFO - 'USER': 'cltbld', 07:13:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:33 INFO - '_': '/tools/buildbot/bin/python'} 07:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:33 INFO - Downloading/unpacking psutil>=3.1.1 07:13:33 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 07:13:33 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 07:13:33 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 07:13:33 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 07:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:34 INFO - Installing collected packages: psutil 07:13:34 INFO - Running setup.py install for psutil 07:13:34 INFO - building 'psutil._psutil_linux' extension 07:13: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 07:13: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 07:13:34 INFO - building 'psutil._psutil_posix' extension 07:13: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 07:13:35 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 07:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:35 INFO - Successfully installed psutil 07:13:35 INFO - Cleaning up... 07:13:35 INFO - Return code: 0 07:13:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:13:35 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')]} 07:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:35 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')]} 07:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:35 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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13:35 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 07:13:35 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 07:13:35 INFO - Using env: {'DISPLAY': ':0', 07:13:35 INFO - 'HOME': '/home/cltbld', 07:13:35 INFO - 'LANG': 'en_US.UTF-8', 07:13:35 INFO - 'LANGUAGE': 'en_US:en', 07:13:35 INFO - 'LOGNAME': 'cltbld', 07:13:35 INFO - 'MAIL': '/var/mail/cltbld', 07:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:35 INFO - 'MOZ_NO_REMOTE': '1', 07:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:35 INFO - 'NO_EM_RESTART': '1', 07:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:35 INFO - 'PWD': '/builds/slave/test', 07:13:35 INFO - 'SHELL': '/bin/bash', 07:13:35 INFO - 'SHLVL': '1', 07:13:35 INFO - 'TERM': 'linux', 07:13:35 INFO - 'TMOUT': '86400', 07:13:35 INFO - 'USER': 'cltbld', 07:13:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:35 INFO - '_': '/tools/buildbot/bin/python'} 07:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:13:35 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 07:13:35 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 07:13:35 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 07:13:35 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 07:13:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:13:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:13:36 INFO - Installing collected packages: mozsystemmonitor 07:13:36 INFO - Running setup.py install for mozsystemmonitor 07:13:36 INFO - Successfully installed mozsystemmonitor 07:13:36 INFO - Cleaning up... 07:13:36 INFO - Return code: 0 07:13:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13: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')]} 07:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13: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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13: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 07:13: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 07:13:36 INFO - Using env: {'DISPLAY': ':0', 07:13:36 INFO - 'HOME': '/home/cltbld', 07:13:36 INFO - 'LANG': 'en_US.UTF-8', 07:13:36 INFO - 'LANGUAGE': 'en_US:en', 07:13:36 INFO - 'LOGNAME': 'cltbld', 07:13:36 INFO - 'MAIL': '/var/mail/cltbld', 07:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:36 INFO - 'MOZ_NO_REMOTE': '1', 07:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:36 INFO - 'NO_EM_RESTART': '1', 07:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:36 INFO - 'PWD': '/builds/slave/test', 07:13:36 INFO - 'SHELL': '/bin/bash', 07:13:36 INFO - 'SHLVL': '1', 07:13:36 INFO - 'TERM': 'linux', 07:13:36 INFO - 'TMOUT': '86400', 07:13:36 INFO - 'USER': 'cltbld', 07:13:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:36 INFO - '_': '/tools/buildbot/bin/python'} 07:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:36 INFO - Downloading/unpacking jsonschema==2.5.1 07:13: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 07:13: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 07:13: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 07:13: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 07:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:13:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:13: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 07:13: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 07:13: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 07:13: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 07:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:13:38 INFO - warning: no files found matching '*.txt' 07:13:38 INFO - no previously-included directories found matching 'build' 07:13:38 INFO - no previously-included directories found matching 'dist' 07:13:38 INFO - no previously-included directories found matching '.git*' 07:13:38 INFO - Installing collected packages: jsonschema, functools32 07:13:38 INFO - Running setup.py install for functools32 07:13:38 INFO - warning: no files found matching '*.txt' 07:13:38 INFO - no previously-included directories found matching 'build' 07:13:38 INFO - no previously-included directories found matching 'dist' 07:13:38 INFO - no previously-included directories found matching '.git*' 07:13:38 INFO - Successfully installed jsonschema functools32 07:13:38 INFO - Cleaning up... 07:13:38 INFO - Return code: 0 07:13:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13: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')]} 07:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13: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', '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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:13: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 functools32==3.2.3-2 07:13:38 INFO - Using env: {'DISPLAY': ':0', 07:13:38 INFO - 'HOME': '/home/cltbld', 07:13:38 INFO - 'LANG': 'en_US.UTF-8', 07:13:38 INFO - 'LANGUAGE': 'en_US:en', 07:13:38 INFO - 'LOGNAME': 'cltbld', 07:13:38 INFO - 'MAIL': '/var/mail/cltbld', 07:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:38 INFO - 'MOZ_NO_REMOTE': '1', 07:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:38 INFO - 'NO_EM_RESTART': '1', 07:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:38 INFO - 'PWD': '/builds/slave/test', 07:13:38 INFO - 'SHELL': '/bin/bash', 07:13:38 INFO - 'SHLVL': '1', 07:13:38 INFO - 'TERM': 'linux', 07:13:38 INFO - 'TMOUT': '86400', 07:13:38 INFO - 'USER': 'cltbld', 07:13:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:38 INFO - '_': '/tools/buildbot/bin/python'} 07:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:13:38 INFO - Cleaning up... 07:13:38 INFO - Return code: 0 07:13:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13: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')]} 07:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13: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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13: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 07:13: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 07:13:38 INFO - Using env: {'DISPLAY': ':0', 07:13:38 INFO - 'HOME': '/home/cltbld', 07:13:38 INFO - 'LANG': 'en_US.UTF-8', 07:13:38 INFO - 'LANGUAGE': 'en_US:en', 07:13:38 INFO - 'LOGNAME': 'cltbld', 07:13:38 INFO - 'MAIL': '/var/mail/cltbld', 07:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:38 INFO - 'MOZ_NO_REMOTE': '1', 07:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:38 INFO - 'NO_EM_RESTART': '1', 07:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:38 INFO - 'PWD': '/builds/slave/test', 07:13:38 INFO - 'SHELL': '/bin/bash', 07:13:38 INFO - 'SHLVL': '1', 07:13:38 INFO - 'TERM': 'linux', 07:13:38 INFO - 'TMOUT': '86400', 07:13:38 INFO - 'USER': 'cltbld', 07:13:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:38 INFO - '_': '/tools/buildbot/bin/python'} 07:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:13: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 07:13: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 07:13: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 07:13: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 07:13:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:13:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:13: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 07:13: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 07:13: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 07:13: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 07:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:40 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 07:13:40 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 07:13:40 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 07:13:40 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 07:13:40 INFO - Downloading docopt-0.6.1.tar.gz 07:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:40 INFO - Running setup.py install for blobuploader 07:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:40 INFO - Running setup.py install for requests 07:13:40 INFO - Running setup.py install for docopt 07:13:41 INFO - Successfully installed blobuploader requests docopt 07:13:41 INFO - Cleaning up... 07:13:41 INFO - Return code: 0 07:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:41 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')]} 07:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:41 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')]} 07:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:41 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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13:41 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 07:13:41 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 07:13:41 INFO - Using env: {'DISPLAY': ':0', 07:13:41 INFO - 'HOME': '/home/cltbld', 07:13:41 INFO - 'LANG': 'en_US.UTF-8', 07:13:41 INFO - 'LANGUAGE': 'en_US:en', 07:13:41 INFO - 'LOGNAME': 'cltbld', 07:13:41 INFO - 'MAIL': '/var/mail/cltbld', 07:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:41 INFO - 'MOZ_NO_REMOTE': '1', 07:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:41 INFO - 'NO_EM_RESTART': '1', 07:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:41 INFO - 'PWD': '/builds/slave/test', 07:13:41 INFO - 'SHELL': '/bin/bash', 07:13:41 INFO - 'SHLVL': '1', 07:13:41 INFO - 'TERM': 'linux', 07:13:41 INFO - 'TMOUT': '86400', 07:13:41 INFO - 'USER': 'cltbld', 07:13:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:41 INFO - '_': '/tools/buildbot/bin/python'} 07:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:41 INFO - Running setup.py (path:/tmp/pip-XZmGuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:41 INFO - Running setup.py (path:/tmp/pip-9K1J7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:41 INFO - Running setup.py (path:/tmp/pip-b8nq1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:41 INFO - Running setup.py (path:/tmp/pip-fbsQyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:41 INFO - Running setup.py (path:/tmp/pip-fJByE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:41 INFO - Running setup.py (path:/tmp/pip-9xn1nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:41 INFO - Running setup.py (path:/tmp/pip-X4KWkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:41 INFO - Running setup.py (path:/tmp/pip-UeQtXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:41 INFO - Running setup.py (path:/tmp/pip-WS7PRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:41 INFO - Running setup.py (path:/tmp/pip-mwK6zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:42 INFO - Running setup.py (path:/tmp/pip-NKlOGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:42 INFO - Running setup.py (path:/tmp/pip-TeI0Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:42 INFO - Running setup.py (path:/tmp/pip-UTUbP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:42 INFO - Running setup.py (path:/tmp/pip-ynNhOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:42 INFO - Running setup.py (path:/tmp/pip-6lBsGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:42 INFO - Running setup.py (path:/tmp/pip-ijdIBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:42 INFO - Running setup.py (path:/tmp/pip-f3W_OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:13:42 INFO - Running setup.py install for manifestparser 07:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:13:42 INFO - Running setup.py install for mozcrash 07:13:42 INFO - Running setup.py install for mozdebug 07:13:42 INFO - Running setup.py install for mozdevice 07:13:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:13:42 INFO - Running setup.py install for mozfile 07:13:43 INFO - Running setup.py install for mozhttpd 07:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Running setup.py install for mozinfo 07:13:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Running setup.py install for mozInstall 07:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Running setup.py install for mozleak 07:13:43 INFO - Running setup.py install for mozlog 07:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Running setup.py install for moznetwork 07:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Running setup.py install for mozprocess 07:13:43 INFO - Running setup.py install for mozprofile 07:13:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:13:43 INFO - Running setup.py install for mozrunner 07:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:13:44 INFO - Running setup.py install for mozscreenshot 07:13:44 INFO - Running setup.py install for moztest 07:13:44 INFO - Running setup.py install for mozversion 07:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:13:44 INFO - Cleaning up... 07:13:44 INFO - Return code: 0 07:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:44 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')]} 07:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:44 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')]} 07:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:44 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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13:44 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 07:13:44 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 07:13:44 INFO - Using env: {'DISPLAY': ':0', 07:13:44 INFO - 'HOME': '/home/cltbld', 07:13:44 INFO - 'LANG': 'en_US.UTF-8', 07:13:44 INFO - 'LANGUAGE': 'en_US:en', 07:13:44 INFO - 'LOGNAME': 'cltbld', 07:13:44 INFO - 'MAIL': '/var/mail/cltbld', 07:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:44 INFO - 'MOZ_NO_REMOTE': '1', 07:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:44 INFO - 'NO_EM_RESTART': '1', 07:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:44 INFO - 'PWD': '/builds/slave/test', 07:13:44 INFO - 'SHELL': '/bin/bash', 07:13:44 INFO - 'SHLVL': '1', 07:13:44 INFO - 'TERM': 'linux', 07:13:44 INFO - 'TMOUT': '86400', 07:13:44 INFO - 'USER': 'cltbld', 07:13:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:44 INFO - '_': '/tools/buildbot/bin/python'} 07:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:44 INFO - Running setup.py (path:/tmp/pip-qkSMzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13: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)) 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:44 INFO - Running setup.py (path:/tmp/pip-cXwYtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13: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)) 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:44 INFO - Running setup.py (path:/tmp/pip-87nAfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13: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)) 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:44 INFO - Running setup.py (path:/tmp/pip-OBaItw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13: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)) 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:44 INFO - Running setup.py (path:/tmp/pip-uHeDhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13: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)) 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:44 INFO - Running setup.py (path:/tmp/pip-zyl1ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13: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)) 07:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:44 INFO - Running setup.py (path:/tmp/pip-k7mjwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:45 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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:45 INFO - Running setup.py (path:/tmp/pip-25Y7AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:45 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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:45 INFO - Running setup.py (path:/tmp/pip-OggzTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:45 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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:45 INFO - Running setup.py (path:/tmp/pip-VYEAR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:45 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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:45 INFO - Running setup.py (path:/tmp/pip-Yg1vo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:45 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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:45 INFO - Running setup.py (path:/tmp/pip-N78c5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:45 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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:45 INFO - Running setup.py (path:/tmp/pip-kPaOBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13: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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:45 INFO - Running setup.py (path:/tmp/pip-4z6OMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13: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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:45 INFO - Running setup.py (path:/tmp/pip-5O4r5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13: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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:45 INFO - Running setup.py (path:/tmp/pip-HWZGdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13: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)) 07:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:45 INFO - Running setup.py (path:/tmp/pip-1etC6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13: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 07:13: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 07:13: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 07:13: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 07:13:46 INFO - Downloading blessings-1.6.tar.gz 07:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:13:46 INFO - Installing collected packages: blessings 07:13:46 INFO - Running setup.py install for blessings 07:13:47 INFO - Successfully installed blessings 07:13:47 INFO - Cleaning up... 07:13:47 INFO - Return code: 0 07:13:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:13:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:47 INFO - Reading from file tmpfile_stdout 07:13:47 INFO - Current package versions: 07:13:47 INFO - argparse == 1.2.1 07:13:47 INFO - blessings == 1.6 07:13:47 INFO - blobuploader == 1.2.4 07:13:47 INFO - docopt == 0.6.1 07:13:47 INFO - functools32 == 3.2.3-2 07:13:47 INFO - jsonschema == 2.5.1 07:13:47 INFO - manifestparser == 1.1 07:13:47 INFO - mozInstall == 1.13 07:13:47 INFO - mozcrash == 1.0 07:13:47 INFO - mozdebug == 0.1 07:13:47 INFO - mozdevice == 0.51 07:13:47 INFO - mozfile == 1.2 07:13:47 INFO - mozhttpd == 0.7 07:13:47 INFO - mozinfo == 0.10 07:13:47 INFO - mozleak == 0.1 07:13:47 INFO - mozlog == 3.5 07:13:47 INFO - moznetwork == 0.27 07:13:47 INFO - mozprocess == 0.25 07:13:47 INFO - mozprofile == 0.28 07:13:47 INFO - mozrunner == 6.13 07:13:47 INFO - mozscreenshot == 0.1 07:13:47 INFO - mozsystemmonitor == 0.3 07:13:47 INFO - moztest == 0.8 07:13:47 INFO - mozversion == 1.4 07:13:47 INFO - psutil == 3.1.1 07:13:47 INFO - requests == 1.2.3 07:13:47 INFO - wsgiref == 0.1.2 07:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:47 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')]} 07:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:47 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')]} 07:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:47 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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13:47 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 07:13:47 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 07:13:47 INFO - Using env: {'DISPLAY': ':0', 07:13:47 INFO - 'HOME': '/home/cltbld', 07:13:47 INFO - 'LANG': 'en_US.UTF-8', 07:13:47 INFO - 'LANGUAGE': 'en_US:en', 07:13:47 INFO - 'LOGNAME': 'cltbld', 07:13:47 INFO - 'MAIL': '/var/mail/cltbld', 07:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:47 INFO - 'MOZ_NO_REMOTE': '1', 07:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:47 INFO - 'NO_EM_RESTART': '1', 07:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:47 INFO - 'PWD': '/builds/slave/test', 07:13:47 INFO - 'SHELL': '/bin/bash', 07:13:47 INFO - 'SHLVL': '1', 07:13:47 INFO - 'TERM': 'linux', 07:13:47 INFO - 'TMOUT': '86400', 07:13:47 INFO - 'USER': 'cltbld', 07:13:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:47 INFO - '_': '/tools/buildbot/bin/python'} 07:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13: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)) 07:13:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:13: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 07:13: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 07:13: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 07:13: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 07:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:13: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)) 07:13: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)) 07:13:48 INFO - Installing collected packages: simplejson 07:13:48 INFO - Running setup.py install for simplejson 07:13:48 INFO - building 'simplejson._speedups' extension 07:13: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 07:13: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 07:13:49 INFO - Successfully installed simplejson 07:13:49 INFO - Cleaning up... 07:13:49 INFO - Return code: 0 07:13:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13: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')]} 07:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13: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 0x1caa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2019eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, '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': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', '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 07:13: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 07:13: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 07:13:49 INFO - Using env: {'DISPLAY': ':0', 07:13:49 INFO - 'HOME': '/home/cltbld', 07:13:49 INFO - 'LANG': 'en_US.UTF-8', 07:13:49 INFO - 'LANGUAGE': 'en_US:en', 07:13:49 INFO - 'LOGNAME': 'cltbld', 07:13:49 INFO - 'MAIL': '/var/mail/cltbld', 07:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:49 INFO - 'MOZ_NO_REMOTE': '1', 07:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:49 INFO - 'NO_EM_RESTART': '1', 07:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:49 INFO - 'PWD': '/builds/slave/test', 07:13:49 INFO - 'SHELL': '/bin/bash', 07:13:49 INFO - 'SHLVL': '1', 07:13:49 INFO - 'TERM': 'linux', 07:13:49 INFO - 'TMOUT': '86400', 07:13:49 INFO - 'USER': 'cltbld', 07:13:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:49 INFO - '_': '/tools/buildbot/bin/python'} 07:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:13:50 INFO - Cleaning up... 07:13:50 INFO - Return code: 0 07:13:50 INFO - Running post-action listener: _resource_record_post_action 07:13:50 INFO - Running post-action listener: _start_resource_monitoring 07:13:50 INFO - Starting resource monitoring. 07:13:50 INFO - [mozharness: 2017-08-18 14:13:50.075787Z] Finished create-virtualenv step (success) 07:13:50 INFO - [mozharness: 2017-08-18 14:13:50.076253Z] Running install step. 07:13:50 INFO - Running pre-action listener: _resource_record_pre_action 07:13:50 INFO - Running main action method: install 07:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:50 INFO - Reading from file tmpfile_stdout 07:13:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:13:50 INFO - Reading from file tmpfile_stdout 07:13:50 INFO - Output received: 07:13:50 INFO - Usage: mozinstall [options] installer 07:13:50 INFO - Options: 07:13:50 INFO - -h, --help show this help message and exit 07:13:50 INFO - -d DEST, --destination=DEST 07:13:50 INFO - Directory to install application into. [default: 07:13:50 INFO - "/builds/slave/test"] 07:13:50 INFO - --app=APP Application being installed. [default: firefox] 07:13:50 INFO - mkdir: /builds/slave/test/build/application 07:13: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'] 07:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:14:05 INFO - Reading from file tmpfile_stdout 07:14:05 INFO - Output received: 07:14:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:14:05 INFO - Running post-action listener: _resource_record_post_action 07:14:05 INFO - [mozharness: 2017-08-18 14:14:05.145137Z] Finished install step (success) 07:14:05 INFO - [mozharness: 2017-08-18 14:14:05.145285Z] Running setup-mitmproxy step. 07:14:05 INFO - Running pre-action listener: _resource_record_pre_action 07:14:05 INFO - Running main action method: setup_mitmproxy 07:14:05 INFO - Skipping: mitmproxy is not required 07:14:05 INFO - Running post-action listener: _resource_record_post_action 07:14:05 INFO - [mozharness: 2017-08-18 14:14:05.146278Z] Finished setup-mitmproxy step (success) 07:14:05 INFO - [mozharness: 2017-08-18 14:14:05.146499Z] Running run-tests step. 07:14:05 INFO - Running pre-action listener: _resource_record_pre_action 07:14:05 INFO - Running pre-action listener: _set_gcov_prefix 07:14:05 INFO - Running main action method: run_tests 07:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:05 INFO - Python 2.7.3 07:14:05 INFO - Return code: 0 07:14:05 INFO - grabbing minidump binary from tooltool 07:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:14:05 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 0x2017050>, '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 0x2017f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20183e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:05 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 07:14:05 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 07:14:05 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 07:14:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:05 INFO - Return code: 0 07:14:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:05 INFO - ENV: RUST_BACKTRACE is now 1 07:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:05 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/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 07:14:05 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/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 07:14:05 INFO - Using env: {'DISPLAY': ':0', 07:14:05 INFO - 'HOME': '/home/cltbld', 07:14:05 INFO - 'LANG': 'en_US.UTF-8', 07:14:05 INFO - 'LANGUAGE': 'en_US:en', 07:14:05 INFO - 'LOGNAME': 'cltbld', 07:14:05 INFO - 'MAIL': '/var/mail/cltbld', 07:14:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:05 INFO - 'MOZ_NO_REMOTE': '1', 07:14:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:05 INFO - 'NO_EM_RESTART': '1', 07:14:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:05 INFO - 'PWD': '/builds/slave/test', 07:14:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:05 INFO - 'RUST_BACKTRACE': '1', 07:14:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:05 INFO - 'SHELL': '/bin/bash', 07:14:05 INFO - 'SHLVL': '1', 07:14:05 INFO - 'TERM': 'linux', 07:14:05 INFO - 'TMOUT': '86400', 07:14:05 INFO - 'USER': 'cltbld', 07:14:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120', 07:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:05 INFO - '_': '/tools/buildbot/bin/python'} 07:14:05 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/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 07:14:05 INFO - mozversion application_buildid: 20170818130022 07:14:05 INFO - mozversion application_changeset: 006122d3bffe2e7e6a311d889282f0bd70e60620 07:14:05 INFO - mozversion application_display_name: Firefox 07:14:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:05 INFO - mozversion application_name: Firefox 07:14:05 INFO - mozversion application_remotingname: firefox 07:14:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:14:05 INFO - mozversion application_vendor: Mozilla 07:14:05 INFO - mozversion application_version: 56.0 07:14:05 INFO - mozversion platform_buildid: 20170818130022 07:14:05 INFO - mozversion platform_changeset: 006122d3bffe2e7e6a311d889282f0bd70e60620 07:14:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:14:05 INFO - mozversion platform_version: 56.0 07:14:05 INFO - using testdate: 1503065645 07:14:05 INFO - actual date: 1503065645 07:14:05 INFO - starting webserver on 'localhost:53581' 07:14:05 INFO - SUITE-START | Running 2 tests 07:14:05 INFO - TEST-START | dromaeo_css 07:14:05 INFO - Initialising browser for dromaeo_css test... 07:14:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53581/getInfo.html -profile /tmp/tmpYK3Emg/profile 07:14:05 INFO - TEST-INFO | started process 5424 (/builds/slave/test/build/application/firefox/firefox http://localhost:53581/getInfo.html) 07:14:11 INFO - TEST-INFO | 5424: exit 0 07:14:11 INFO - Browser initialized. 07:14:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:11 INFO - TEST-INFO | started process 5588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYK3Emg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:11 INFO - PID 5588 | 1503065651626 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 07:14:22 INFO - PID 5588 | RSS: Main: 154329088 07:14:22 INFO - PID 5588 | 07:17:20 INFO - PID 5588 | Cycle 1(1): loaded http://localhost:53581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53581/tests/dromaeo/cssquery-ext.html) 07:17:21 INFO - PID 5588 | RSS: Main: 160616448 07:17:21 INFO - PID 5588 | 07:20:23 INFO - PID 5588 | Cycle 1(1): loaded http://localhost:53581/tests/dromaeo/cssquery-ext.html (next: http://localhost:53581/tests/dromaeo/cssquery-jquery.html) 07:20:24 INFO - PID 5588 | RSS: Main: 157507584 07:20:24 INFO - PID 5588 | 07:23:25 INFO - PID 5588 | Cycle 1(1): loaded http://localhost:53581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53581/tests/dromaeo/cssquery-mootools.html) 07:23:26 INFO - PID 5588 | RSS: Main: 159371264 07:23:26 INFO - PID 5588 | 07:26:27 INFO - PID 5588 | Cycle 1(1): loaded http://localhost:53581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53581/tests/dromaeo/cssquery-prototype.html) 07:26:28 INFO - PID 5588 | RSS: Main: 159293440 07:26:28 INFO - PID 5588 | 07:29:31 INFO - PID 5588 | Cycle 1(1): loaded http://localhost:53581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53581/tests/dromaeo/cssquery-yui.html) 07:29:32 INFO - PID 5588 | RSS: Main: 161640448 07:29:32 INFO - PID 5588 | 07:32:33 INFO - PID 5588 | Cycle 1(1): loaded http://localhost:53581/tests/dromaeo/cssquery-yui.html (next: http://localhost:53581/tests/dromaeo/cssquery-dojo.html) 07:32:34 INFO - PID 5588 | RSS: Main: 162516992 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | __start_tp_report 07:32:34 INFO - PID 5588 | _x_x_mozilla_page_load 07:32:34 INFO - PID 5588 | _x_x_mozilla_page_load_details 07:32:34 INFO - PID 5588 | |i|pagename|runs| 07:32:34 INFO - PID 5588 | |0;dojo.html;3597.1906321077777;3618.819059047047;3628.782273063618;3660.1032746976985;3662.7069834413232;6457.967710161454;6475.838104047401;6491.967540162298;6526.151600291967;6541.803745887625;6461.8061458156335;6472.352764723525;6527.673616319189;6547.279799222082;6553.90169147462;5606.971965140168;5640.717964101799;5655.57583181261;5697.886042279152;5709.31488221414;5663.377028526858;5695.45893140151;5699.2590963174725;5744.540436765049;5767.365589785141;5581.720913954286;5634.492895639371;5663.008973429633;5705.51503122233;5722.2561067061015;5645.01212287848;5645.689487078209;5665.745041473144;5694.487496125369;5695.316562012544;5598.468145526209;5624.100143976985;5671.007573674632;5706.572007099443;5720.11338242573;6342.841428964312;6396.808095757135;6417.133686952248;6427.100205971121;6437.2918978912285;6944.930550694479;6947.5831450113155;7012.754553590651;7024.894626580605;7030;6901.654917254167;6949.89575156373;7017.859642807166;7034.5779253244455;7110;6457.483401327882;6515.967420162869;6518.804435866931;6532.118164047888;6550.967245163839;7193.3166349196745;7248.492605517668;7257.020302259233;7270.200277969419;7280.199178090405;6779.389854913082;6845.863082738318;6917.861642767117;6931.653417329113;6933.722651094001;6911.619860907698;6921.238663746984;6929.79210623672;6943.930560694429;7000.719971201197;6959;6963.338482844122;6965.686544105527;6982.965085174542;7001.50989430735;6852.862942741117;6861.519693621399;6947.89578156328;6950.826229344307;6956.721731130698;5028.120078986163;5101.056304583664;5121.769520371592;5179.48205179479;5191.32512773337;4524.5701658342405;4573.565511276423;4588.059447813191;4593.517680643551;4634.050019745944;6625.834354141185;6637.037629543689;6655.86688266232;6711.530192886451;6718.05947167397;6995.8600827983155;6995.8950615740805;7007.089078419773;7077.1507419109;7096.0420343253;6586.736530538725;6597.175353080865;6599.373059559334;6677.165354330708;6677.53257271996;5849.941500585025;5870.677112758839;5873.2658417697785;5907.970460147758;5908.615939963888;7023.68393422287;7069.681864316118;7095.680694368766;7149.0706208192605;7164.856702865914;6899.275576064641;6940.028396024662;6952.513324067267;6976.895346569704;6977.965110174417;7123.074000379917;7245.094363204599;7247.9637601811655;7270.854582908418;7294.817629559304;6800.659967001531;6888.483363747639;6895.724171033103;6926.480513961574;6931.549449285781;6935.410490108397;6945.201301850352;6951.548149370275;6956.165260168812;7041.929580704127;6727.461803055646;6738.663066846736;6812.420944219797;6835.965820170867;6840.384365407137;6733.293004234485;6736.7642132525125;6751.662416879039;6876.415504682158;6883.621400823003;6703.698333575098;6716;6790.490713196431;6804.727810887509;6807.455403567802;6799.218089919723;6803.557768745016;6856.828579285558;6879.931200687929;6886.035954966209;6580.934190658032;6634.767783127568;6657.034729964032;6657.434118100015;6661.666916654245 07:32:34 INFO - PID 5588 | |1;ext.html;889.6762129711641;902.170018308456;923.113810741688;924.9630014799408;944.0135058863488;43646.781766091204;43843.78078109609;44397.112057758866;44404;44596;44715.88210294744;45144.77427612866;45291.320630190574;45322.32016519747;45334.54665453353;7871.409644276673;7988;8008.079070906862;8012.3189528889825;8037.075736290314;7913;7997.04035515736;8021.598920054003;8036.116027236999;8043.638036288381;8005.3195478384405;8044.959775201116;8061.193880611951;8061.556614386206;8062.032556093277;8003.399745019147;8032.1164671886045;8032.558209298486;8039.397045221632;8039.397045221632;7836.882446763303;7906.7627971160955;7913.366930645535;7936.484128531627;7938.960305198437;41635.37546936768;41743.791281043705;41938.58061419408;41976;42206.78896605528;3776.2447510497736;3833.3291673956946;3833.7891415972113;3835.42468629705;3840.615938406165;33336.3332733344;33528.664713352795;33547.66452335494;33582.83208583966;33613.6638633613;5154.92267615986;5285.841424757264;5300.363956325227;5336.893262134736;5354.384245811742;196276;196889;206125;207087;212959;53032.469675303524;53107.73446132822;53141.2028819568;53206.20190697143;53222;55032;55301.44698552963;55425;55442.44557554373;55505.44494555084;16078.75881861773;16180.595485112966;16182.352705891632;16189.757153642704;16322.102284374236;12970.935145324212;13087.803682944763;13096.803547946789;13101.868981310256;13122.737545249232;14466.855331446552;14612.634684132981;14755.55733328002;14763.114213147246;14866.925665371604;5338;5368.704721240291;5382.650127741685;5494.862628434241;5564.1931919871395;1115.910727141843;1130.7399298161304;1134.750354921916;1135.8182690769438;1149.1725957310723;26575.601365979524;26786.732132678815;26903.86548067247;33006.50490242648;33306.500402493984;1213.5691829400612;1219.3903048475763;1222.6943264183953;1227.1777908801125;1239.0645062977394;14084.929575352262;14250.786238206436;14331.140131592138;14505;14597.78103328451;258017;259719;259790;260037;260348;58241.41758582445;58348.416515835146;58391.70804145952;58404;58413.41586584165;1515.4089904937305;1559.844015598431;1562.3516240760184;1570.8900376973502;1593.3228377939329;25818.612720808826;26094.34764130836;26231.475370492866;26281;26365.60451593266;43237.56762432461;43295.35056974085;43367.34948975831;43401.56598433975;43433.26266949287;217617;217869;218033;219255;219566;33516.994490165336;33570.32859342849;36983.26033479369;37085.62914370822;37147.81426092852;47027.29459058048;47533.28700069433;47586.52413475821;48008.5199148004;48656.756716217606;35215.647843521234;35394.64605353914;35470.46794298139;35541;36051.819740901126;35042.29915401627;35302.117447063;35389;35694.82152589221;36113.097172570895;40662.593374067066;41223;41269.793651031556;41441.58558414377;41647.58352416437;33823;34286.82856585701;34385.312293753486;34413.65586344105;34838.47742283817;25996.74003259943;26035.609465858408;26071.217863464128;26179.607305890808;26971.46057078808 07:32:34 INFO - PID 5588 | |2;jquery.html;567.2314014510339;577.4514211499077;580.0805722929157;590.1708100119332;636.7357546618153;23981.640275395883;24712.752872471294;24912.252632421012;24921.376965575848;24934.37664058395;24046.879765601192;28406.857965710144;28473.288167795814;28546.28634284144;28744.425111497756;6545.050967609705;6688.73245070199;6697;6697.631630260334;6700.530962832604;6410.647414392207;6520.054592084145;6558.8688226235445;6560;6670.366315200048;6577.4080332770045;6623.9006414903815;6624.436922861562;6628.668566571676;6631.27056023837;6580.309067547886;6613.305602911697;6615;6620.768273110442;6626.867462650768;6138.9693051534905;6155.784547540859;6185.938140618581;6197.628142311431;6203.503719702413;30139.547906781416;31323;31831.36337273265;32081;32378.352432951207;2342.402687314741;2364.775346342095;2369.253685089209;2387.415083304584;2387.928362149138;20121.698174527395;20855.37433876971;20858.5828283435;20919.8954005229;20934.953252337473;2228.6322756745117;2266.943326416853;2280.372897453197;2290.8281878858984;2346.483773569812;157084;158957.20521397318;159812.20093899572;159939;160918;15606.765898511532;16423.507294781175;16510.504684859472;16891.493255202116;16929;25624;25632.35919102;25762.227133186036;25962.610560841604;25999.220023399328;10840.620578279722;10898.618548350929;10984.835227471594;11017.669469915916;11118;9915.30592858493;10017.949910250549;10026.69919902404;10117.645882394081;10169.745756356002;9601.855972160423;9994.300398972002;10118.494075296207;10200.23498237635;10230.897691023143;2843.8009339346463;2868.3259434032984;2922.0941508132546;2977.0919869439595;2982.8359440230997;1048.114343379843;1074.5379486820586;1074.940878251688;1077.4074259157433;1078.9406582637873;25718;27155.1853444397;27204;27813.721862781516;28025.299367515567;1128.7460321427777;1157.1726215755775;1171.6485054483621;1171.701216189866;1172.4430895324654;12285.201461904948;12645.87354126447;12656.303903285409;12680.175788573713;12690.873091269154;616705;637641;644851;676094;694952;136620;136784;138433;140033;148760;1326.635175326793;1363.4592910011622;1395.6859706565942;1399.8670126337981;1406.8522805105522;22694;22729.659055114516;22889.542209155392;23256.76743232546;23541;67861.66069169622;70773;71057.64471177611;71567.28432715606;72670.27329726635;89206;89286.55356723175;89662.55168724114;90319;92078.53960730153;15718.921405393357;15882.60293492672;15883.364665413254;15944.441944531885;16080.67838643244;24975.375615609755;25017.624735629342;25127.24618261455;25152.11967581126;25253.24240272795;19433.12550935183;19847.404577862686;20118.29585964484;20242.696359554913;20330;18481;18860.434186974413;19293.324733634254;19332.806671933664;19574.314898978468;21023.789762102795;21556.676649849953;21832;21880.343589692333;21899.890500548034;15839.920800395925;16141.59646008859;16187.75718364249;16242.918785405996;16277.267522961733;20323.491912702302;20399.4900127498;20646.483837903572;20780.27269045576;20814.479638009172 07:32:34 INFO - PID 5588 | |3;mootools.html;1436.9856301436985;1447.8841692664587;1487.7917091607171;1506.638406782372;1523.6724104317573;15508.302126404311;16005.679886402266;16101.677966440664;16159.353625854952;16165.595860103504;16228.10745409002;16323.510294691148;16383.262753176106;16398.180090995433;16416.507504774847;2941.352902361477;2946.6758656547763;3004.218903085192;3006.4588374092655;3007.7894547381693;2939.8089124206963;2981.075866481387;2997.310618557722;3046.086174147758;3052.465818481768;3024.516077427612;3027.31885325801;3029.803062800911;3039.3921215756827;3051.023672424825;2860.3850172213074;2926.1221633509863;2930.2674331417147;2931.516299810529;2945.911622651324;2852.885884564615;2863.2555535560905;2886.956695649567;2888.653361596601;2890.7253810887933;15539.378424862993;15877.126758028304;15958.601034974103;15960.521184364488;16015.35938562456;8388.328933685352;8589.699360522352;8627.352948528885;8637.265832404253;8642.092580279106;5567.359753628344;5798.333191682968;5861.677607731573;5937.614055086406;6057.242844644419;2022.3629556689743;2022.9393118206478;2024.4635171679517;2051.5178932950894;2067.8449116316337;27633.86183069092;27838.72161278402;27843.582346264822;27850.3037424064;27876.860615696995;7519.248075192547;7539.660715267826;7599.544027358376;7714.074311082706;7722.07335119778;18839.340623078126;18845;18854.05729713509;18879;18887.81112188888;8746.256568191648;8823.161799629024;8849.955750221208;8891.688790892287;8903.599338029804;8023.518588884685;8089.110197878229;8171.83656326882;8286.668533258602;8301.128381519975;5695.487406133468;5729.1119876419225;5766.596338256281;5782.624129431573;5811.878664287505;1535.961600959985;1576.7634854771875;1595.0429742154847;1701.5575950253024;1772.4682595221382;949.8717673114179;959.5825815770023;979.7606028374113;991.6628346362127;994.7910938702809;8644.913550864536;8718.520481373458;8761.948566172101;8852.911470885338;8885;1067.2635881241918;1071.5445935477392;1093.5455843727823;1093.748437859297;1101.1466113761899;5446.700431476228;5469.453054694499;5560.221568980346;5725.112607545837;5884.705764711833;22422.439439014157;23358.883205584203;23372.065117395454;23375.181868634518;23377.649335259986;21986.89006554957;22525;22804.42988925257;22820.885895570416;22923.541529169324;11907.166498345206;11979.161458697807;12658.367081645882;12818.458261375858;12881.09832311748;9066.546672666473;9360.625574977197;9463.716088517356;9495.47774872361;9677;19789.30737424183;20017.6997345037;20363.694544581547;20681.586368272852;20852.37442876716;20814.791852081285;20888.268910588056;21003.369898903056;21081;21290;13416.865831341562;13480.191188528719;13531.729365412833;13599.796003059764;13612.183269003495;14859.257037147883;14982.850171498145;15007.32467038964;15029.849701502844;15102.320395582445;11815.586454474053;11842.644720658394;11981.820272696092;12018.459169337226;12160.027197823976;11894.048476122063;12005.339706315886;12073.879261207276;12117.333546655018;12243.32661703615;10324.741881453023;10430.217733669853;10514.842277365693;10525.578976841147;10528.526216320131;7340.00757832609;7610.353119984642;7689.115751688628;7773.494722842997;8008.799780005314;8047.114817369968;8173.959130204311;8203.630836612487;8205.95897020511;8290.668373265002 07:32:34 INFO - PID 5588 | |4;prototype.html;543.6602123672704;544.9700266485344;561.6994907724368;569.2136989436707;575.922250496183;6218.129461875335;6293.150424692665;6293.4335909768115;6332.936670633292;6426.742930282789;5993.820185394434;6133.9079913801215;6139.6009259398215;6176.81469555914;6230.688465576714;4845.636577256702;4893.119238537062;4909.410870695504;4922.187839006559;4932.9753351233285;4793.568578827905;4863.465018847924;4876.707397556141;4912.754362281889;4922.21244600864;4838.782209830459;4838.9596236809075;4846.345743324641;4853.063896342697;4895.360054381768;4832.879178020543;4845.660803743739;4848.781804818792;4861;4907.141250281186;4437.977810110961;4452.888677783049;4483.125790470859;4512.729236245803;4517.683762136652;6190.845228869314;6232.968835155841;6241.375862413768;6259.155014073087;6275.372462753734;5822.82531524055;5827.213326200951;5847.7953271635715;5873.7944171954205;5958.225430694026;6598.670066496656;6663.433608143314;6677.432418244455;6692.297308782605;6695.2420918010475;5050.318207042039;5062.531865758925;5074.974625126888;5102.107131252016;5114.641975061747;6749.966250168816;6780.389764921131;6887.311268873123;6905.205901321362;6968.895466568006;5144.588432925357;5206.739663016834;5207.921881171786;5209.765560549784;5217.2695822584865;5187.870303242449;5244.239585260116;5278.419373868871;5295.364556253275;5320.76056577455;5861.1501332307425;5867.6772777497645;5895.734691938873;5905.261842269716;5907.852303692442;6512.381323774329;6596.96701516499;6599.53803233769;6622.496702242522;6736.326367363323;1775.6981313176532;1814.1201517264117;1815.7094864821565;1823.6079242962562;1847.8429333506801;1265.1586694848006;1274.222724138275;1285.13895689888;1304.9673758156123;1306.3794697518792;6306.463950564162;6310.1796766420075;6312.5581209314905;6342.619442833353;6386.818438588783;6717.059611654372;6738.663066846638;6752.122224110933;6753.358430949052;6790.354916282945;6079.908801367983;6292.2134733158355;6340.556161068773;6346.619202847844;6389.169407976933;3540.185757275841;3546.7339949503375;3582.3730847102174;3582.5880023797595;3585.6055833858254;6915.619640919697;6923.7576684816795;6929.133858267716;6937.549059311129;6989.091418115714;6981.581105133709;6991.405730512862;7011.579305241702;7014.403775679022;7015.684294206773;7027.789166325018;7028.894566581505;7060.6116663584;7061.9293807062295;7080;6766.560173588898;6790.913453847361;6800.591964482147;6809.21694005176;6848.623325717133;6642.4686025118845;6752.797416077526;6759.966200168968;6764.154480689914;6780.593164410151;6862;6903;6927.203371612329;6978.616176110159;6979.371856532936;5147.2499350219605;5192.610554208374;5222.477752224747;5227.18978558324;5254.9211761822835;6486.6756662167645;6653.900191497035;6724.260331363448;6864.84217260066;6880.621565813928;6445.645489497935;6545.476361890942;6562.146920900444;6608;6636.303188165173;6569.37590928861;6578.76974305897;6615.272320044695;6659.833504162435;6666.200055993312;6467.385598368148;6652.667366631746;6653.201615806134;6668.966655166693;6698.162729658793;6629;6637.369449902251;6652.600843949379;6709.396154346132;6709.429698475684;6411;6483.189601299838;6512.120863683532;6533.150690410406;6558.213014438298 07:32:34 INFO - PID 5588 | |5;yui.html;890.7372325164076;911.9270458363329;965.5172413793103;970.4225985538607;991.1872264742914;18593.90703046483;19440;20408.795912040874;20426.489337766525;20439.284625038108;18826;19379.418617441464;22943.770562294372;22952.196673116443;23071.077156913703;1058.5606973106171;1081.0162751895778;1081.4322480697658;1081.8323159910226;1085.5766251162054;1089.2103225161773;1090.0353187429143;1090.3185509056839;1090.7709381029993;1099.4118146791468;1088.4612117002096;1116.3190453823202;1121.2935850414228;1123.404595564348;1125.9042981346595;1104.0229396983648;1105.1987309200845;1107.3134656512932;1111.2443538393889;1117.6032508459502;808.6926967752275;811.5049819610033;811.7158994351988;813.9755807325789;816.4040250617082;19763.209471621118;20694.379168624964;20786.48033799152;21061.78938210629;21078.367648970554;20893.582128357346;20990.685139722915;21115.15539378423;21368.20744980528;21681;15192.46826361072;15639.843601564065;15680.372785088583;15850;15888.602784930354;3675.4854320395166;3694.7783133012103;3697.2975134724315;3700.4264339027495;3702.9629703702885;144166;144222;144388;144929;146642;16267.51197464078;16658.250378732744;16734.4142954996;16832.410865619644;16858.831411685725;30706.925257615876;32051.878184263438;32341.676583234337;32412.189695257806;32415.675843241737;9640.75898102553;9907;9942.850857237147;10049.346792458467;10068.647597334204;4722.787474563653;4857.077155340474;4921.803127874917;4935.481774413706;4939.925901111486;5801.3328467225965;5916.645001299936;5931.466168044896;5952.940470595326;5969.2240008799445;1185.9339967745761;1210.2556927489532;1217.4034722985673;1237.2638280223252;1239.8078297863844;758.2682711183734;761.5316580303074;773.2847116417291;775.5036776463069;781.7146741439334;12847.807282890764;13523.188608683511;14082.577522674335;14094.647633809032;14116.858831411555;702.9964850175717;710.3713213805819;712.5546533416615;724.6811402982671;725.2384995754437;6825.761098361533;6958.199807022156;7032.718691252293;7114.14630244374;7229.2770722928335;122933.46799394049;123822;124271.37864310801;124798.37600811938;130634.34682826525;112537;114806;114948;116747.41626291814;117235.41382293034;97944.51027744958;98608;102517.48741256246;102762;103034;13216.530374413564;13398.330083495981;14069.929650351683;14108.576742697736;14256.501022464165;48007.03985920192;48315.75842120767;48389;48828;49413;81315;87294.1270587286;87908.56045719731;89520.5523972402;90505;20827.791722082584;21746.67379989333;21771.782282176977;21990.670139948234;22013.889930550245;22086;23236.883815581492;23414;24025.27924162278;24212.031518739757;18929.053547322856;19085.713714294576;20852.47868803292;22517.66223506616;22770.43073923165;21637.783622164206;21711.782882171607;21986.560268794856;22153.113875445448;22187.334379968626;20449.89775051115;21086.261980830597;21402.357929262147;21609.675854862504;21648.567028659654;14768.852311476749;15023.774643380139;15590.454334098253;15747.842521574637;15845.52463426099;15810;16443.917780411022;16713.832861671228;16743.497695069167;16865.831341686426 07:32:34 INFO - PID 5588 | __end_tp_report 07:32:34 INFO - PID 5588 | __start_cc_report 07:32:34 INFO - PID 5588 | _x_x_mozilla_cycle_collect,293 07:32:34 INFO - PID 5588 | __end_cc_report 07:32:34 INFO - PID 5588 | __startTimestamp1503066754043__endTimestamp 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | ------- Summary: start ------- 07:32:34 INFO - PID 5588 | Number of tests: 6 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | [#0] dojo.html Cycles:165 Average:6417.83 Median:6727.46 stddev:807.82 (12.0%) stddev-sans-first:779.40 07:32:34 INFO - PID 5588 | Values: 3597.2 3618.8 3628.8 3660.1 3662.7 6458.0 6475.8 6492.0 6526.2 6541.8 6461.8 6472.4 6527.7 6547.3 6553.9 5607.0 5640.7 5655.6 5697.9 5709.3 5663.4 5695.5 5699.3 5744.5 5767.4 5581.7 5634.5 5663.0 5705.5 5722.3 5645.0 5645.7 5665.7 5694.5 5695.3 5598.5 5624.1 5671.0 5706.6 5720.1 6342.8 6396.8 6417.1 6427.1 6437.3 6944.9 6947.6 7012.8 7024.9 7030.0 6901.7 6949.9 7017.9 7034.6 7110.0 6457.5 6516.0 6518.8 6532.1 6551.0 7193.3 7248.5 7257.0 7270.2 7280.2 6779.4 6845.9 6917.9 6931.7 6933.7 6911.6 6921.2 6929.8 6943.9 7000.7 6959.0 6963.3 6965.7 6983.0 7001.5 6852.9 6861.5 6947.9 6950.8 6956.7 5028.1 5101.1 5121.8 5179.5 5191.3 4524.6 4573.6 4588.1 4593.5 4634.1 6625.8 6637.0 6655.9 6711.5 6718.1 6995.9 6995.9 7007.1 7077.2 7096.0 6586.7 6597.2 6599.4 6677.2 6677.5 5849.9 5870.7 5873.3 5908.0 5908.6 7023.7 7069.7 7095.7 7149.1 7164.9 6899.3 6940.0 6952.5 6976.9 6978.0 7123.1 7245.1 7248.0 7270.9 7294.8 6800.7 6888.5 6895.7 6926.5 6931.5 6935.4 6945.2 6951.5 6956.2 7041.9 6727.5 6738.7 6812.4 6836.0 6840.4 6733.3 6736.8 6751.7 6876.4 6883.6 6703.7 6716.0 6790.5 6804.7 6807.5 6799.2 6803.6 6856.8 6879.9 6886.0 6580.9 6634.8 6657.0 6657.4 6661.7 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | [#1] ext.html Cycles:180 Average:41286.54 Median:3804.79 stddev:59290.47 (1558.3%) stddev-sans-first:59379.21 07:32:34 INFO - PID 5588 | Values: 889.7 902.2 923.1 925.0 944.0 43646.8 43843.8 44397.1 44404.0 44596.0 44715.9 45144.8 45291.3 45322.3 45334.5 7871.4 7988.0 8008.1 8012.3 8037.1 7913.0 7997.0 8021.6 8036.1 8043.6 8005.3 8045.0 8061.2 8061.6 8062.0 8003.4 8032.1 8032.6 8039.4 8039.4 7836.9 7906.8 7913.4 7936.5 7939.0 41635.4 41743.8 41938.6 41976.0 42206.8 3776.2 3833.3 3833.8 3835.4 3840.6 33336.3 33528.7 33547.7 33582.8 33613.7 5154.9 5285.8 5300.4 5336.9 5354.4 196276.0 196889.0 206125.0 207087.0 212959.0 53032.5 53107.7 53141.2 53206.2 53222.0 55032.0 55301.4 55425.0 55442.4 55505.4 16078.8 16180.6 16182.4 16189.8 16322.1 12970.9 13087.8 13096.8 13101.9 13122.7 14466.9 14612.6 14755.6 14763.1 14866.9 5338.0 5368.7 5382.7 5494.9 5564.2 1115.9 1130.7 1134.8 1135.8 1149.2 26575.6 26786.7 26903.9 33006.5 33306.5 1213.6 1219.4 1222.7 1227.2 1239.1 14084.9 14250.8 14331.1 14505.0 14597.8 258017.0 259719.0 259790.0 260037.0 260348.0 58241.4 58348.4 58391.7 58404.0 58413.4 1515.4 1559.8 1562.4 1570.9 1593.3 25818.6 26094.3 26231.5 26281.0 26365.6 43237.6 43295.4 43367.3 43401.6 43433.3 217617.0 217869.0 218033.0 219255.0 219566.0 33517.0 33570.3 36983.3 37085.6 37147.8 47027.3 47533.3 47586.5 48008.5 48656.8 35215.6 35394.6 35470.5 35541.0 36051.8 35042.3 35302.1 35389.0 35694.8 36113.1 40662.6 41223.0 41269.8 41441.6 41647.6 33823.0 34286.8 34385.3 34413.7 34838.5 25996.7 26035.6 26071.2 26179.6 26971.5 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | [#2] jquery.html Cycles:180 Average:42722.76 Median:2344.44 stddev:109539.79 (4672.3%) stddev-sans-first:109801.35 07:32:34 INFO - PID 5588 | Values: 567.2 577.5 580.1 590.2 636.7 23981.6 24712.8 24912.3 24921.4 24934.4 24046.9 28406.9 28473.3 28546.3 28744.4 6545.1 6688.7 6697.0 6697.6 6700.5 6410.6 6520.1 6558.9 6560.0 6670.4 6577.4 6623.9 6624.4 6628.7 6631.3 6580.3 6613.3 6615.0 6620.8 6626.9 6139.0 6155.8 6185.9 6197.6 6203.5 30139.5 31323.0 31831.4 32081.0 32378.4 2342.4 2364.8 2369.3 2387.4 2387.9 20121.7 20855.4 20858.6 20919.9 20935.0 2228.6 2266.9 2280.4 2290.8 2346.5 157084.0 158957.2 159812.2 159939.0 160918.0 15606.8 16423.5 16510.5 16891.5 16929.0 25624.0 25632.4 25762.2 25962.6 25999.2 10840.6 10898.6 10984.8 11017.7 11118.0 9915.3 10017.9 10026.7 10117.6 10169.7 9601.9 9994.3 10118.5 10200.2 10230.9 2843.8 2868.3 2922.1 2977.1 2982.8 1048.1 1074.5 1074.9 1077.4 1078.9 25718.0 27155.2 27204.0 27813.7 28025.3 1128.7 1157.2 1171.6 1171.7 1172.4 12285.2 12645.9 12656.3 12680.2 12690.9 616705.0 637641.0 644851.0 676094.0 694952.0 136620.0 136784.0 138433.0 140033.0 148760.0 1326.6 1363.5 1395.7 1399.9 1406.9 22694.0 22729.7 22889.5 23256.8 23541.0 67861.7 70773.0 71057.6 71567.3 72670.3 89206.0 89286.6 89662.6 90319.0 92078.5 15718.9 15882.6 15883.4 15944.4 16080.7 24975.4 25017.6 25127.2 25152.1 25253.2 19433.1 19847.4 20118.3 20242.7 20330.0 18481.0 18860.4 19293.3 19332.8 19574.3 21023.8 21556.7 21832.0 21880.3 21899.9 15839.9 16141.6 16187.8 16242.9 16277.3 20323.5 20399.5 20646.5 20780.3 20814.5 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | [#3] mootools.html Cycles:180 Average:10111.45 Median:27736.29 stddev:7113.39 (25.6%) stddev-sans-first:7103.48 07:32:34 INFO - PID 5588 | Values: 1437.0 1447.9 1487.8 1506.6 1523.7 15508.3 16005.7 16101.7 16159.4 16165.6 16228.1 16323.5 16383.3 16398.2 16416.5 2941.4 2946.7 3004.2 3006.5 3007.8 2939.8 2981.1 2997.3 3046.1 3052.5 3024.5 3027.3 3029.8 3039.4 3051.0 2860.4 2926.1 2930.3 2931.5 2945.9 2852.9 2863.3 2887.0 2888.7 2890.7 15539.4 15877.1 15958.6 15960.5 16015.4 8388.3 8589.7 8627.4 8637.3 8642.1 5567.4 5798.3 5861.7 5937.6 6057.2 2022.4 2022.9 2024.5 2051.5 2067.8 27633.9 27838.7 27843.6 27850.3 27876.9 7519.2 7539.7 7599.5 7714.1 7722.1 18839.3 18845.0 18854.1 18879.0 18887.8 8746.3 8823.2 8850.0 8891.7 8903.6 8023.5 8089.1 8171.8 8286.7 8301.1 5695.5 5729.1 5766.6 5782.6 5811.9 1536.0 1576.8 1595.0 1701.6 1772.5 949.9 959.6 979.8 991.7 994.8 8644.9 8718.5 8761.9 8852.9 8885.0 1067.3 1071.5 1093.5 1093.7 1101.1 5446.7 5469.5 5560.2 5725.1 5884.7 22422.4 23358.9 23372.1 23375.2 23377.6 21986.9 22525.0 22804.4 22820.9 22923.5 11907.2 11979.2 12658.4 12818.5 12881.1 9066.5 9360.6 9463.7 9495.5 9677.0 19789.3 20017.7 20363.7 20681.6 20852.4 20814.8 20888.3 21003.4 21081.0 21290.0 13416.9 13480.2 13531.7 13599.8 13612.2 14859.3 14982.9 15007.3 15029.8 15102.3 11815.6 11842.6 11981.8 12018.5 12160.0 11894.0 12005.3 12073.9 12117.3 12243.3 10324.7 10430.2 10514.8 10525.6 10528.5 7340.0 7610.4 7689.1 7773.5 8008.8 8047.1 8174.0 8203.6 8206.0 8290.7 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | [#4] prototype.html Cycles:180 Average:5640.62 Median:6308.32 stddev:1590.97 (25.2%) stddev-sans-first:1548.76 07:32:34 INFO - PID 5588 | Values: 543.7 545.0 561.7 569.2 575.9 6218.1 6293.2 6293.4 6332.9 6426.7 5993.8 6133.9 6139.6 6176.8 6230.7 4845.6 4893.1 4909.4 4922.2 4933.0 4793.6 4863.5 4876.7 4912.8 4922.2 4838.8 4839.0 4846.3 4853.1 4895.4 4832.9 4845.7 4848.8 4861.0 4907.1 4438.0 4452.9 4483.1 4512.7 4517.7 6190.8 6233.0 6241.4 6259.2 6275.4 5822.8 5827.2 5847.8 5873.8 5958.2 6598.7 6663.4 6677.4 6692.3 6695.2 5050.3 5062.5 5075.0 5102.1 5114.6 6750.0 6780.4 6887.3 6905.2 6968.9 5144.6 5206.7 5207.9 5209.8 5217.3 5187.9 5244.2 5278.4 5295.4 5320.8 5861.2 5867.7 5895.7 5905.3 5907.9 6512.4 6597.0 6599.5 6622.5 6736.3 1775.7 1814.1 1815.7 1823.6 1847.8 1265.2 1274.2 1285.1 1305.0 1306.4 6306.5 6310.2 6312.6 6342.6 6386.8 6717.1 6738.7 6752.1 6753.4 6790.4 6079.9 6292.2 6340.6 6346.6 6389.2 3540.2 3546.7 3582.4 3582.6 3585.6 6915.6 6923.8 6929.1 6937.5 6989.1 6981.6 6991.4 7011.6 7014.4 7015.7 7027.8 7028.9 7060.6 7061.9 7080.0 6766.6 6790.9 6800.6 6809.2 6848.6 6642.5 6752.8 6760.0 6764.2 6780.6 6862.0 6903.0 6927.2 6978.6 6979.4 5147.2 5192.6 5222.5 5227.2 5254.9 6486.7 6653.9 6724.3 6864.8 6880.6 6445.6 6545.5 6562.1 6608.0 6636.3 6569.4 6578.8 6615.3 6659.8 6666.2 6467.4 6652.7 6653.2 6669.0 6698.2 6629.0 6637.4 6652.6 6709.4 6709.4 6411.0 6483.2 6512.1 6533.2 6558.2 07:32:34 INFO - PID 5588 | 07:32:34 INFO - PID 5588 | [#5] yui.html Cycles:180 Average:27183.20 Median:20942.13 stddev:37506.68 (179.1%) stddev-sans-first:37559.94 07:32:34 INFO - PID 5588 | Values: 890.7 911.9 965.5 970.4 991.2 18593.9 19440.0 20408.8 20426.5 20439.3 18826.0 19379.4 22943.8 22952.2 23071.1 1058.6 1081.0 1081.4 1081.8 1085.6 1089.2 1090.0 1090.3 1090.8 1099.4 1088.5 1116.3 1121.3 1123.4 1125.9 1104.0 1105.2 1107.3 1111.2 1117.6 808.7 811.5 811.7 814.0 816.4 19763.2 20694.4 20786.5 21061.8 21078.4 20893.6 20990.7 21115.2 21368.2 21681.0 15192.5 15639.8 15680.4 15850.0 15888.6 3675.5 3694.8 3697.3 3700.4 3703.0 144166.0 144222.0 144388.0 144929.0 146642.0 16267.5 16658.3 16734.4 16832.4 16858.8 30706.9 32051.9 32341.7 32412.2 32415.7 9640.8 9907.0 9942.9 10049.3 10068.6 4722.8 4857.1 4921.8 4935.5 4939.9 5801.3 5916.6 5931.5 5952.9 5969.2 1185.9 1210.3 1217.4 1237.3 1239.8 758.3 761.5 773.3 775.5 781.7 12847.8 13523.2 14082.6 14094.6 14116.9 703.0 710.4 712.6 724.7 725.2 6825.8 6958.2 7032.7 7114.1 7229.3 122933.5 123822.0 124271.4 124798.4 130634.3 112537.0 114806.0 114948.0 116747.4 117235.4 97944.5 98608.0 102517.5 102762.0 103034.0 13216.5 13398.3 14069.9 14108.6 14256.5 48007.0 48315.8 48389.0 48828.0 49413.0 81315.0 87294.1 87908.6 89520.6 90505.0 20827.8 21746.7 21771.8 21990.7 22013.9 22086.0 23236.9 23414.0 24025.3 24212.0 18929.1 19085.7 20852.5 22517.7 22770.4 21637.8 21711.8 21986.6 22153.1 22187.3 20449.9 21086.3 21402.4 21609.7 21648.6 14768.9 15023.8 15590.5 15747.8 15845.5 15810.0 16443.9 16713.8 16743.5 16865.8 07:32:34 INFO - PID 5588 | -------- Summary: end -------- 07:32:34 INFO - PID 5588 | 07:32:34 INFO - TEST-INFO | 5588: exit 0 07:32:34 INFO - TEST-OK | dromaeo_css | took 1109324ms 07:32:34 INFO - TEST-START | kraken 07:32:34 INFO - Initialising browser for kraken test... 07:32:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53581/getInfo.html -profile /tmp/tmpEXpaVa/profile 07:32:34 INFO - TEST-INFO | started process 5952 (/builds/slave/test/build/application/firefox/firefox http://localhost:53581/getInfo.html) 07:32:40 INFO - TEST-INFO | 5952: exit 0 07:32:40 INFO - Browser initialized. 07:32:40 INFO - Running cycle 1/1 for kraken test... 07:32:40 INFO - TEST-INFO | started process 6115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEXpaVa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:40 INFO - PID 6115 | 1503066760733 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 07:32:51 INFO - PID 6115 | RSS: Main: 154431488 07:32:51 INFO - PID 6115 | 07:32:54 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53581/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:54 INFO - PID 6115 | RSS: Main: 161579008 07:32:54 INFO - PID 6115 | 07:32:57 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53581/tests/kraken/driver.html?testName=audio-dft) 07:32:58 INFO - PID 6115 | RSS: Main: 161128448 07:32:58 INFO - PID 6115 | 07:33:01 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53581/tests/kraken/driver.html?testName=audio-fft) 07:33:01 INFO - PID 6115 | RSS: Main: 161554432 07:33:01 INFO - PID 6115 | 07:33:03 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53581/tests/kraken/driver.html?testName=audio-oscillator) 07:33:04 INFO - PID 6115 | RSS: Main: 161386496 07:33:04 INFO - PID 6115 | 07:33:06 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:07 INFO - PID 6115 | RSS: Main: 161259520 07:33:07 INFO - PID 6115 | 07:33:10 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53581/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:10 INFO - PID 6115 | RSS: Main: 161538048 07:33:10 INFO - PID 6115 | 07:33:14 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53581/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:14 INFO - PID 6115 | RSS: Main: 164487168 07:33:14 INFO - PID 6115 | 07:33:17 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53581/tests/kraken/driver.html?testName=json-parse-financial) 07:33:18 INFO - PID 6115 | RSS: Main: 165408768 07:33:18 INFO - PID 6115 | 07:33:19 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:20 INFO - PID 6115 | RSS: Main: 164720640 07:33:20 INFO - PID 6115 | 07:33:21 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:22 INFO - PID 6115 | RSS: Main: 164610048 07:33:22 INFO - PID 6115 | 07:33:24 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:25 INFO - PID 6115 | RSS: Main: 161886208 07:33:25 INFO - PID 6115 | 07:33:27 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:28 INFO - PID 6115 | RSS: Main: 161910784 07:33:28 INFO - PID 6115 | 07:33:31 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:31 INFO - PID 6115 | RSS: Main: 162586624 07:33:31 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | Cycle 1(1): loaded http://localhost:53581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53581/tests/kraken/driver.html?testName=ai-astar) 07:33:33 INFO - PID 6115 | RSS: Main: 164524032 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | __start_tp_report 07:33:33 INFO - PID 6115 | _x_x_mozilla_page_load 07:33:33 INFO - PID 6115 | _x_x_mozilla_page_load_details 07:33:33 INFO - PID 6115 | |i|pagename|runs| 07:33:33 INFO - PID 6115 | |0;ai-astar;98;114;99;105;106;107;109;97;106;107 07:33:33 INFO - PID 6115 | |1;audio-beat-detection;136;112;148;163;115;144;138;117;161;114 07:33:33 INFO - PID 6115 | |2;audio-dft;162;162;163;161;163;162;159;161;161;163 07:33:33 INFO - PID 6115 | |3;audio-fft;74;75;75;188;75;75;77;74;158;78 07:33:33 INFO - PID 6115 | |4;audio-oscillator;78;78;126;77;77;78;123;78;78;132 07:33:33 INFO - PID 6115 | |5;imaging-gaussian-blur;114;114;114;113;113;114;114;113;114;113 07:33:33 INFO - PID 6115 | |6;imaging-darkroom;147;147;148;147;147;146;148;148;149;148 07:33:33 INFO - PID 6115 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;94;93 07:33:33 INFO - PID 6115 | |8;json-parse-financial;46;50;45;46;47;49;47;46;45;46 07:33:33 INFO - PID 6115 | |9;json-stringify-tinderbox;53;53;52;53;52;53;53;53;53;52 07:33:33 INFO - PID 6115 | |10;stanford-crypto-aes;74;74;75;73;78;73;72;82;78;73 07:33:33 INFO - PID 6115 | |11;stanford-crypto-ccm;124;120;124;122;112;115;116;113;123;143 07:33:33 INFO - PID 6115 | |12;stanford-crypto-pbkdf2;165;160;163;157;160;159;161;163;168;168 07:33:33 INFO - PID 6115 | |13;stanford-crypto-sha256-iterative;58;61;59;60;58;67;58;58;58;59 07:33:33 INFO - PID 6115 | __end_tp_report 07:33:33 INFO - PID 6115 | __start_cc_report 07:33:33 INFO - PID 6115 | _x_x_mozilla_cycle_collect,802 07:33:33 INFO - PID 6115 | __end_cc_report 07:33:33 INFO - PID 6115 | __startTimestamp1503066813742__endTimestamp 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | ------- Summary: start ------- 07:33:33 INFO - PID 6115 | Number of tests: 14 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#0] ai-astar Cycles:10 Average:104.80 Median:111.50 stddev:5.33 (4.8%) stddev-sans-first:5.05 07:33:33 INFO - PID 6115 | Values: 98.0 114.0 99.0 105.0 106.0 107.0 109.0 97.0 106.0 107.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:141.00 stddev:19.48 (13.8%) stddev-sans-first:20.65 07:33:33 INFO - PID 6115 | Values: 136.0 112.0 148.0 163.0 115.0 144.0 138.0 117.0 161.0 114.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 07:33:33 INFO - PID 6115 | Values: 162.0 162.0 163.0 161.0 163.0 162.0 159.0 161.0 161.0 163.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.00 stddev:41.78 (55.7%) stddev-sans-first:43.63 07:33:33 INFO - PID 6115 | Values: 74.0 75.0 75.0 188.0 75.0 75.0 77.0 74.0 158.0 78.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:78.00 stddev:23.91 (30.7%) stddev-sans-first:24.78 07:33:33 INFO - PID 6115 | Values: 78.0 78.0 126.0 77.0 77.0 78.0 123.0 78.0 78.0 132.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:33:33 INFO - PID 6115 | Values: 114.0 114.0 114.0 113.0 113.0 114.0 114.0 113.0 114.0 113.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 07:33:33 INFO - PID 6115 | Values: 147.0 147.0 148.0 147.0 147.0 146.0 148.0 148.0 149.0 148.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:33:33 INFO - PID 6115 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:46.50 stddev:1.64 (3.5%) stddev-sans-first:1.72 07:33:33 INFO - PID 6115 | Values: 46.0 50.0 45.0 46.0 47.0 49.0 47.0 46.0 45.0 46.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#9] json-stringify-tinderbox Cycles:10 Average:52.70 Median:53.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:33:33 INFO - PID 6115 | Values: 53.0 53.0 52.0 53.0 52.0 53.0 53.0 53.0 53.0 52.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:74.50 stddev:3.16 (4.2%) stddev-sans-first:3.32 07:33:33 INFO - PID 6115 | Values: 74.0 74.0 75.0 73.0 78.0 73.0 72.0 82.0 78.0 73.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.50 stddev:8.90 (7.3%) stddev-sans-first:9.39 07:33:33 INFO - PID 6115 | Values: 124.0 120.0 124.0 122.0 112.0 115.0 116.0 113.0 123.0 143.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:3.72 (2.3%) stddev-sans-first:3.82 07:33:33 INFO - PID 6115 | Values: 165.0 160.0 163.0 157.0 160.0 159.0 161.0 163.0 168.0 168.0 07:33:33 INFO - PID 6115 | 07:33:33 INFO - PID 6115 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.00 stddev:2.80 (4.7%) stddev-sans-first:2.91 07:33:33 INFO - PID 6115 | Values: 58.0 61.0 59.0 60.0 58.0 67.0 58.0 58.0 58.0 59.0 07:33:33 INFO - PID 6115 | -------- Summary: end -------- 07:33:33 INFO - PID 6115 | 07:33:34 INFO - PID 6115 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:33:34 INFO - TEST-INFO | 6115: exit 0 07:33:34 INFO - TEST-OK | kraken | took 59742ms 07:33:34 INFO - SUITE-END | took 1169s 07:33:34 INFO - Completed test suite (00:19:29) 07:33:34 INFO - javascript benchmark 07:33:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9192.570628861782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3597.1906321077777, 3618.819059047047, 3628.782273063618, 3660.1032746976985, 3662.7069834413232, 6457.967710161454, 6475.838104047401, 6491.967540162298, 6526.151600291967, 6541.803745887625, 6461.8061458156335, 6472.352764723525, 6527.673616319189, 6547.279799222082, 6553.90169147462, 5606.971965140168, 5640.717964101799, 5655.57583181261, 5697.886042279152, 5709.31488221414, 5663.377028526858, 5695.45893140151, 5699.2590963174725, 5744.540436765049, 5767.365589785141, 5581.720913954286, 5634.492895639371, 5663.008973429633, 5705.51503122233, 5722.2561067061015, 5645.01212287848, 5645.689487078209, 5665.745041473144, 5694.487496125369, 5695.316562012544, 5598.468145526209, 5624.100143976985, 5671.007573674632, 5706.572007099443, 5720.11338242573, 6342.841428964312, 6396.808095757135, 6417.133686952248, 6427.100205971121, 6437.2918978912285, 6944.930550694479, 6947.5831450113155, 7012.754553590651, 7024.894626580605, 7030.0, 6901.654917254167, 6949.89575156373, 7017.859642807166, 7034.5779253244455, 7110.0, 6457.483401327882, 6515.967420162869, 6518.804435866931, 6532.118164047888, 6550.967245163839, 7193.3166349196745, 7248.492605517668, 7257.020302259233, 7270.200277969419, 7280.199178090405, 6779.389854913082, 6845.863082738318, 6917.861642767117, 6931.653417329113, 6933.722651094001, 6911.619860907698, 6921.238663746984, 6929.79210623672, 6943.930560694429, 7000.719971201197, 6959.0, 6963.338482844122, 6965.686544105527, 6982.965085174542, 7001.50989430735, 6852.862942741117, 6861.519693621399, 6947.89578156328, 6950.826229344307, 6956.721731130698, 5028.120078986163, 5101.056304583664, 5121.769520371592, 5179.48205179479, 5191.32512773337, 4524.5701658342405, 4573.565511276423, 4588.059447813191, 4593.517680643551, 4634.050019745944, 6625.834354141185, 6637.037629543689, 6655.86688266232, 6711.530192886451, 6718.05947167397, 6995.8600827983155, 6995.8950615740805, 7007.089078419773, 7077.1507419109, 7096.0420343253, 6586.736530538725, 6597.175353080865, 6599.373059559334, 6677.165354330708, 6677.53257271996, 5849.941500585025, 5870.677112758839, 5873.2658417697785, 5907.970460147758, 5908.615939963888, 7023.68393422287, 7069.681864316118, 7095.680694368766, 7149.0706208192605, 7164.856702865914, 6899.275576064641, 6940.028396024662, 6952.513324067267, 6976.895346569704, 6977.965110174417, 7123.074000379917, 7245.094363204599, 7247.9637601811655, 7270.854582908418, 7294.817629559304, 6800.659967001531, 6888.483363747639, 6895.724171033103, 6926.480513961574, 6931.549449285781, 6935.410490108397, 6945.201301850352, 6951.548149370275, 6956.165260168812, 7041.929580704127, 6727.461803055646, 6738.663066846736, 6812.420944219797, 6835.965820170867, 6840.384365407137, 6733.293004234485, 6736.7642132525125, 6751.662416879039, 6876.415504682158, 6883.621400823003, 6703.698333575098, 6716.0, 6790.490713196431, 6804.727810887509, 6807.455403567802, 6799.218089919723, 6803.557768745016, 6856.828579285558, 6879.931200687929, 6886.035954966209, 6580.934190658032, 6634.767783127568, 6657.034729964032, 6657.434118100015, 6661.666916654245], "value": 6357.367931748089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.6762129711641, 902.170018308456, 923.113810741688, 924.9630014799408, 944.0135058863488, 43646.781766091204, 43843.78078109609, 44397.112057758866, 44404.0, 44596.0, 44715.88210294744, 45144.77427612866, 45291.320630190574, 45322.32016519747, 45334.54665453353, 7871.409644276673, 7988.0, 8008.079070906862, 8012.3189528889825, 8037.075736290314, 7913.0, 7997.04035515736, 8021.598920054003, 8036.116027236999, 8043.638036288381, 8005.3195478384405, 8044.959775201116, 8061.193880611951, 8061.556614386206, 8062.032556093277, 8003.399745019147, 8032.1164671886045, 8032.558209298486, 8039.397045221632, 8039.397045221632, 7836.882446763303, 7906.7627971160955, 7913.366930645535, 7936.484128531627, 7938.960305198437, 41635.37546936768, 41743.791281043705, 41938.58061419408, 41976.0, 42206.78896605528, 3776.2447510497736, 3833.3291673956946, 3833.7891415972113, 3835.42468629705, 3840.615938406165, 33336.3332733344, 33528.664713352795, 33547.66452335494, 33582.83208583966, 33613.6638633613, 5154.92267615986, 5285.841424757264, 5300.363956325227, 5336.893262134736, 5354.384245811742, 196276.0, 196889.0, 206125.0, 207087.0, 212959.0, 53032.469675303524, 53107.73446132822, 53141.2028819568, 53206.20190697143, 53222.0, 55032.0, 55301.44698552963, 55425.0, 55442.44557554373, 55505.44494555084, 16078.75881861773, 16180.595485112966, 16182.352705891632, 16189.757153642704, 16322.102284374236, 12970.935145324212, 13087.803682944763, 13096.803547946789, 13101.868981310256, 13122.737545249232, 14466.855331446552, 14612.634684132981, 14755.55733328002, 14763.114213147246, 14866.925665371604, 5338.0, 5368.704721240291, 5382.650127741685, 5494.862628434241, 5564.1931919871395, 1115.910727141843, 1130.7399298161304, 1134.750354921916, 1135.8182690769438, 1149.1725957310723, 26575.601365979524, 26786.732132678815, 26903.86548067247, 33006.50490242648, 33306.500402493984, 1213.5691829400612, 1219.3903048475763, 1222.6943264183953, 1227.1777908801125, 1239.0645062977394, 14084.929575352262, 14250.786238206436, 14331.140131592138, 14505.0, 14597.78103328451, 258017.0, 259719.0, 259790.0, 260037.0, 260348.0, 58241.41758582445, 58348.416515835146, 58391.70804145952, 58404.0, 58413.41586584165, 1515.4089904937305, 1559.844015598431, 1562.3516240760184, 1570.8900376973502, 1593.3228377939329, 25818.612720808826, 26094.34764130836, 26231.475370492866, 26281.0, 26365.60451593266, 43237.56762432461, 43295.35056974085, 43367.34948975831, 43401.56598433975, 43433.26266949287, 217617.0, 217869.0, 218033.0, 219255.0, 219566.0, 33516.994490165336, 33570.32859342849, 36983.26033479369, 37085.62914370822, 37147.81426092852, 47027.29459058048, 47533.28700069433, 47586.52413475821, 48008.5199148004, 48656.756716217606, 35215.647843521234, 35394.64605353914, 35470.46794298139, 35541.0, 36051.819740901126, 35042.29915401627, 35302.117447063, 35389.0, 35694.82152589221, 36113.097172570895, 40662.593374067066, 41223.0, 41269.793651031556, 41441.58558414377, 41647.58352416437, 33823.0, 34286.82856585701, 34385.312293753486, 34413.65586344105, 34838.47742283817, 25996.74003259943, 26035.609465858408, 26071.217863464128, 26179.607305890808, 26971.46057078808], "value": 18564.69564255793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2314014510339, 577.4514211499077, 580.0805722929157, 590.1708100119332, 636.7357546618153, 23981.640275395883, 24712.752872471294, 24912.252632421012, 24921.376965575848, 24934.37664058395, 24046.879765601192, 28406.857965710144, 28473.288167795814, 28546.28634284144, 28744.425111497756, 6545.050967609705, 6688.73245070199, 6697.0, 6697.631630260334, 6700.530962832604, 6410.647414392207, 6520.054592084145, 6558.8688226235445, 6560.0, 6670.366315200048, 6577.4080332770045, 6623.9006414903815, 6624.436922861562, 6628.668566571676, 6631.27056023837, 6580.309067547886, 6613.305602911697, 6615.0, 6620.768273110442, 6626.867462650768, 6138.9693051534905, 6155.784547540859, 6185.938140618581, 6197.628142311431, 6203.503719702413, 30139.547906781416, 31323.0, 31831.36337273265, 32081.0, 32378.352432951207, 2342.402687314741, 2364.775346342095, 2369.253685089209, 2387.415083304584, 2387.928362149138, 20121.698174527395, 20855.37433876971, 20858.5828283435, 20919.8954005229, 20934.953252337473, 2228.6322756745117, 2266.943326416853, 2280.372897453197, 2290.8281878858984, 2346.483773569812, 157084.0, 158957.20521397318, 159812.20093899572, 159939.0, 160918.0, 15606.765898511532, 16423.507294781175, 16510.504684859472, 16891.493255202116, 16929.0, 25624.0, 25632.35919102, 25762.227133186036, 25962.610560841604, 25999.220023399328, 10840.620578279722, 10898.618548350929, 10984.835227471594, 11017.669469915916, 11118.0, 9915.30592858493, 10017.949910250549, 10026.69919902404, 10117.645882394081, 10169.745756356002, 9601.855972160423, 9994.300398972002, 10118.494075296207, 10200.23498237635, 10230.897691023143, 2843.8009339346463, 2868.3259434032984, 2922.0941508132546, 2977.0919869439595, 2982.8359440230997, 1048.114343379843, 1074.5379486820586, 1074.940878251688, 1077.4074259157433, 1078.9406582637873, 25718.0, 27155.1853444397, 27204.0, 27813.721862781516, 28025.299367515567, 1128.7460321427777, 1157.1726215755775, 1171.6485054483621, 1171.701216189866, 1172.4430895324654, 12285.201461904948, 12645.87354126447, 12656.303903285409, 12680.175788573713, 12690.873091269154, 616705.0, 637641.0, 644851.0, 676094.0, 694952.0, 136620.0, 136784.0, 138433.0, 140033.0, 148760.0, 1326.635175326793, 1363.4592910011622, 1395.6859706565942, 1399.8670126337981, 1406.8522805105522, 22694.0, 22729.659055114516, 22889.542209155392, 23256.76743232546, 23541.0, 67861.66069169622, 70773.0, 71057.64471177611, 71567.28432715606, 72670.27329726635, 89206.0, 89286.55356723175, 89662.55168724114, 90319.0, 92078.53960730153, 15718.921405393357, 15882.60293492672, 15883.364665413254, 15944.441944531885, 16080.67838643244, 24975.375615609755, 25017.624735629342, 25127.24618261455, 25152.11967581126, 25253.24240272795, 19433.12550935183, 19847.404577862686, 20118.29585964484, 20242.696359554913, 20330.0, 18481.0, 18860.434186974413, 19293.324733634254, 19332.806671933664, 19574.314898978468, 21023.789762102795, 21556.676649849953, 21832.0, 21880.343589692333, 21899.890500548034, 15839.920800395925, 16141.59646008859, 16187.75718364249, 16242.918785405996, 16277.267522961733, 20323.491912702302, 20399.4900127498, 20646.483837903572, 20780.27269045576, 20814.479638009172], "value": 13338.979511237801, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.9856301436985, 1447.8841692664587, 1487.7917091607171, 1506.638406782372, 1523.6724104317573, 15508.302126404311, 16005.679886402266, 16101.677966440664, 16159.353625854952, 16165.595860103504, 16228.10745409002, 16323.510294691148, 16383.262753176106, 16398.180090995433, 16416.507504774847, 2941.352902361477, 2946.6758656547763, 3004.218903085192, 3006.4588374092655, 3007.7894547381693, 2939.8089124206963, 2981.075866481387, 2997.310618557722, 3046.086174147758, 3052.465818481768, 3024.516077427612, 3027.31885325801, 3029.803062800911, 3039.3921215756827, 3051.023672424825, 2860.3850172213074, 2926.1221633509863, 2930.2674331417147, 2931.516299810529, 2945.911622651324, 2852.885884564615, 2863.2555535560905, 2886.956695649567, 2888.653361596601, 2890.7253810887933, 15539.378424862993, 15877.126758028304, 15958.601034974103, 15960.521184364488, 16015.35938562456, 8388.328933685352, 8589.699360522352, 8627.352948528885, 8637.265832404253, 8642.092580279106, 5567.359753628344, 5798.333191682968, 5861.677607731573, 5937.614055086406, 6057.242844644419, 2022.3629556689743, 2022.9393118206478, 2024.4635171679517, 2051.5178932950894, 2067.8449116316337, 27633.86183069092, 27838.72161278402, 27843.582346264822, 27850.3037424064, 27876.860615696995, 7519.248075192547, 7539.660715267826, 7599.544027358376, 7714.074311082706, 7722.07335119778, 18839.340623078126, 18845.0, 18854.05729713509, 18879.0, 18887.81112188888, 8746.256568191648, 8823.161799629024, 8849.955750221208, 8891.688790892287, 8903.599338029804, 8023.518588884685, 8089.110197878229, 8171.83656326882, 8286.668533258602, 8301.128381519975, 5695.487406133468, 5729.1119876419225, 5766.596338256281, 5782.624129431573, 5811.878664287505, 1535.961600959985, 1576.7634854771875, 1595.0429742154847, 1701.5575950253024, 1772.4682595221382, 949.8717673114179, 959.5825815770023, 979.7606028374113, 991.6628346362127, 994.7910938702809, 8644.913550864536, 8718.520481373458, 8761.948566172101, 8852.911470885338, 8885.0, 1067.2635881241918, 1071.5445935477392, 1093.5455843727823, 1093.748437859297, 1101.1466113761899, 5446.700431476228, 5469.453054694499, 5560.221568980346, 5725.112607545837, 5884.705764711833, 22422.439439014157, 23358.883205584203, 23372.065117395454, 23375.181868634518, 23377.649335259986, 21986.89006554957, 22525.0, 22804.42988925257, 22820.885895570416, 22923.541529169324, 11907.166498345206, 11979.161458697807, 12658.367081645882, 12818.458261375858, 12881.09832311748, 9066.546672666473, 9360.625574977197, 9463.716088517356, 9495.47774872361, 9677.0, 19789.30737424183, 20017.6997345037, 20363.694544581547, 20681.586368272852, 20852.37442876716, 20814.791852081285, 20888.268910588056, 21003.369898903056, 21081.0, 21290.0, 13416.865831341562, 13480.191188528719, 13531.729365412833, 13599.796003059764, 13612.183269003495, 14859.257037147883, 14982.850171498145, 15007.32467038964, 15029.849701502844, 15102.320395582445, 11815.586454474053, 11842.644720658394, 11981.820272696092, 12018.459169337226, 12160.027197823976, 11894.048476122063, 12005.339706315886, 12073.879261207276, 12117.333546655018, 12243.32661703615, 10324.741881453023, 10430.217733669853, 10514.842277365693, 10525.578976841147, 10528.526216320131, 7340.00757832609, 7610.353119984642, 7689.115751688628, 7773.494722842997, 8008.799780005314, 8047.114817369968, 8173.959130204311, 8203.630836612487, 8205.95897020511, 8290.668373265002], "value": 7269.108523687271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6602123672704, 544.9700266485344, 561.6994907724368, 569.2136989436707, 575.922250496183, 6218.129461875335, 6293.150424692665, 6293.4335909768115, 6332.936670633292, 6426.742930282789, 5993.820185394434, 6133.9079913801215, 6139.6009259398215, 6176.81469555914, 6230.688465576714, 4845.636577256702, 4893.119238537062, 4909.410870695504, 4922.187839006559, 4932.9753351233285, 4793.568578827905, 4863.465018847924, 4876.707397556141, 4912.754362281889, 4922.21244600864, 4838.782209830459, 4838.9596236809075, 4846.345743324641, 4853.063896342697, 4895.360054381768, 4832.879178020543, 4845.660803743739, 4848.781804818792, 4861.0, 4907.141250281186, 4437.977810110961, 4452.888677783049, 4483.125790470859, 4512.729236245803, 4517.683762136652, 6190.845228869314, 6232.968835155841, 6241.375862413768, 6259.155014073087, 6275.372462753734, 5822.82531524055, 5827.213326200951, 5847.7953271635715, 5873.7944171954205, 5958.225430694026, 6598.670066496656, 6663.433608143314, 6677.432418244455, 6692.297308782605, 6695.2420918010475, 5050.318207042039, 5062.531865758925, 5074.974625126888, 5102.107131252016, 5114.641975061747, 6749.966250168816, 6780.389764921131, 6887.311268873123, 6905.205901321362, 6968.895466568006, 5144.588432925357, 5206.739663016834, 5207.921881171786, 5209.765560549784, 5217.2695822584865, 5187.870303242449, 5244.239585260116, 5278.419373868871, 5295.364556253275, 5320.76056577455, 5861.1501332307425, 5867.6772777497645, 5895.734691938873, 5905.261842269716, 5907.852303692442, 6512.381323774329, 6596.96701516499, 6599.53803233769, 6622.496702242522, 6736.326367363323, 1775.6981313176532, 1814.1201517264117, 1815.7094864821565, 1823.6079242962562, 1847.8429333506801, 1265.1586694848006, 1274.222724138275, 1285.13895689888, 1304.9673758156123, 1306.3794697518792, 6306.463950564162, 6310.1796766420075, 6312.5581209314905, 6342.619442833353, 6386.818438588783, 6717.059611654372, 6738.663066846638, 6752.122224110933, 6753.358430949052, 6790.354916282945, 6079.908801367983, 6292.2134733158355, 6340.556161068773, 6346.619202847844, 6389.169407976933, 3540.185757275841, 3546.7339949503375, 3582.3730847102174, 3582.5880023797595, 3585.6055833858254, 6915.619640919697, 6923.7576684816795, 6929.133858267716, 6937.549059311129, 6989.091418115714, 6981.581105133709, 6991.405730512862, 7011.579305241702, 7014.403775679022, 7015.684294206773, 7027.789166325018, 7028.894566581505, 7060.6116663584, 7061.9293807062295, 7080.0, 6766.560173588898, 6790.913453847361, 6800.591964482147, 6809.21694005176, 6848.623325717133, 6642.4686025118845, 6752.797416077526, 6759.966200168968, 6764.154480689914, 6780.593164410151, 6862.0, 6903.0, 6927.203371612329, 6978.616176110159, 6979.371856532936, 5147.2499350219605, 5192.610554208374, 5222.477752224747, 5227.18978558324, 5254.9211761822835, 6486.6756662167645, 6653.900191497035, 6724.260331363448, 6864.84217260066, 6880.621565813928, 6445.645489497935, 6545.476361890942, 6562.146920900444, 6608.0, 6636.303188165173, 6569.37590928861, 6578.76974305897, 6615.272320044695, 6659.833504162435, 6666.200055993312, 6467.385598368148, 6652.667366631746, 6653.201615806134, 6668.966655166693, 6698.162729658793, 6629.0, 6637.369449902251, 6652.600843949379, 6709.396154346132, 6709.429698475684, 6411.0, 6483.189601299838, 6512.120863683532, 6533.150690410406, 6558.213014438298], "value": 5182.383422059398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.7372325164076, 911.9270458363329, 965.5172413793103, 970.4225985538607, 991.1872264742914, 18593.90703046483, 19440.0, 20408.795912040874, 20426.489337766525, 20439.284625038108, 18826.0, 19379.418617441464, 22943.770562294372, 22952.196673116443, 23071.077156913703, 1058.5606973106171, 1081.0162751895778, 1081.4322480697658, 1081.8323159910226, 1085.5766251162054, 1089.2103225161773, 1090.0353187429143, 1090.3185509056839, 1090.7709381029993, 1099.4118146791468, 1088.4612117002096, 1116.3190453823202, 1121.2935850414228, 1123.404595564348, 1125.9042981346595, 1104.0229396983648, 1105.1987309200845, 1107.3134656512932, 1111.2443538393889, 1117.6032508459502, 808.6926967752275, 811.5049819610033, 811.7158994351988, 813.9755807325789, 816.4040250617082, 19763.209471621118, 20694.379168624964, 20786.48033799152, 21061.78938210629, 21078.367648970554, 20893.582128357346, 20990.685139722915, 21115.15539378423, 21368.20744980528, 21681.0, 15192.46826361072, 15639.843601564065, 15680.372785088583, 15850.0, 15888.602784930354, 3675.4854320395166, 3694.7783133012103, 3697.2975134724315, 3700.4264339027495, 3702.9629703702885, 144166.0, 144222.0, 144388.0, 144929.0, 146642.0, 16267.51197464078, 16658.250378732744, 16734.4142954996, 16832.410865619644, 16858.831411685725, 30706.925257615876, 32051.878184263438, 32341.676583234337, 32412.189695257806, 32415.675843241737, 9640.75898102553, 9907.0, 9942.850857237147, 10049.346792458467, 10068.647597334204, 4722.787474563653, 4857.077155340474, 4921.803127874917, 4935.481774413706, 4939.925901111486, 5801.3328467225965, 5916.645001299936, 5931.466168044896, 5952.940470595326, 5969.2240008799445, 1185.9339967745761, 1210.2556927489532, 1217.4034722985673, 1237.2638280223252, 1239.8078297863844, 758.2682711183734, 761.5316580303074, 773.2847116417291, 775.5036776463069, 781.7146741439334, 12847.807282890764, 13523.188608683511, 14082.577522674335, 14094.647633809032, 14116.858831411555, 702.9964850175717, 710.3713213805819, 712.5546533416615, 724.6811402982671, 725.2384995754437, 6825.761098361533, 6958.199807022156, 7032.718691252293, 7114.14630244374, 7229.2770722928335, 122933.46799394049, 123822.0, 124271.37864310801, 124798.37600811938, 130634.34682826525, 112537.0, 114806.0, 114948.0, 116747.41626291814, 117235.41382293034, 97944.51027744958, 98608.0, 102517.48741256246, 102762.0, 103034.0, 13216.530374413564, 13398.330083495981, 14069.929650351683, 14108.576742697736, 14256.501022464165, 48007.03985920192, 48315.75842120767, 48389.0, 48828.0, 49413.0, 81315.0, 87294.1270587286, 87908.56045719731, 89520.5523972402, 90505.0, 20827.791722082584, 21746.67379989333, 21771.782282176977, 21990.670139948234, 22013.889930550245, 22086.0, 23236.883815581492, 23414.0, 24025.27924162278, 24212.031518739757, 18929.053547322856, 19085.713714294576, 20852.47868803292, 22517.66223506616, 22770.43073923165, 21637.783622164206, 21711.782882171607, 21986.560268794856, 22153.113875445448, 22187.334379968626, 20449.89775051115, 21086.261980830597, 21402.357929262147, 21609.675854862504, 21648.567028659654, 14768.852311476749, 15023.774643380139, 15590.454334098253, 15747.842521574637, 15845.52463426099, 15810.0, 16443.917780411022, 16713.832861671228, 16743.497695069167, 16865.831341686426], "value": 10174.108003895215, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 114.0, 99.0, 105.0, 106.0, 107.0, 109.0, 97.0, 106.0, 107.0], "value": 104.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 112.0, 148.0, 163.0, 115.0, 144.0, 138.0, 117.0, 161.0, 114.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 163.0, 162.0, 159.0, 161.0, 161.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 188.0, 75.0, 75.0, 77.0, 74.0, 158.0, 78.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 126.0, 77.0, 77.0, 78.0, 123.0, 78.0, 78.0, 132.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0, 148.0, 149.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 50.0, 45.0, 46.0, 47.0, 49.0, 47.0, 46.0, 45.0, 46.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 73.0, 78.0, 73.0, 72.0, 82.0, 78.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 124.0, 122.0, 112.0, 115.0, 116.0, 113.0, 123.0, 143.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 163.0, 157.0, 160.0, 159.0, 161.0, 163.0, 168.0, 168.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 59.0, 60.0, 58.0, 67.0, 58.0, 58.0, 58.0, 59.0], "value": 59.6, "unit": "score"}]}]} 07:33:34 INFO - Return code: 0 07:33:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:33:35 INFO - # TBPL SUCCESS # 07:33:35 INFO - Running post-action listener: _package_coverage_data 07:33:35 INFO - Running post-action listener: _resource_record_post_action 07:33:35 INFO - [mozharness: 2017-08-18 14:33:35.029004Z] Finished run-tests step (success) 07:33:35 INFO - Running post-run listener: _resource_record_post_run 07:33:35 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 1249280; Write bytes: 387076096; Read time: 704; Write time: 319620 07:33:35 INFO - TinderboxPrint: CPU usage
13.0% 07:33:35 INFO - TinderboxPrint: I/O read bytes / time
1,249,280 / 704 07:33:35 INFO - TinderboxPrint: I/O write bytes / time
387,076,096 / 319,620 07:33:35 INFO - TinderboxPrint: CPU idle
8,211.5 (87.0%) 07:33:35 INFO - TinderboxPrint: CPU user
1,181.2 (12.5%) 07:33:35 INFO - TinderboxPrint: Swap in / out
0 / 0 07:33:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106233856; Read time: 100; Write time: 131344 07:33:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:33:35 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 1236992; Write bytes: 280838144; Read time: 580; Write time: 188276 07:33:35 INFO - Running post-run listener: _upload_blobber_files 07:33:35 INFO - Blob upload gear active. 07:33:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:33:35 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 07:33:35 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'] 07:33:35 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 07:33:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:36 INFO - (blobuploader) - INFO - Done attempting. 07:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:37 INFO - (blobuploader) - INFO - Done attempting. 07:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:44 INFO - (blobuploader) - INFO - Done attempting. 07:33:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:33:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:33:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:45 INFO - (blobuploader) - INFO - Done attempting. 07:33:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:33:45 INFO - Return code: 0 07:33:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:33:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:33:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2b7e42bc676f83e01d2f8ee3b485d76ac1dd2e8752246827c26b5817c1ea2a23b414807224136c8c6cb123304370c8a20beb7cc5144954bf2937497f1e54ec48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7951b5d40308d5d669c3b4ca9cec250dcfbe096a36959b4b3dc8872193d41f68649b38d11dd37494031b3aab209796bfb695fb8ead5b77a96771756033418569", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7e94f345db8944ed098d27111b8c0a77973d2e6e583a0504e0347ef9994eb90df7aff5d491ed13dc444321e223f5256827571365d88218bad4b67c71502fdd6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ea6a4f88c8b7f56fe4f94b34964acfe97923893a54974bbe221f4269475197f8fa8a2f5fb935651d615b54f4d87a9bfa57af59ebb939ab5bdb43f687b096081"} 07:33:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:33:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:33:45 INFO - Contents: 07:33:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2b7e42bc676f83e01d2f8ee3b485d76ac1dd2e8752246827c26b5817c1ea2a23b414807224136c8c6cb123304370c8a20beb7cc5144954bf2937497f1e54ec48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7951b5d40308d5d669c3b4ca9cec250dcfbe096a36959b4b3dc8872193d41f68649b38d11dd37494031b3aab209796bfb695fb8ead5b77a96771756033418569", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7e94f345db8944ed098d27111b8c0a77973d2e6e583a0504e0347ef9994eb90df7aff5d491ed13dc444321e223f5256827571365d88218bad4b67c71502fdd6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ea6a4f88c8b7f56fe4f94b34964acfe97923893a54974bbe221f4269475197f8fa8a2f5fb935651d615b54f4d87a9bfa57af59ebb939ab5bdb43f687b096081"} 07:33:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:33:45 INFO - Copying logs to upload dir... 07:33:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:33:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.052128 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-18 07:33:45.596618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 07:33:45.604306) ========= 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=fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2b7e42bc676f83e01d2f8ee3b485d76ac1dd2e8752246827c26b5817c1ea2a23b414807224136c8c6cb123304370c8a20beb7cc5144954bf2937497f1e54ec48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7951b5d40308d5d669c3b4ca9cec250dcfbe096a36959b4b3dc8872193d41f68649b38d11dd37494031b3aab209796bfb695fb8ead5b77a96771756033418569", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7e94f345db8944ed098d27111b8c0a77973d2e6e583a0504e0347ef9994eb90df7aff5d491ed13dc444321e223f5256827571365d88218bad4b67c71502fdd6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ea6a4f88c8b7f56fe4f94b34964acfe97923893a54974bbe221f4269475197f8fa8a2f5fb935651d615b54f4d87a9bfa57af59ebb939ab5bdb43f687b096081"} build_url:https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/Dk1apzgORRuEWgwuC-WsPQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2b7e42bc676f83e01d2f8ee3b485d76ac1dd2e8752246827c26b5817c1ea2a23b414807224136c8c6cb123304370c8a20beb7cc5144954bf2937497f1e54ec48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7951b5d40308d5d669c3b4ca9cec250dcfbe096a36959b4b3dc8872193d41f68649b38d11dd37494031b3aab209796bfb695fb8ead5b77a96771756033418569", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7e94f345db8944ed098d27111b8c0a77973d2e6e583a0504e0347ef9994eb90df7aff5d491ed13dc444321e223f5256827571365d88218bad4b67c71502fdd6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2ea6a4f88c8b7f56fe4f94b34964acfe97923893a54974bbe221f4269475197f8fa8a2f5fb935651d615b54f4d87a9bfa57af59ebb939ab5bdb43f687b096081"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-18 07:33:45.633712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 07:33:45.634018) ========= 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=fa44defc139c4ba8574fe040000001db-1503065572.376199-1566416120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004755 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-18 07:33:45.713717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 07:33:45.717041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-18 07:33:45.717307) ========= ========= Total master_lag: 0.64 =========