builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1502071798.69 results: success (0) revision: 813810854eeaae9f2c5cb8f6879f91ac45e5038a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.688549) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.689042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.689349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.705563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.705876) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 19:09:58-- 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% 43.2M=0s 2017-08-06 19:09:58 (43.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.839547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.839886) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018718 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.889396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:58.889796) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 813810854eeaae9f2c5cb8f6879f91ac45e5038a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 813810854eeaae9f2c5cb8f6879f91ac45e5038a --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=e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 19:09:58,989 truncating revision to first 12 chars 2017-08-06 19:09:58,989 Setting DEBUG logging. 2017-08-06 19:09:58,989 attempt 1/10 2017-08-06 19:09:58,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/813810854eea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 19:09:59,524 unpacking tar archive at: mozilla-central-813810854eea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:59.809213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:59.809557) ========= script_repo_revision: 813810854eeaae9f2c5cb8f6879f91ac45e5038a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:59.809932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:59.810216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:09:59.817962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 19:09:59.818256) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:00 INFO - MultiFileLogger online at 20170806 19:10:00 in /builds/slave/test 19:10:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:10:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:00 INFO - {'append_to_log': False, 19:10:00 INFO - 'base_work_dir': '/builds/slave/test', 19:10:00 INFO - 'blob_upload_branch': 'Firefox', 19:10:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:00 INFO - 'branch': 'Firefox', 19:10:00 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:00 INFO - 'code_coverage': False, 19:10:00 INFO - 'config_files': ('talos/linux_config.py',), 19:10:00 INFO - 'default_actions': ('clobber', 19:10:00 INFO - 'read-buildbot-config', 19:10:00 INFO - 'download-and-extract', 19:10:00 INFO - 'populate-webroot', 19:10:00 INFO - 'create-virtualenv', 19:10:00 INFO - 'install', 19:10:00 INFO - 'setup-mitmproxy', 19:10:00 INFO - 'run-tests'), 19:10:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:00 INFO - 'disable_ccov_upload': False, 19:10:00 INFO - 'download_minidump_stackwalk': True, 19:10:00 INFO - 'download_symbols': 'ondemand', 19:10:00 INFO - 'enable_stylo': False, 19:10:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:00 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:00 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:00 INFO - 'gecko_profile': False, 19:10:00 INFO - 'gecko_profile_interval': 0, 19:10:00 INFO - 'installer_path': 'installer.exe', 19:10:00 INFO - 'log_level': 'info', 19:10:00 INFO - 'log_name': 'talos', 19:10:00 INFO - 'log_to_console': True, 19:10:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:00 INFO - 'opt_config_files': (), 19:10:00 INFO - 'pip_index': False, 19:10:00 INFO - 'suite': 'dromaeojs-e10s', 19:10:00 INFO - 'system_bits': '32', 19:10:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:00 INFO - 'title': 'talos-linux64-ix-006', 19:10:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:00 INFO - 'use_talos_json': True, 19:10:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:00 INFO - 'work_dir': 'build'} 19:10:00 INFO - [mozharness: 2017-08-07 02:10:00.023614Z] Running clobber step. 19:10:00 INFO - Running pre-action listener: _resource_record_pre_action 19:10:00 INFO - Running main action method: clobber 19:10:00 INFO - rmtree: /builds/slave/test/build 19:10:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:01 INFO - Running post-action listener: _resource_record_post_action 19:10:01 INFO - [mozharness: 2017-08-07 02:10:01.050803Z] Finished clobber step (success) 19:10:01 INFO - [mozharness: 2017-08-07 02:10:01.050906Z] Running read-buildbot-config step. 19:10:01 INFO - Running pre-action listener: _resource_record_pre_action 19:10:01 INFO - Running main action method: read_buildbot_config 19:10:01 INFO - Using buildbot properties: 19:10:01 INFO - { 19:10:01 INFO - "project": "", 19:10:01 INFO - "product": "firefox", 19:10:01 INFO - "who": "ryanvm@gmail.com", 19:10:01 INFO - "installer_path": "public/build/target.tar.bz2", 19:10:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:10:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:10:01 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:10:01 INFO - "stage_platform": "linux64-stylo", 19:10:01 INFO - "basedir": "/builds/slave/test", 19:10:01 INFO - "buildnumber": 260, 19:10:01 INFO - "platform": "ubuntu64_hw_stylo", 19:10:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:10:01 INFO - "slavebuilddir": "test", 19:10:01 INFO - "taskId": "DEomSBzST0C2rhxaZZ5mng", 19:10:01 INFO - "branch": "mozilla-central", 19:10:01 INFO - "script_repo_revision": "production", 19:10:01 INFO - "revision": "813810854eeaae9f2c5cb8f6879f91ac45e5038a", 19:10:01 INFO - "slavename": "talos-linux64-ix-006", 19:10:01 INFO - "repo_path": "mozilla-central" 19:10:01 INFO - } 19:10:01 INFO - Finding installer, test and symbols from parent task. 19:10:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DEomSBzST0C2rhxaZZ5mng'}, attempt #1 19:10:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DEomSBzST0C2rhxaZZ5mng'}, attempt #1 19:10:01 INFO - Task dependencies: RKvT63nbRo-zGQ2y8mYqJQ 19:10:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ'}, attempt #1 19:10:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:10:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json 19:10:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip 19:10:02 INFO - Running post-action listener: _resource_record_post_action 19:10:02 INFO - [mozharness: 2017-08-07 02:10:02.415217Z] Finished read-buildbot-config step (success) 19:10:02 INFO - [mozharness: 2017-08-07 02:10:02.415445Z] Running download-and-extract step. 19:10:02 INFO - Running pre-action listener: _resource_record_pre_action 19:10:02 INFO - Running main action method: download_and_extract 19:10:02 INFO - mkdir: /builds/slave/test/build/tests 19:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:02 INFO - trying https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json 19:10:02 INFO - Downloading https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:10:03 INFO - Downloaded 989 bytes. 19:10:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:10:03 INFO - Using the following test package requirements: 19:10:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:10:03 INFO - u'common': [u'target.common.tests.zip'], 19:10:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:10:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:10:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:10:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:10:03 INFO - u'mozbase': [u'target.common.tests.zip'], 19:10:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:10:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:10:03 INFO - u'web-platform': [u'target.common.tests.zip', 19:10:03 INFO - u'target.web-platform.tests.tar.gz'], 19:10:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:10:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:10:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip 19:10:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:10:03 INFO - Fetch https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip into memory 19:10:04 INFO - Content-Length response header: 54284835 19:10:04 INFO - Bytes received: 54284835 19:10:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:10:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip 19:10:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:10:14 INFO - Fetch https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip into memory 19:10:15 INFO - Content-Length response header: 54284835 19:10:15 INFO - Bytes received: 54284835 19:10:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.talos.tests.zip 19:10:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:10:27 INFO - Fetch https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.talos.tests.zip into memory 19:10:28 INFO - Content-Length response header: 14496008 19:10:28 INFO - Bytes received: 14496008 19:10: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')]} 19:10:28 INFO - trying https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:10:28 INFO - Downloading https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:10:30 INFO - Downloaded 61820626 bytes. 19:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:10:30 INFO - mkdir: /builds/slave/test/properties 19:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:30 INFO - Contents: 19:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:10:30 INFO - Running post-action listener: _resource_record_post_action 19:10:30 INFO - Running post-action listener: set_extra_try_arguments 19:10:30 INFO - [mozharness: 2017-08-07 02:10:30.011898Z] Finished download-and-extract step (success) 19:10:30 INFO - [mozharness: 2017-08-07 02:10:30.011997Z] Running populate-webroot step. 19:10:30 INFO - Running pre-action listener: _resource_record_pre_action 19:10:30 INFO - Running main action method: populate_webroot 19:10:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:10:30 INFO - 'tests': ['damp', 'tps']}, 19:10:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:10:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:10:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:10:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:30 INFO - 'ts_paint', 19:10:30 INFO - 'tpaint', 19:10:30 INFO - 'sessionrestore', 19:10:30 INFO - 'sessionrestore_many_windows', 19:10:30 INFO - 'sessionrestore_no_auto_restore', 19:10:30 INFO - 'tabpaint']}, 19:10:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:10:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:10:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:30 INFO - 'tsvgr_opacity', 19:10:30 INFO - 'tart', 19:10:30 INFO - 'tscrollx', 19:10:30 INFO - 'tsvg_static']}, 19:10:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:10:30 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:10:30 INFO - 'talos_options': ['--mitmproxy', 19:10:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:10:30 INFO - '--firstNonBlankPaint'], 19:10:30 INFO - 'tests': ['tp6_google', 19:10:30 INFO - 'tp6_youtube', 19:10:30 INFO - 'tp6_amazon', 19:10:30 INFO - 'tp6_facebook']}, 19:10:30 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:10:30 INFO - 'talos_options': ['--stylo', 19:10:30 INFO - '--mitmproxy', 19:10:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:10:30 INFO - '--firstNonBlankPaint'], 19:10:30 INFO - 'tests': ['tp6_google', 19:10:30 INFO - 'tp6_youtube', 19:10:30 INFO - 'tp6_amazon', 19:10:30 INFO - 'tp6_facebook']}, 19:10:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:10:30 INFO - 'talos_options': ['--stylo', 19:10:30 INFO - '--stylo-threads=1', 19:10:30 INFO - '--mitmproxy', 19:10:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:10:30 INFO - '--firstNonBlankPaint'], 19:10:30 INFO - 'tests': ['tp6_google', 19:10:30 INFO - 'tp6_youtube', 19:10:30 INFO - 'tp6_amazon', 19:10:30 INFO - 'tp6_facebook']}, 19:10:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:10:30 INFO - 'talos_options': ['--xperf_path', 19:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:30 INFO - 'tests': ['tp5n']}}} 19:10:30 INFO - Running post-action listener: _resource_record_post_action 19:10:30 INFO - [mozharness: 2017-08-07 02:10:30.020501Z] Finished populate-webroot step (success) 19:10:30 INFO - [mozharness: 2017-08-07 02:10:30.020591Z] Running create-virtualenv step. 19:10:30 INFO - Running pre-action listener: _resource_record_pre_action 19:10:30 INFO - Running main action method: create_virtualenv 19:10:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10: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 19:10:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:10:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:30 INFO - Using real prefix '/usr' 19:10:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:32 INFO - Installing pip.................done. 19:10:32 INFO - Return code: 0 19:10:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:10:32 INFO - Reading from file tmpfile_stdout 19:10:32 INFO - Output received: 19:10: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) 19:10:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:32 INFO - Using env: {'DISPLAY': ':0', 19:10:32 INFO - 'HOME': '/home/cltbld', 19:10:32 INFO - 'LANG': 'en_US.UTF-8', 19:10:32 INFO - 'LANGUAGE': 'en_US:en', 19:10:32 INFO - 'LOGNAME': 'cltbld', 19:10:32 INFO - 'MAIL': '/var/mail/cltbld', 19:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:32 INFO - 'MOZ_NO_REMOTE': '1', 19:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:32 INFO - 'NO_EM_RESTART': '1', 19:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:32 INFO - 'PWD': '/builds/slave/test', 19:10:32 INFO - 'SHELL': '/bin/bash', 19:10:32 INFO - 'SHLVL': '1', 19:10:32 INFO - 'TERM': 'linux', 19:10:32 INFO - 'TMOUT': '86400', 19:10:32 INFO - 'USER': 'cltbld', 19:10:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:32 INFO - '_': '/tools/buildbot/bin/python'} 19:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10: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 19:10:33 INFO - Cleaning up... 19:10:33 INFO - Return code: 0 19:10:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:33 INFO - Using env: {'DISPLAY': ':0', 19:10:33 INFO - 'HOME': '/home/cltbld', 19:10:33 INFO - 'LANG': 'en_US.UTF-8', 19:10:33 INFO - 'LANGUAGE': 'en_US:en', 19:10:33 INFO - 'LOGNAME': 'cltbld', 19:10:33 INFO - 'MAIL': '/var/mail/cltbld', 19:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:33 INFO - 'MOZ_NO_REMOTE': '1', 19:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:33 INFO - 'NO_EM_RESTART': '1', 19:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:33 INFO - 'PWD': '/builds/slave/test', 19:10:33 INFO - 'SHELL': '/bin/bash', 19:10:33 INFO - 'SHLVL': '1', 19:10:33 INFO - 'TERM': 'linux', 19:10:33 INFO - 'TMOUT': '86400', 19:10:33 INFO - 'USER': 'cltbld', 19:10:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:33 INFO - '_': '/tools/buildbot/bin/python'} 19:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:33 INFO - Downloading/unpacking psutil>=3.1.1 19:10: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 19:10: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 19:10: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 19:10: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 19:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:34 INFO - Installing collected packages: psutil 19:10:34 INFO - Running setup.py install for psutil 19:10:34 INFO - building 'psutil._psutil_linux' extension 19:10: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 19:10: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 19:10:34 INFO - building 'psutil._psutil_posix' extension 19:10: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 19:10:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:35 INFO - Successfully installed psutil 19:10:35 INFO - Cleaning up... 19:10:35 INFO - Return code: 0 19:10:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:35 INFO - Using env: {'DISPLAY': ':0', 19:10:35 INFO - 'HOME': '/home/cltbld', 19:10:35 INFO - 'LANG': 'en_US.UTF-8', 19:10:35 INFO - 'LANGUAGE': 'en_US:en', 19:10:35 INFO - 'LOGNAME': 'cltbld', 19:10:35 INFO - 'MAIL': '/var/mail/cltbld', 19:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:35 INFO - 'MOZ_NO_REMOTE': '1', 19:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:35 INFO - 'NO_EM_RESTART': '1', 19:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:35 INFO - 'PWD': '/builds/slave/test', 19:10:35 INFO - 'SHELL': '/bin/bash', 19:10:35 INFO - 'SHLVL': '1', 19:10:35 INFO - 'TERM': 'linux', 19:10:35 INFO - 'TMOUT': '86400', 19:10:35 INFO - 'USER': 'cltbld', 19:10:35 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:35 INFO - '_': '/tools/buildbot/bin/python'} 19:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10: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 19:10: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 19:10: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 19:10: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 19:10:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:36 INFO - Installing collected packages: mozsystemmonitor 19:10:36 INFO - Running setup.py install for mozsystemmonitor 19:10:36 INFO - Successfully installed mozsystemmonitor 19:10:36 INFO - Cleaning up... 19:10:36 INFO - Return code: 0 19:10:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:36 INFO - Using env: {'DISPLAY': ':0', 19:10:36 INFO - 'HOME': '/home/cltbld', 19:10:36 INFO - 'LANG': 'en_US.UTF-8', 19:10:36 INFO - 'LANGUAGE': 'en_US:en', 19:10:36 INFO - 'LOGNAME': 'cltbld', 19:10:36 INFO - 'MAIL': '/var/mail/cltbld', 19:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:36 INFO - 'MOZ_NO_REMOTE': '1', 19:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:36 INFO - 'NO_EM_RESTART': '1', 19:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:36 INFO - 'PWD': '/builds/slave/test', 19:10:36 INFO - 'SHELL': '/bin/bash', 19:10:36 INFO - 'SHLVL': '1', 19:10:36 INFO - 'TERM': 'linux', 19:10:36 INFO - 'TMOUT': '86400', 19:10:36 INFO - 'USER': 'cltbld', 19:10:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:36 INFO - '_': '/tools/buildbot/bin/python'} 19:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:36 INFO - Downloading/unpacking jsonschema==2.5.1 19:10: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 19:10: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 19:10: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 19:10: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 19:10:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:10: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 19:10: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 19:10: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 19:10: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 19:10:38 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:38 INFO - warning: no files found matching '*.txt' 19:10:38 INFO - no previously-included directories found matching 'build' 19:10:38 INFO - no previously-included directories found matching 'dist' 19:10:38 INFO - no previously-included directories found matching '.git*' 19:10:38 INFO - Installing collected packages: jsonschema, functools32 19:10:38 INFO - Running setup.py install for functools32 19:10:38 INFO - warning: no files found matching '*.txt' 19:10:38 INFO - no previously-included directories found matching 'build' 19:10:38 INFO - no previously-included directories found matching 'dist' 19:10:38 INFO - no previously-included directories found matching '.git*' 19:10:38 INFO - Successfully installed jsonschema functools32 19:10:38 INFO - Cleaning up... 19:10:38 INFO - Return code: 0 19:10:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:38 INFO - Using env: {'DISPLAY': ':0', 19:10:38 INFO - 'HOME': '/home/cltbld', 19:10:38 INFO - 'LANG': 'en_US.UTF-8', 19:10:38 INFO - 'LANGUAGE': 'en_US:en', 19:10:38 INFO - 'LOGNAME': 'cltbld', 19:10:38 INFO - 'MAIL': '/var/mail/cltbld', 19:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:38 INFO - 'MOZ_NO_REMOTE': '1', 19:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:38 INFO - 'NO_EM_RESTART': '1', 19:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:38 INFO - 'PWD': '/builds/slave/test', 19:10:38 INFO - 'SHELL': '/bin/bash', 19:10:38 INFO - 'SHLVL': '1', 19:10:38 INFO - 'TERM': 'linux', 19:10:38 INFO - 'TMOUT': '86400', 19:10:38 INFO - 'USER': 'cltbld', 19:10:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:38 INFO - '_': '/tools/buildbot/bin/python'} 19:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:10:38 INFO - Cleaning up... 19:10:38 INFO - Return code: 0 19:10:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:38 INFO - Using env: {'DISPLAY': ':0', 19:10:38 INFO - 'HOME': '/home/cltbld', 19:10:38 INFO - 'LANG': 'en_US.UTF-8', 19:10:38 INFO - 'LANGUAGE': 'en_US:en', 19:10:38 INFO - 'LOGNAME': 'cltbld', 19:10:38 INFO - 'MAIL': '/var/mail/cltbld', 19:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:38 INFO - 'MOZ_NO_REMOTE': '1', 19:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:38 INFO - 'NO_EM_RESTART': '1', 19:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:38 INFO - 'PWD': '/builds/slave/test', 19:10:38 INFO - 'SHELL': '/bin/bash', 19:10:38 INFO - 'SHLVL': '1', 19:10:38 INFO - 'TERM': 'linux', 19:10:38 INFO - 'TMOUT': '86400', 19:10:38 INFO - 'USER': 'cltbld', 19:10:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:38 INFO - '_': '/tools/buildbot/bin/python'} 19:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 19:10: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 19:10: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 19:10: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 19:10: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 19:10:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10: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 19:10: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 19:10: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 19:10: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 19:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10: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 19:10: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 19:10: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 19:10: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 19:10:40 INFO - Downloading docopt-0.6.1.tar.gz 19:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:40 INFO - Running setup.py install for blobuploader 19:10:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:40 INFO - Running setup.py install for requests 19:10:40 INFO - Running setup.py install for docopt 19:10:40 INFO - Successfully installed blobuploader requests docopt 19:10:40 INFO - Cleaning up... 19:10:40 INFO - Return code: 0 19:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:40 INFO - Using env: {'DISPLAY': ':0', 19:10:40 INFO - 'HOME': '/home/cltbld', 19:10:40 INFO - 'LANG': 'en_US.UTF-8', 19:10:40 INFO - 'LANGUAGE': 'en_US:en', 19:10:40 INFO - 'LOGNAME': 'cltbld', 19:10:40 INFO - 'MAIL': '/var/mail/cltbld', 19:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:40 INFO - 'MOZ_NO_REMOTE': '1', 19:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:40 INFO - 'NO_EM_RESTART': '1', 19:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:40 INFO - 'PWD': '/builds/slave/test', 19:10:40 INFO - 'SHELL': '/bin/bash', 19:10:40 INFO - 'SHLVL': '1', 19:10:40 INFO - 'TERM': 'linux', 19:10:40 INFO - 'TMOUT': '86400', 19:10:40 INFO - 'USER': 'cltbld', 19:10:40 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:40 INFO - '_': '/tools/buildbot/bin/python'} 19:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:41 INFO - Running setup.py (path:/tmp/pip-tXz3eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:41 INFO - Running setup.py (path:/tmp/pip-gc9Skg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:41 INFO - Running setup.py (path:/tmp/pip-_COIBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:41 INFO - Running setup.py (path:/tmp/pip-ZoznUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:41 INFO - Running setup.py (path:/tmp/pip-BMIkML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:41 INFO - Running setup.py (path:/tmp/pip-xXlw8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:41 INFO - Running setup.py (path:/tmp/pip-nWeDpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:41 INFO - Running setup.py (path:/tmp/pip-JfaHfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:41 INFO - Running setup.py (path:/tmp/pip-67t23m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:41 INFO - Running setup.py (path:/tmp/pip-JPZXow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:41 INFO - Running setup.py (path:/tmp/pip-6pOLph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:41 INFO - Running setup.py (path:/tmp/pip-zTDg0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:42 INFO - Running setup.py (path:/tmp/pip-6gou6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:42 INFO - Running setup.py (path:/tmp/pip-zdy1gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:42 INFO - Running setup.py (path:/tmp/pip-O7fmg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:42 INFO - Running setup.py (path:/tmp/pip-_0oOEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:42 INFO - Running setup.py (path:/tmp/pip-9fO9gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:42 INFO - Running setup.py install for manifestparser 19:10:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:42 INFO - Running setup.py install for mozcrash 19:10:42 INFO - Running setup.py install for mozdebug 19:10:42 INFO - Running setup.py install for mozdevice 19:10:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:42 INFO - Running setup.py install for mozfile 19:10:42 INFO - Running setup.py install for mozhttpd 19:10:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for mozinfo 19:10:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for mozInstall 19:10:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for mozleak 19:10:43 INFO - Running setup.py install for mozlog 19:10:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for moznetwork 19:10:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for mozprocess 19:10:43 INFO - Running setup.py install for mozprofile 19:10:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for mozrunner 19:10:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:43 INFO - Running setup.py install for mozscreenshot 19:10:43 INFO - Running setup.py install for moztest 19:10:44 INFO - Running setup.py install for mozversion 19:10:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:44 INFO - Cleaning up... 19:10:44 INFO - Return code: 0 19:10:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:44 INFO - Using env: {'DISPLAY': ':0', 19:10:44 INFO - 'HOME': '/home/cltbld', 19:10:44 INFO - 'LANG': 'en_US.UTF-8', 19:10:44 INFO - 'LANGUAGE': 'en_US:en', 19:10:44 INFO - 'LOGNAME': 'cltbld', 19:10:44 INFO - 'MAIL': '/var/mail/cltbld', 19:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:44 INFO - 'MOZ_NO_REMOTE': '1', 19:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:44 INFO - 'NO_EM_RESTART': '1', 19:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:44 INFO - 'PWD': '/builds/slave/test', 19:10:44 INFO - 'SHELL': '/bin/bash', 19:10:44 INFO - 'SHLVL': '1', 19:10:44 INFO - 'TERM': 'linux', 19:10:44 INFO - 'TMOUT': '86400', 19:10:44 INFO - 'USER': 'cltbld', 19:10:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:44 INFO - '_': '/tools/buildbot/bin/python'} 19:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:44 INFO - Running setup.py (path:/tmp/pip-v7SRq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10: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)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:44 INFO - Running setup.py (path:/tmp/pip-E6Lec6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10: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)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:44 INFO - Running setup.py (path:/tmp/pip-Z4WT5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10: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)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:44 INFO - Running setup.py (path:/tmp/pip-neKb9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10: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)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:44 INFO - Running setup.py (path:/tmp/pip-CC_MDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10: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)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:44 INFO - Running setup.py (path:/tmp/pip-Oj3jPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10: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)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:44 INFO - Running setup.py (path:/tmp/pip-Ps7oZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:44 INFO - Running setup.py (path:/tmp/pip-OQm4IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:44 INFO - Running setup.py (path:/tmp/pip-4ZMY8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:45 INFO - Running setup.py (path:/tmp/pip-8p642Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:45 INFO - Running setup.py (path:/tmp/pip-y5yuXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:45 INFO - Running setup.py (path:/tmp/pip-YX0vw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:45 INFO - Running setup.py (path:/tmp/pip-kxm177-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:45 INFO - Running setup.py (path:/tmp/pip-vT217j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:45 INFO - Running setup.py (path:/tmp/pip-C4CkT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:45 INFO - Running setup.py (path:/tmp/pip-f0T4yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10: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)) 19:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:45 INFO - Running setup.py (path:/tmp/pip-JJFvho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10: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 19:10: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 19:10: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 19:10: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 19:10:46 INFO - Downloading blessings-1.6.tar.gz 19:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:46 INFO - Installing collected packages: blessings 19:10:46 INFO - Running setup.py install for blessings 19:10:46 INFO - Successfully installed blessings 19:10:46 INFO - Cleaning up... 19:10:46 INFO - Return code: 0 19:10:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:47 INFO - Reading from file tmpfile_stdout 19:10:47 INFO - Current package versions: 19:10:47 INFO - argparse == 1.2.1 19:10:47 INFO - blessings == 1.6 19:10:47 INFO - blobuploader == 1.2.4 19:10:47 INFO - docopt == 0.6.1 19:10:47 INFO - functools32 == 3.2.3-2 19:10:47 INFO - jsonschema == 2.5.1 19:10:47 INFO - manifestparser == 1.1 19:10:47 INFO - mozInstall == 1.13 19:10:47 INFO - mozcrash == 1.0 19:10:47 INFO - mozdebug == 0.1 19:10:47 INFO - mozdevice == 0.51 19:10:47 INFO - mozfile == 1.2 19:10:47 INFO - mozhttpd == 0.7 19:10:47 INFO - mozinfo == 0.10 19:10:47 INFO - mozleak == 0.1 19:10:47 INFO - mozlog == 3.5 19:10:47 INFO - moznetwork == 0.27 19:10:47 INFO - mozprocess == 0.25 19:10:47 INFO - mozprofile == 0.28 19:10:47 INFO - mozrunner == 6.13 19:10:47 INFO - mozscreenshot == 0.1 19:10:47 INFO - mozsystemmonitor == 0.3 19:10:47 INFO - moztest == 0.8 19:10:47 INFO - mozversion == 1.4 19:10:47 INFO - psutil == 3.1.1 19:10:47 INFO - requests == 1.2.3 19:10:47 INFO - wsgiref == 0.1.2 19:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:47 INFO - Using env: {'DISPLAY': ':0', 19:10:47 INFO - 'HOME': '/home/cltbld', 19:10:47 INFO - 'LANG': 'en_US.UTF-8', 19:10:47 INFO - 'LANGUAGE': 'en_US:en', 19:10:47 INFO - 'LOGNAME': 'cltbld', 19:10:47 INFO - 'MAIL': '/var/mail/cltbld', 19:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:47 INFO - 'MOZ_NO_REMOTE': '1', 19:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:47 INFO - 'NO_EM_RESTART': '1', 19:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:47 INFO - 'PWD': '/builds/slave/test', 19:10:47 INFO - 'SHELL': '/bin/bash', 19:10:47 INFO - 'SHLVL': '1', 19:10:47 INFO - 'TERM': 'linux', 19:10:47 INFO - 'TMOUT': '86400', 19:10:47 INFO - 'USER': 'cltbld', 19:10:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:47 INFO - '_': '/tools/buildbot/bin/python'} 19:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10: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)) 19:10:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:10: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 19:10: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 19:10: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 19:10: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 19:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:10: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)) 19:10: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)) 19:10:48 INFO - Installing collected packages: simplejson 19:10:48 INFO - Running setup.py install for simplejson 19:10:48 INFO - building 'simplejson._speedups' extension 19:10: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 19:10: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 19:10:49 INFO - Successfully installed simplejson 19:10:49 INFO - Cleaning up... 19:10:49 INFO - Return code: 0 19:10:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10: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')]} 19:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10: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 0xb431f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd0fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb2d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', '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 19:10: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 19:10: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 19:10:49 INFO - Using env: {'DISPLAY': ':0', 19:10:49 INFO - 'HOME': '/home/cltbld', 19:10:49 INFO - 'LANG': 'en_US.UTF-8', 19:10:49 INFO - 'LANGUAGE': 'en_US:en', 19:10:49 INFO - 'LOGNAME': 'cltbld', 19:10:49 INFO - 'MAIL': '/var/mail/cltbld', 19:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:49 INFO - 'MOZ_NO_REMOTE': '1', 19:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:49 INFO - 'NO_EM_RESTART': '1', 19:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:49 INFO - 'PWD': '/builds/slave/test', 19:10:49 INFO - 'SHELL': '/bin/bash', 19:10:49 INFO - 'SHLVL': '1', 19:10:49 INFO - 'TERM': 'linux', 19:10:49 INFO - 'TMOUT': '86400', 19:10:49 INFO - 'USER': 'cltbld', 19:10:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:49 INFO - '_': '/tools/buildbot/bin/python'} 19:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:10:49 INFO - Cleaning up... 19:10:49 INFO - Return code: 0 19:10:49 INFO - Running post-action listener: _resource_record_post_action 19:10:49 INFO - Running post-action listener: _start_resource_monitoring 19:10:49 INFO - Starting resource monitoring. 19:10:49 INFO - [mozharness: 2017-08-07 02:10:49.896647Z] Finished create-virtualenv step (success) 19:10:49 INFO - [mozharness: 2017-08-07 02:10:49.897154Z] Running install step. 19:10:49 INFO - Running pre-action listener: _resource_record_pre_action 19:10:49 INFO - Running main action method: install 19:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:50 INFO - Reading from file tmpfile_stdout 19:10:50 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:50 INFO - Reading from file tmpfile_stdout 19:10:50 INFO - Output received: 19:10:50 INFO - Usage: mozinstall [options] installer 19:10:50 INFO - Options: 19:10:50 INFO - -h, --help show this help message and exit 19:10:50 INFO - -d DEST, --destination=DEST 19:10:50 INFO - Directory to install application into. [default: 19:10:50 INFO - "/builds/slave/test"] 19:10:50 INFO - --app=APP Application being installed. [default: firefox] 19:10:50 INFO - mkdir: /builds/slave/test/build/application 19:10: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'] 19:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:11:08 INFO - Reading from file tmpfile_stdout 19:11:08 INFO - Output received: 19:11:08 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:08 INFO - Running post-action listener: _resource_record_post_action 19:11:08 INFO - [mozharness: 2017-08-07 02:11:08.195147Z] Finished install step (success) 19:11:08 INFO - [mozharness: 2017-08-07 02:11:08.195495Z] Running setup-mitmproxy step. 19:11:08 INFO - Running pre-action listener: _resource_record_pre_action 19:11:08 INFO - Running main action method: setup_mitmproxy 19:11:08 INFO - Skipping: mitmproxy is not required 19:11:08 INFO - Running post-action listener: _resource_record_post_action 19:11:08 INFO - [mozharness: 2017-08-07 02:11:08.197109Z] Finished setup-mitmproxy step (success) 19:11:08 INFO - [mozharness: 2017-08-07 02:11:08.197573Z] Running run-tests step. 19:11:08 INFO - Running pre-action listener: _resource_record_pre_action 19:11:08 INFO - Running pre-action listener: _set_gcov_prefix 19:11:08 INFO - Running main action method: run_tests 19:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:08 INFO - Python 2.7.3 19:11:08 INFO - Return code: 0 19:11:08 INFO - grabbing minidump binary from tooltool 19:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:08 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 0xeafeb0>, '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 0xeb0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeb1240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:08 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 19:11:08 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 19:11:08 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 19:11:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:08 INFO - Return code: 0 19:11:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:08 INFO - ENV: RUST_BACKTRACE is now 1 19:11:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 19:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 19:11:08 INFO - Using env: {'DISPLAY': ':0', 19:11:08 INFO - 'HOME': '/home/cltbld', 19:11:08 INFO - 'LANG': 'en_US.UTF-8', 19:11:08 INFO - 'LANGUAGE': 'en_US:en', 19:11:08 INFO - 'LOGNAME': 'cltbld', 19:11:08 INFO - 'MAIL': '/var/mail/cltbld', 19:11:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:08 INFO - 'MOZ_NO_REMOTE': '1', 19:11:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:08 INFO - 'NO_EM_RESTART': '1', 19:11:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:08 INFO - 'PWD': '/builds/slave/test', 19:11:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:08 INFO - 'RUST_BACKTRACE': '1', 19:11:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:11:08 INFO - 'SHELL': '/bin/bash', 19:11:08 INFO - 'SHLVL': '1', 19:11:08 INFO - 'STYLO_FORCE_ENABLED': '1', 19:11:08 INFO - 'TERM': 'linux', 19:11:08 INFO - 'TMOUT': '86400', 19:11:08 INFO - 'USER': 'cltbld', 19:11:08 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315', 19:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:08 INFO - '_': '/tools/buildbot/bin/python'} 19:11:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 19:11:08 INFO - mozversion application_buildid: 20170807011658 19:11:08 INFO - mozversion application_changeset: 813810854eeaae9f2c5cb8f6879f91ac45e5038a 19:11:08 INFO - mozversion application_display_name: Nightly 19:11:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:08 INFO - mozversion application_name: Firefox 19:11:08 INFO - mozversion application_remotingname: firefox 19:11:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:11:08 INFO - mozversion application_vendor: Mozilla 19:11:08 INFO - mozversion application_version: 57.0a1 19:11:08 INFO - mozversion platform_buildid: 20170807011658 19:11:08 INFO - mozversion platform_changeset: 813810854eeaae9f2c5cb8f6879f91ac45e5038a 19:11:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:11:08 INFO - mozversion platform_version: 57.0a1 19:11:08 INFO - using testdate: 1502071868 19:11:08 INFO - actual date: 1502071868 19:11:08 INFO - starting webserver on 'localhost:59519' 19:11:08 INFO - SUITE-START | Running 2 tests 19:11:08 INFO - TEST-START | dromaeo_css 19:11:08 INFO - Initialising browser for dromaeo_css test... 19:11:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59519/getInfo.html -profile /tmp/tmpTOQ1MY/profile 19:11:08 INFO - TEST-INFO | started process 16009 (/builds/slave/test/build/application/firefox/firefox http://localhost:59519/getInfo.html) 19:11:14 INFO - TEST-INFO | 16009: exit 0 19:11:14 INFO - Browser initialized. 19:11:14 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:14 INFO - TEST-INFO | started process 16237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTOQ1MY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:15 INFO - PID 16237 | 19:11:15 INFO - PID 16237 | (/builds/slave/test/build/application/firefox/firefox:16290): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:11:15 INFO - PID 16237 | 19:11:26 INFO - PID 16237 | RSS: Main: 169779200 19:11:26 INFO - PID 16237 | 19:11:26 INFO - PID 16237 | serialization: Helvetica 19:11:26 INFO - PID 16237 | serialization: Arial 19:14:25 INFO - PID 16237 | Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59519/tests/dromaeo/cssquery-ext.html) 19:14:26 INFO - PID 16237 | RSS: Main: 175333376 19:14:26 INFO - PID 16237 | 19:14:26 INFO - PID 16237 | serialization: Helvetica 19:14:26 INFO - PID 16237 | serialization: Arial 19:17:28 INFO - PID 16237 | Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-ext.html (next: http://localhost:59519/tests/dromaeo/cssquery-jquery.html) 19:17:29 INFO - PID 16237 | RSS: Main: 172277760 19:17:29 INFO - PID 16237 | 19:17:29 INFO - PID 16237 | serialization: Helvetica 19:17:29 INFO - PID 16237 | serialization: Arial 19:20:30 INFO - PID 16237 | Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59519/tests/dromaeo/cssquery-mootools.html) 19:20:31 INFO - PID 16237 | RSS: Main: 174284800 19:20:31 INFO - PID 16237 | 19:20:31 INFO - PID 16237 | serialization: Helvetica 19:20:31 INFO - PID 16237 | serialization: Arial 19:23:33 INFO - PID 16237 | Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59519/tests/dromaeo/cssquery-prototype.html) 19:23:34 INFO - PID 16237 | RSS: Main: 173371392 19:23:34 INFO - PID 16237 | 19:23:34 INFO - PID 16237 | serialization: Helvetica 19:23:34 INFO - PID 16237 | serialization: Arial 19:26:37 INFO - PID 16237 | Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59519/tests/dromaeo/cssquery-yui.html) 19:26:38 INFO - PID 16237 | RSS: Main: 175874048 19:26:38 INFO - PID 16237 | 19:26:38 INFO - PID 16237 | serialization: Helvetica 19:26:38 INFO - PID 16237 | serialization: Arial 19:29:39 INFO - PID 16237 | Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-yui.html (next: http://localhost:59519/tests/dromaeo/cssquery-dojo.html) 19:29:40 INFO - PID 16237 | RSS: Main: 177139712 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | __start_tp_report 19:29:40 INFO - PID 16237 | _x_x_mozilla_page_load 19:29:40 INFO - PID 16237 | _x_x_mozilla_page_load_details 19:29:40 INFO - PID 16237 | |i|pagename|runs| 19:29:40 INFO - PID 16237 | |0;dojo.html;3112.3775244951016;3136.310011797407;3136.341368312655;3167.3506931079132;3218.1954511372155;6147.907781383277;6164.5376596755195;6264.154339164205;6286.119943207943;6359.936400635992;6092.299385570661;6222.160008398865;6250.687465626723;6257.4368306852375;6268.498520118391;5672.404397538261;5711.086226203808;5730.914036289459;5734.856628584298;5760.7695692172265;5723.771049158028;5738.368779434259;5771.942280577204;5823.5341172706085;5840.357560668344;5720.485156335929;5799.65202087874;5810.854728631797;5817.476427121558;5843.2403787507565;5492.148716948879;5664.433556644344;5677.290338707661;5716.342620598602;5828.941710582903;5211.443146575468;5601.103823388238;5643.68959707216;5688.061469857468;5731.455511726421;6109.389061093855;6112.786052488142;6130.264368275791;6205.7517699291975;6218.28489723683;6566.540342176049;6592.802215933481;6609.801705948781;6685.966570167118;6701.195856497203;6760.256371799098;6767.323267673242;6772.72909083636;6776.593404395752;6777.288384719583;6250.374962503759;6254.374562543755;6263.71813268404;6267.091271765568;6268.686565671698;6905.896411553831;6910.827229319308;6967.163940327092;6988.951657251453;7002.1947476040905;6570.770023049266;6588.571742836701;6595.538312318187;6639.933600664028;6686.7993960181275;6547.770828020996;6642.501812364092;6678.899816502756;6703.430208432241;6746.359095885883;6691.531592788556;6731.32686731323;6733.091032710521;6757.898631520531;6767.120274364301;6701.028350889093;6720.462363010947;6783.62690052042;6801.863962720718;6811.659417029129;5403.162509810985;5423.186522021729;5460.563154947595;5489.3687225969525;5504.91742623861;4546.363509108662;4631.096936097429;4632.97683511587;4724.763761811964;4742;5803.912941305884;5822.214001109796;5824.708764561755;5826.708664566755;5857.179994800731;6641.203055633258;6691.096701945273;6805.319468053155;6817.0796942413135;6822.3859852613505;5757.769689212469;5776.393478684761;5828.038373668382;5849.151872978395;5861.765529378862;5775.826725198251;5890.646561206341;5901.144334071536;5968.582199246011;6028.819135425944;6545.574537655038;6555.344465553407;6572.934270657328;6573.671316434255;6597.30728273534;6705.262421133769;6731.158605174353;6807;6834.316568343126;6840.110785597841;6475.352464753487;6493.448056915215;6507.804765857032;6583.341665833378;6607.273199948098;6415.518836087405;6580.5064620154635;6604.24051234095;6682.231543372574;6701.497387695845;6823.658817059028;6841.555298905555;6841.62371069596;6843.520953533205;6871.278515755774;6492.5455218134275;6507.707153178213;6602.306757790555;6609.834754131185;6611.867762644816;6485.708143133665;6494.447971922251;6503.382178693017;6585.440237579859;6598.04328372393;6314.336994615683;6425.261094973951;6432.2602900667025;6493.740250389931;6507.446867016357;6488.545801793829;6567.868642627216;6617.073609694743;6620.90068648961;6693.799186024427;6260.186175797117;6341.365863413622;6381.968090159519;6447.6131432114225;6498.967505162444 19:29:40 INFO - PID 16237 | |1;ext.html;830.8130670599112;873.4409977614326;886.9024407315198;890.8040231149147;1178.9764204715912;31567.684323156762;42420.787896060516;42862.785686071606;42969;42998.78500607496;42954;43103.78448107763;43191.136177276436;43242.135157296834;43337;7807.882881756764;7935.841283174333;7960.562169080698;7964.323032542241;8000.559969201691;7767.417443691746;7871.645775940068;7876.173001834811;7889.960550197241;7891.487053341514;7722.575258360788;7826.608669566527;7829.451938364316;7833.373330133604;7839.921600784005;7764.650590723403;7770.728024519171;7827.099883513383;7831.530108193527;7853.607319634052;7705.807354816118;7773.3004029637605;7805.219478052206;7822.1786712395515;7824.178461261543;40119.19761604781;40422.59577404247;40430.39354409686;40478.59521404807;40482.39276410856;3579.6778289954027;3605.7475976681644;3607.6392360763975;3611.837467313951;3615.7649752766247;32191.839040804647;32231.355372892413;32291.354172916646;32313.353732925443;32341.191470213198;5002.699838009695;5053.393592768891;5072.51811077947;5080.949190508085;5099.59203263738;190763;192081.23756287474;192461;192502;192520;48926.042958281985;48944.510554894;49148.508514915105;49195.262071068966;49324.506754931994;51217;51784;51826;51999;52004.47995520072;16215.918920405322;16387.180640967905;16416;16583;16600.169991500617;13498.59504214875;13509;13525.256110913797;13525.59423217305;13530.18818870871;13306.334683265992;13522.594322170351;13756.587302380945;14771.482998095014;15123.243837808286;5890;6076.513878889678;6141.447269745655;6152.692365381802;6259.937400625936;996.9601215951426;998.6554638649654;1010.6664800615779;1023.6110278094426;1023.8668973033458;23084.65373019406;28519.287017824307;28995.695193716332;29137.708622913924;29389.559156612668;1055.3140458701905;1086.4893500054961;1088.684281558355;1100.5652767156928;1102.388174563109;12472.750544989049;12602.432890519949;12607.369631518388;12622.179558328678;16774.83225167757;235875;240970;241220;241279;241296;62331.37668623347;62475.375246247866;62612;62750.686246568475;62785.37214627887;1450.3400952566558;1512.4252783942252;1521.0341433190003;1533.8466153384795;1559.9220038998005;27538;27994.44011119807;28051.43897122087;28297.858510708138;28497;39742.40386394149;39859.80070099631;39958.200835982534;40018;40067.59932400638;213868;214518;223936;228197;230420;39819.80090099531;39841.40237896376;40049.1990160201;40064.3990340151;40259.39610905897;42834;49790;49799.50200498094;50282.497175027784;50657.240141397175;36234.8188259057;36681.816590916875;36710.63289367072;36973.6302636981;37114.07214819651;36043.81978090093;36424.63575364213;36425.271494570494;36454.27091458103;36863;39007.219855603296;39144.6085539141;39467.80266098651;39497;39740;34924.30151396907;34962;34965.825170873984;35412.645873541966;35464.46803297901;24800;25036.62445063289;25171.87414062918;25260;25496.490070198863 19:29:40 INFO - PID 16237 | |2;jquery.html;569.4419468920457;576.3947854752508;587.321643501755;594.9643021418715;599.682168450721;22498.775012249873;22872.542549149006;23256.18603348883;23368.415789605246;23390.181343652956;26860.328491787666;27406.5889011665;27597;27620;27633.44733105337;6571.408573228408;6760.763373281936;6761.628110453923;6764.154480689914;6764.729410823561;5970.134330522072;6505.316941721122;6509.544331896769;6569.080328753978;6714.597124172566;6495.967520162392;6542.247641521215;6545.803625891231;6549.967250163742;6552.475801935833;6454.257760357572;6467.870642587169;6502.93497065028;6531.379518945692;6533.640649764261;6017.879642407172;6038.486728628071;6050.515958723292;6053.485453736438;6058.96970515149;28858.278543036384;29595.852020739974;30120.397592048255;30180.547291790423;30375.24061898448;1872.5505878589177;1892.3660573707825;1898.364048043907;1902.1535416739557;1907.895065771382;19881;20311;20333.491662708402;20434.489137771525;20491.897540512353;2402.759724027583;2445.6453814196843;2452.497238066192;2505.7744802967636;2507.9498410031697;137583;140620;140774;141104.99999999898;141279.29360353132;14762;15287.388504459697;15499.147546884804;15504.534863954099;15517.612059698598;23906.880465597907;23996.64005039926;24039.7596024041;24106.638400423657;24167.274981750223;10129.341592796445;10302.857628423253;10369.429681367597;10433.32183408076;10512.684619461428;8357.95821020891;9444.480553569481;9477.383970041925;9539.284553658503;9641.42151470914;8216.917830821734;9144.81710365789;9199.218066464426;9361.812763744823;9531.237500999903;2732.8770205340807;2743.547314693053;2804.901828435995;2808;2828.6322778038725;956.3449037409258;961.4711908450324;976.916962058233;977.2768151567789;985.4186030242191;19740.40778776639;19845.244878984933;19921.60156796856;20358;20511.692324615142;1034.6689059501039;1040.6773900090996;1040.9479526023667;1045.4197920154388;1047.4448542272607;10941.507632156572;10974.780504390028;11116.888831111748;11176.944115279533;11219.943900280447;527972;528815;561835;562159;570308.2969170338;122753;123669.38165309116;124547;124691.37654311852;124909;1263.4251415605877;1290.8450985881755;1335.8263425754783;1338.9263590502421;1339.9464021439228;20924;20961.790382095984;20991.265305714838;21192.688522460343;21414.892925535274;56165.71917140388;56766.432335676116;57051;57385.71307143437;59129.70435147969;69713;69743;69937.65031174812;70238.29761702317;70344.29655703582;14689.338979745724;15116;15133.243337832844;15159.772603410736;15177.468788592347;23509.177178799346;23562.76437235674;23615.173468928504;23808.523829522965;23850.52298954046;18485.63028739391;19037.23851045998;19104.904475477535;19169.712454313474;19184.71222931685;16641;17054.658906822042;17137.74293385625;17196.828031719524;17242.913785430992;19113.61772764509;19568.11943462519;19749.308774192836;19752.802471975097;20014.599708006048;14870;14896.62758431048;14986.85013149898;15002.099874007594;15057.247137643293;18388;18952.86282823035;19090.618187635893;19229.615407692047;19248.903755481133 19:29:40 INFO - PID 16237 | |3;mootools.html;1340.4035204334073;1379.2276325257856;1384.4254634326755;1390.9095908765926;1393.6446206217413;13658.31708414579;14253.572392828206;14257.215853128073;14261.35823887925;14696;14440.783388249185;14741;14747;14751.04118232314;14787.778183327258;2313.3060081975423;2591.2096810472844;2639.4721055788823;2655.4556315955183;2670.052131493321;2281.2243837095384;2602.8958841646404;2656.0836511403536;2657.481791050746;2673.612326212698;2624.8293860899075;2653.177514970356;2689.690685571165;2695.9595606065923;2703.2701170683904;2546.4907018596355;2548.197317844882;2552.5150221457957;2553.553128202576;2555.0418593027616;2510.071273628769;2519.143491212978;2544.4911017796517;2561.244432892301;2573.3566608347915;13596.38816253271;13951;13997.230152341617;14001.299935003311;14005.159690418608;7612.200718924544;7888.053433588007;7907.288344049006;7911.327537159348;7935.206479352077;4824.842037910911;5045.772940217699;5121.795128194868;5154.845354639367;5177.689338639693;1757.5254681235995;1814.564504518906;1835.0732879895568;1859.414284500378;1875.2967637136073;23218.883905580533;23254.186103486296;23301.650475242885;23368.883155584113;23373.649395259086;6734.3602357775935;7149.142102947576;7218.927810721931;7262.620102180569;7279.381252593589;16302.962129733784;16400.26198821056;16452.341906323614;16530.09084500364;16569.171541422882;7674.9232507674205;7698.576578288136;7788.299053085249;8023.438359314909;8084.919150808417;7019.89470157948;7133.108361454818;7146.285371462812;7156.24859389767;7191.748288809867;5028.195488721787;5117.692938423706;5139.871503212375;5161.096808058574;5206.245094461282;1521.9086854788527;1525.8855585831107;1547.1954583616457;1561;1562.3672412672886;890.5636238243214;897.3494216692845;905.3752910491871;907.4237858959608;907.5507623726297;7144.64276786169;7250.16623088341;7315.780526584211;7348.787450070786;7387.889181662279;715.1668306423063;715.6171448275252;719.144994372341;741.1439787045971;742.1761844352764;4431.202383570923;4725.9527404726205;4834.903301933941;5063.392392912874;5145.202493613496;18974;19003.42989710311;19022;19236.71144932827;19685.901570492057;18680.906595467208;19624.21503139887;19658.41024769259;19677;19744.70382944257;10822.134229261641;10868.728281793019;11000.559977600806;11023.944880275547;11061.778764424667;7579.62101894892;7842.647080881488;7859.9607001966915;7923.128455869734;7940.6029698515995;16504.17479126063;16713.331466741194;16931;17022.659546809242;17041.318347266468;17101;17184.484465466056;17355.913220433817;17412;17753.289868405118;11268.38023908693;11522.654320370402;11544.01875840563;11545.942270288595;11558.826617600911;12778.872211277769;13082.149660272053;13153.736925261632;13174.670633234246;13217.603471895858;10698.14414846826;10732.570697172338;10779.946100269763;10815.729606759895;11022.779544409228;10438;10554.261201715806;10639.308444951053;10852.891471085188;10978.725531861768;8996.640134394813;9004.864927025968;9047.140521650434;9062.410943288665;9101.271898248257;6982.022516847747;7051.365377116084;7084.305630347641;7183.461240406886;7300.306470885257;7291.489595728461;7412.888806667796;7495.775126746206;7500.549967001997;7542.245775422414 19:29:40 INFO - PID 16237 | |4;prototype.html;487.5997524202808;511.0851575679534;520.0898427751436;521.5827338129496;534.5216031651672;6183.690815459231;6259.937400625992;6271.498280137589;6289.088082228074;6301.590396624216;6101.901657701623;6104.908426373608;6172.629642221458;6186.659733714644;6203.813885583429;5110.718910459923;5143.665661731994;5144.845654630367;5173.560247378959;5177.378714554259;4778.976105119469;4939.555440010398;4998.950010499903;5036.169032109698;5116;4805.687630304036;4817.735024573647;4821.963277895252;4878.219484882419;4895.632827537949;4842.709437433765;4869.14789911764;4875.390576177978;4880.487548807395;4887.511248875084;4295.613394794453;4346.695731298811;4390.868273951786;4403.2954727243805;4415.116976604692;5839.591228613998;5868.9413105868825;5896.262967129109;5956.315023772278;5958.880822383528;5595.1886976388605;5623.8594035149035;5640.689762063085;5693.601447898649;5703.942960570383;6204.4944606297295;6352.6823658816875;6378.23906658943;6423.325550817143;6449.516286278548;4745.501722319142;4775.570198682135;4777.378940737716;4841.467438581753;4865.635077369176;6618.93381066188;6727.495437842182;6786.287439818847;6829.658517074176;6869.4847886408215;4762.571368576845;4839.41926968766;4844.515548445198;4863.562279394871;4916.926246106311;4915.729634870045;4936.703797772145;4941.901161976741;4945.060438516671;4955.90088198234;5562.638428502134;5581.441855814467;5583.246261754693;5604.8318550443555;5650.124230744159;6519.837004074936;6522.739090436425;6567.277599464055;6569.67151642416;6596.373344532261;1760.0935518208132;1763.615561784019;1767.9823201768074;1776.4670598820303;1777.6178121703895;1148.2995372822572;1212.593781083347;1224.4122821045949;1224.6448529926222;1242.763874863773;5571.359293681197;5702.2301989231755;5730.828075157752;5743.741531631086;5778.451047150514;6594.7032383542855;6641.1404806653245;6662;6701.798946031627;6727.562708423937;5587.189857470644;5640.53346130001;5698.914516282259;5704.971475142681;5720.3421606515785;3498.317828023562;3539.734519911017;3552.307300076512;3563.198280386944;3572.160542272564;6468.741250349934;6528.412442880163;6548.312427195171;6555.639439830759;6577.914644083673;6636.369544893228;6717.951024937343;6776.832248167341;6867.695137923779;6886.10480637514;6320.841978950563;6353.428191462791;6413.038044293487;6464.288928217892;6520.239535325531;6502.252240992347;6572.737090516517;6584.176977877765;6619.106420633153;6659.7003134860015;6029.246344206974;6523.836904077436;6575.4410875076155;6576.046473261446;6582.473402127914;6383;6424.2933277338525;6461.709223084878;6490.7079181436;6525.673716314071;4931.260310953386;4943.826966056171;4952.653314268111;5009;5019.247112933089;6369.617822930639;6494.155759751202;6597.701149425287;6676.699548520425;6724.260331363448;6325.715342809676;6366.236051673829;6382;6425.646589437439;6462.935370646233;6360.823247699191;6383.297837237993;6455;6473.255575608865;6492.285848556749;6187.84530386744;6298.244210694746;6368;6393.968030159819;6402.551821372459;6492;6511.5256202642695;6555.836573930496;6562.245341785756;6606.141201643755;6324.588901721373;6351.96824015877;6381.521385895983;6391.840203994937;6404.263509696445 19:29:40 INFO - PID 16237 | |5;yui.html;892.5091199840091;917.2432742987036;931.4550987672209;932.2728271947879;933.1554942776781;19235.903820480897;20244.39266821996;20341.389758307258;20439.89780051098;22640.320790376314;20225;22459.663105053438;22490.32529024128;22590.096396144134;22629.773702262974;1018.0379541333461;1030.7165529479416;1031.881333646629;1031.8968103189695;1032.220673391592;948.6252930092609;1032.5611615063606;1047.1151876664208;1051.232600201853;1051.6739810658682;1086.8858769829174;1097.489667304703;1097.6213206443765;1098.132475344477;1098.242212873119;1088.847561341409;1092.9726756831064;1093.7211011192135;1094.5895289266525;1095.2552264460164;800.8598495263363;802.0575823407473;806.2501873257927;807.8747794091867;807.9838403231961;20154.69767953482;20255.493612659655;20395.8980205098;20446.284380046774;20905.790942090687;21801.454963625878;22275.108995640156;22374.105035798548;22770.31689049331;22930;16345.182740863029;16506.052385734034;16589;16612.169391530377;16970.66058678832;3516.085817687394;3580.695640870529;3597.262561174979;3619.6199399062984;3619.8733044343585;127613;127796;130843.34578327142;131449;131723;17317.826821731873;17542.473725788248;17733.822661773218;18221.817781822276;18288.08559572016;32683.34633307368;32918.506222406686;33194.50208246878;33221.66778332186;33410.66589334124;7717.073951125901;8057.677692892219;8360.749177524684;8754.387192896436;8888.511131887808;4263.232618128766;4351.673624478177;4377.299632058919;4378.562143785596;4382.211201983673;5180.9740951295;5244.239585260192;5286.97356513215;5320.893582128336;5350.438203988603;1044.9895501044891;1069.1660504806264;1079.1852151625471;1080.1304949515716;1082.8213344798178;493.4966334338954;495.8016793282716;514.8095204774257;515.8504033830147;519;10667.466626668636;10784.13726901846;10829.891701082888;11031.338119712844;12793.360331983364;541.0963690636646;543.8096666166889;545.3319683387818;545.9781608735685;550.6833570696865;4811.49479304668;4878.707277563358;4922.975385123052;5070.670406423571;5692.601517893708;92649.07350926404;100577;101843;102258;103157;85140;85690;86078.56960715157;86476.5676171615;87682;76786;79122.60438697769;81786.59106704548;83870.58064709637;84376.57811710902;11250.943745281222;11469.598564050219;11606.361650109326;11746.119041072125;11909.642710718692;36088;36484.45273320849;36543.45184822177;36559.45160822537;36678;44007.339889902316;44737.55262447464;44861.32708009448;45155.54844451514;45954;15838.68322633564;16258.51224463268;16306.673866522366;16518;16557.58606034859;18125.184366703266;18169;18225.90887045556;18295.359662411753;18463.16915738768;16015.839841601435;16247.187640618158;16300.103494307927;16335.183240838149;16430.178491075636;16167.27247273852;16241.756373654169;16292.837071629607;16351.509454716377;16443.67112657764;15337.233138343261;15416.99789513678;15524.534263972098;15525.146116963675;15583.84416155824;11108.944455277671;11133.610323638633;11209.55161793519;11231.71920701989;11577.073834093084;12657.873421266038;12824.935875320563;12844.807327890276;12898.613041608767;13041.282729449971 19:29:40 INFO - PID 16237 | __end_tp_report 19:29:40 INFO - PID 16237 | __start_cc_report 19:29:40 INFO - PID 16237 | _x_x_mozilla_cycle_collect,363 19:29:40 INFO - PID 16237 | __end_cc_report 19:29:40 INFO - PID 16237 | __startTimestamp1502072980231__endTimestamp 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | ------- Summary: start ------- 19:29:40 INFO - PID 16237 | Number of tests: 6 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | [#0] dojo.html Cycles:165 Average:6181.41 Median:6447.61 stddev:740.58 (11.5%) stddev-sans-first:702.62 19:29:40 INFO - PID 16237 | Values: 3112.4 3136.3 3136.3 3167.4 3218.2 6147.9 6164.5 6264.2 6286.1 6359.9 6092.3 6222.2 6250.7 6257.4 6268.5 5672.4 5711.1 5730.9 5734.9 5760.8 5723.8 5738.4 5771.9 5823.5 5840.4 5720.5 5799.7 5810.9 5817.5 5843.2 5492.1 5664.4 5677.3 5716.3 5828.9 5211.4 5601.1 5643.7 5688.1 5731.5 6109.4 6112.8 6130.3 6205.8 6218.3 6566.5 6592.8 6609.8 6686.0 6701.2 6760.3 6767.3 6772.7 6776.6 6777.3 6250.4 6254.4 6263.7 6267.1 6268.7 6905.9 6910.8 6967.2 6989.0 7002.2 6570.8 6588.6 6595.5 6639.9 6686.8 6547.8 6642.5 6678.9 6703.4 6746.4 6691.5 6731.3 6733.1 6757.9 6767.1 6701.0 6720.5 6783.6 6801.9 6811.7 5403.2 5423.2 5460.6 5489.4 5504.9 4546.4 4631.1 4633.0 4724.8 4742.0 5803.9 5822.2 5824.7 5826.7 5857.2 6641.2 6691.1 6805.3 6817.1 6822.4 5757.8 5776.4 5828.0 5849.2 5861.8 5775.8 5890.6 5901.1 5968.6 6028.8 6545.6 6555.3 6572.9 6573.7 6597.3 6705.3 6731.2 6807.0 6834.3 6840.1 6475.4 6493.4 6507.8 6583.3 6607.3 6415.5 6580.5 6604.2 6682.2 6701.5 6823.7 6841.6 6841.6 6843.5 6871.3 6492.5 6507.7 6602.3 6609.8 6611.9 6485.7 6494.4 6503.4 6585.4 6598.0 6314.3 6425.3 6432.3 6493.7 6507.4 6488.5 6567.9 6617.1 6620.9 6693.8 6260.2 6341.4 6382.0 6447.6 6499.0 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | [#1] ext.html Cycles:180 Average:40210.71 Median:39075.91 stddev:56783.74 (145.3%) stddev-sans-first:56866.04 19:29:40 INFO - PID 16237 | Values: 830.8 873.4 886.9 890.8 1179.0 31567.7 42420.8 42862.8 42969.0 42998.8 42954.0 43103.8 43191.1 43242.1 43337.0 7807.9 7935.8 7960.6 7964.3 8000.6 7767.4 7871.6 7876.2 7890.0 7891.5 7722.6 7826.6 7829.5 7833.4 7839.9 7764.7 7770.7 7827.1 7831.5 7853.6 7705.8 7773.3 7805.2 7822.2 7824.2 40119.2 40422.6 40430.4 40478.6 40482.4 3579.7 3605.7 3607.6 3611.8 3615.8 32191.8 32231.4 32291.4 32313.4 32341.2 5002.7 5053.4 5072.5 5080.9 5099.6 190763.0 192081.2 192461.0 192502.0 192520.0 48926.0 48944.5 49148.5 49195.3 49324.5 51217.0 51784.0 51826.0 51999.0 52004.5 16215.9 16387.2 16416.0 16583.0 16600.2 13498.6 13509.0 13525.3 13525.6 13530.2 13306.3 13522.6 13756.6 14771.5 15123.2 5890.0 6076.5 6141.4 6152.7 6259.9 997.0 998.7 1010.7 1023.6 1023.9 23084.7 28519.3 28995.7 29137.7 29389.6 1055.3 1086.5 1088.7 1100.6 1102.4 12472.8 12602.4 12607.4 12622.2 16774.8 235875.0 240970.0 241220.0 241279.0 241296.0 62331.4 62475.4 62612.0 62750.7 62785.4 1450.3 1512.4 1521.0 1533.8 1559.9 27538.0 27994.4 28051.4 28297.9 28497.0 39742.4 39859.8 39958.2 40018.0 40067.6 213868.0 214518.0 223936.0 228197.0 230420.0 39819.8 39841.4 40049.2 40064.4 40259.4 42834.0 49790.0 49799.5 50282.5 50657.2 36234.8 36681.8 36710.6 36973.6 37114.1 36043.8 36424.6 36425.3 36454.3 36863.0 39007.2 39144.6 39467.8 39497.0 39740.0 34924.3 34962.0 34965.8 35412.6 35464.5 24800.0 25036.6 25171.9 25260.0 25496.5 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | [#2] jquery.html Cycles:180 Average:37070.43 Median:23535.97 stddev:92172.28 (391.6%) stddev-sans-first:92390.10 19:29:40 INFO - PID 16237 | Values: 569.4 576.4 587.3 595.0 599.7 22498.8 22872.5 23256.2 23368.4 23390.2 26860.3 27406.6 27597.0 27620.0 27633.4 6571.4 6760.8 6761.6 6764.2 6764.7 5970.1 6505.3 6509.5 6569.1 6714.6 6496.0 6542.2 6545.8 6550.0 6552.5 6454.3 6467.9 6502.9 6531.4 6533.6 6017.9 6038.5 6050.5 6053.5 6059.0 28858.3 29595.9 30120.4 30180.5 30375.2 1872.6 1892.4 1898.4 1902.2 1907.9 19881.0 20311.0 20333.5 20434.5 20491.9 2402.8 2445.6 2452.5 2505.8 2507.9 137583.0 140620.0 140774.0 141105.0 141279.3 14762.0 15287.4 15499.1 15504.5 15517.6 23906.9 23996.6 24039.8 24106.6 24167.3 10129.3 10302.9 10369.4 10433.3 10512.7 8358.0 9444.5 9477.4 9539.3 9641.4 8216.9 9144.8 9199.2 9361.8 9531.2 2732.9 2743.5 2804.9 2808.0 2828.6 956.3 961.5 976.9 977.3 985.4 19740.4 19845.2 19921.6 20358.0 20511.7 1034.7 1040.7 1040.9 1045.4 1047.4 10941.5 10974.8 11116.9 11176.9 11219.9 527972.0 528815.0 561835.0 562159.0 570308.3 122753.0 123669.4 124547.0 124691.4 124909.0 1263.4 1290.8 1335.8 1338.9 1339.9 20924.0 20961.8 20991.3 21192.7 21414.9 56165.7 56766.4 57051.0 57385.7 59129.7 69713.0 69743.0 69937.7 70238.3 70344.3 14689.3 15116.0 15133.2 15159.8 15177.5 23509.2 23562.8 23615.2 23808.5 23850.5 18485.6 19037.2 19104.9 19169.7 19184.7 16641.0 17054.7 17137.7 17196.8 17242.9 19113.6 19568.1 19749.3 19752.8 20014.6 14870.0 14896.6 14986.9 15002.1 15057.2 18388.0 18952.9 19090.6 19229.6 19248.9 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | [#3] mootools.html Cycles:180 Average:8763.82 Median:2547.34 stddev:6010.22 (235.9%) stddev-sans-first:6001.20 19:29:40 INFO - PID 16237 | Values: 1340.4 1379.2 1384.4 1390.9 1393.6 13658.3 14253.6 14257.2 14261.4 14696.0 14440.8 14741.0 14747.0 14751.0 14787.8 2313.3 2591.2 2639.5 2655.5 2670.1 2281.2 2602.9 2656.1 2657.5 2673.6 2624.8 2653.2 2689.7 2696.0 2703.3 2546.5 2548.2 2552.5 2553.6 2555.0 2510.1 2519.1 2544.5 2561.2 2573.4 13596.4 13951.0 13997.2 14001.3 14005.2 7612.2 7888.1 7907.3 7911.3 7935.2 4824.8 5045.8 5121.8 5154.8 5177.7 1757.5 1814.6 1835.1 1859.4 1875.3 23218.9 23254.2 23301.7 23368.9 23373.6 6734.4 7149.1 7218.9 7262.6 7279.4 16303.0 16400.3 16452.3 16530.1 16569.2 7674.9 7698.6 7788.3 8023.4 8084.9 7019.9 7133.1 7146.3 7156.2 7191.7 5028.2 5117.7 5139.9 5161.1 5206.2 1521.9 1525.9 1547.2 1561.0 1562.4 890.6 897.3 905.4 907.4 907.6 7144.6 7250.2 7315.8 7348.8 7387.9 715.2 715.6 719.1 741.1 742.2 4431.2 4726.0 4834.9 5063.4 5145.2 18974.0 19003.4 19022.0 19236.7 19685.9 18680.9 19624.2 19658.4 19677.0 19744.7 10822.1 10868.7 11000.6 11023.9 11061.8 7579.6 7842.6 7860.0 7923.1 7940.6 16504.2 16713.3 16931.0 17022.7 17041.3 17101.0 17184.5 17355.9 17412.0 17753.3 11268.4 11522.7 11544.0 11545.9 11558.8 12778.9 13082.1 13153.7 13174.7 13217.6 10698.1 10732.6 10779.9 10815.7 11022.8 10438.0 10554.3 10639.3 10852.9 10978.7 8996.6 9004.9 9047.1 9062.4 9101.3 6982.0 7051.4 7084.3 7183.5 7300.3 7291.5 7412.9 7495.8 7500.5 7542.2 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | [#4] prototype.html Cycles:180 Average:5443.63 Median:6065.57 stddev:1523.09 (25.1%) stddev-sans-first:1481.24 19:29:40 INFO - PID 16237 | Values: 487.6 511.1 520.1 521.6 534.5 6183.7 6259.9 6271.5 6289.1 6301.6 6101.9 6104.9 6172.6 6186.7 6203.8 5110.7 5143.7 5144.8 5173.6 5177.4 4779.0 4939.6 4999.0 5036.2 5116.0 4805.7 4817.7 4822.0 4878.2 4895.6 4842.7 4869.1 4875.4 4880.5 4887.5 4295.6 4346.7 4390.9 4403.3 4415.1 5839.6 5868.9 5896.3 5956.3 5958.9 5595.2 5623.9 5640.7 5693.6 5703.9 6204.5 6352.7 6378.2 6423.3 6449.5 4745.5 4775.6 4777.4 4841.5 4865.6 6618.9 6727.5 6786.3 6829.7 6869.5 4762.6 4839.4 4844.5 4863.6 4916.9 4915.7 4936.7 4941.9 4945.1 4955.9 5562.6 5581.4 5583.2 5604.8 5650.1 6519.8 6522.7 6567.3 6569.7 6596.4 1760.1 1763.6 1768.0 1776.5 1777.6 1148.3 1212.6 1224.4 1224.6 1242.8 5571.4 5702.2 5730.8 5743.7 5778.5 6594.7 6641.1 6662.0 6701.8 6727.6 5587.2 5640.5 5698.9 5705.0 5720.3 3498.3 3539.7 3552.3 3563.2 3572.2 6468.7 6528.4 6548.3 6555.6 6577.9 6636.4 6718.0 6776.8 6867.7 6886.1 6320.8 6353.4 6413.0 6464.3 6520.2 6502.3 6572.7 6584.2 6619.1 6659.7 6029.2 6523.8 6575.4 6576.0 6582.5 6383.0 6424.3 6461.7 6490.7 6525.7 4931.3 4943.8 4952.7 5009.0 5019.2 6369.6 6494.2 6597.7 6676.7 6724.3 6325.7 6366.2 6382.0 6425.6 6462.9 6360.8 6383.3 6455.0 6473.3 6492.3 6187.8 6298.2 6368.0 6394.0 6402.6 6492.0 6511.5 6555.8 6562.2 6606.1 6324.6 6352.0 6381.5 6391.8 6404.3 19:29:40 INFO - PID 16237 | 19:29:40 INFO - PID 16237 | [#5] yui.html Cycles:180 Average:22113.53 Median:20234.70 stddev:30034.33 (148.4%) stddev-sans-first:30076.31 19:29:40 INFO - PID 16237 | Values: 892.5 917.2 931.5 932.3 933.2 19235.9 20244.4 20341.4 20439.9 22640.3 20225.0 22459.7 22490.3 22590.1 22629.8 1018.0 1030.7 1031.9 1031.9 1032.2 948.6 1032.6 1047.1 1051.2 1051.7 1086.9 1097.5 1097.6 1098.1 1098.2 1088.8 1093.0 1093.7 1094.6 1095.3 800.9 802.1 806.3 807.9 808.0 20154.7 20255.5 20395.9 20446.3 20905.8 21801.5 22275.1 22374.1 22770.3 22930.0 16345.2 16506.1 16589.0 16612.2 16970.7 3516.1 3580.7 3597.3 3619.6 3619.9 127613.0 127796.0 130843.3 131449.0 131723.0 17317.8 17542.5 17733.8 18221.8 18288.1 32683.3 32918.5 33194.5 33221.7 33410.7 7717.1 8057.7 8360.7 8754.4 8888.5 4263.2 4351.7 4377.3 4378.6 4382.2 5181.0 5244.2 5287.0 5320.9 5350.4 1045.0 1069.2 1079.2 1080.1 1082.8 493.5 495.8 514.8 515.9 519.0 10667.5 10784.1 10829.9 11031.3 12793.4 541.1 543.8 545.3 546.0 550.7 4811.5 4878.7 4923.0 5070.7 5692.6 92649.1 100577.0 101843.0 102258.0 103157.0 85140.0 85690.0 86078.6 86476.6 87682.0 76786.0 79122.6 81786.6 83870.6 84376.6 11250.9 11469.6 11606.4 11746.1 11909.6 36088.0 36484.5 36543.5 36559.5 36678.0 44007.3 44737.6 44861.3 45155.5 45954.0 15838.7 16258.5 16306.7 16518.0 16557.6 18125.2 18169.0 18225.9 18295.4 18463.2 16015.8 16247.2 16300.1 16335.2 16430.2 16167.3 16241.8 16292.8 16351.5 16443.7 15337.2 15417.0 15524.5 15525.1 15583.8 11108.9 11133.6 11209.6 11231.7 11577.1 12657.9 12824.9 12844.8 12898.6 13041.3 19:29:40 INFO - PID 16237 | -------- Summary: end -------- 19:29:40 INFO - PID 16237 | 19:29:41 INFO - TEST-INFO | 16237: exit 0 19:29:41 INFO - TEST-OK | dromaeo_css | took 1112466ms 19:29:41 INFO - TEST-START | kraken 19:29:41 INFO - Initialising browser for kraken test... 19:29:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59519/getInfo.html -profile /tmp/tmpQpLLNp/profile 19:29:41 INFO - TEST-INFO | started process 16616 (/builds/slave/test/build/application/firefox/firefox http://localhost:59519/getInfo.html) 19:29:46 INFO - TEST-INFO | 16616: exit 0 19:29:46 INFO - Browser initialized. 19:29:46 INFO - Running cycle 1/1 for kraken test... 19:29:46 INFO - TEST-INFO | started process 16842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpLLNp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:47 INFO - PID 16842 | 19:29:47 INFO - PID 16842 | (/builds/slave/test/build/application/firefox/firefox:16896): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:29:47 INFO - PID 16842 | 19:29:58 INFO - PID 16842 | RSS: Main: 173760512 19:29:58 INFO - PID 16842 | 19:29:58 INFO - PID 16842 | serialization: Helvetica 19:29:58 INFO - PID 16842 | serialization: Arial 19:30:00 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:01 INFO - PID 16842 | RSS: Main: 178958336 19:30:01 INFO - PID 16842 | 19:30:01 INFO - PID 16842 | serialization: Helvetica 19:30:01 INFO - PID 16842 | serialization: Arial 19:30:04 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-dft) 19:30:05 INFO - PID 16842 | RSS: Main: 179159040 19:30:05 INFO - PID 16842 | 19:30:05 INFO - PID 16842 | serialization: Helvetica 19:30:05 INFO - PID 16842 | serialization: Arial 19:30:08 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-fft) 19:30:08 INFO - PID 16842 | RSS: Main: 174137344 19:30:08 INFO - PID 16842 | 19:30:08 INFO - PID 16842 | serialization: Helvetica 19:30:08 INFO - PID 16842 | serialization: Arial 19:30:10 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-oscillator) 19:30:11 INFO - PID 16842 | RSS: Main: 174764032 19:30:11 INFO - PID 16842 | 19:30:11 INFO - PID 16842 | serialization: Helvetica 19:30:11 INFO - PID 16842 | serialization: Arial 19:30:13 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:14 INFO - PID 16842 | RSS: Main: 175005696 19:30:14 INFO - PID 16842 | 19:30:14 INFO - PID 16842 | serialization: Helvetica 19:30:14 INFO - PID 16842 | serialization: Arial 19:30:17 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59519/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:18 INFO - PID 16842 | RSS: Main: 177487872 19:30:18 INFO - PID 16842 | 19:30:18 INFO - PID 16842 | serialization: Helvetica 19:30:18 INFO - PID 16842 | serialization: Arial 19:30:21 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59519/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:22 INFO - PID 16842 | RSS: Main: 177090560 19:30:22 INFO - PID 16842 | 19:30:22 INFO - PID 16842 | serialization: Helvetica 19:30:22 INFO - PID 16842 | serialization: Arial 19:30:25 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59519/tests/kraken/driver.html?testName=json-parse-financial) 19:30:25 INFO - PID 16842 | RSS: Main: 177647616 19:30:25 INFO - PID 16842 | 19:30:25 INFO - PID 16842 | serialization: Helvetica 19:30:25 INFO - PID 16842 | serialization: Arial 19:30:27 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:28 INFO - PID 16842 | RSS: Main: 178335744 19:30:28 INFO - PID 16842 | 19:30:28 INFO - PID 16842 | serialization: Helvetica 19:30:28 INFO - PID 16842 | serialization: Arial 19:30:30 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:30 INFO - PID 16842 | RSS: Main: 175075328 19:30:30 INFO - PID 16842 | 19:30:30 INFO - PID 16842 | serialization: Helvetica 19:30:30 INFO - PID 16842 | serialization: Arial 19:30:32 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:33 INFO - PID 16842 | RSS: Main: 175181824 19:30:33 INFO - PID 16842 | 19:30:33 INFO - PID 16842 | serialization: Helvetica 19:30:33 INFO - PID 16842 | serialization: Arial 19:30:36 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:37 INFO - PID 16842 | RSS: Main: 175214592 19:30:37 INFO - PID 16842 | 19:30:37 INFO - PID 16842 | serialization: Helvetica 19:30:37 INFO - PID 16842 | serialization: Arial 19:30:40 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:40 INFO - PID 16842 | RSS: Main: 175173632 19:30:40 INFO - PID 16842 | 19:30:40 INFO - PID 16842 | serialization: Helvetica 19:30:40 INFO - PID 16842 | serialization: Arial 19:30:42 INFO - PID 16842 | Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59519/tests/kraken/driver.html?testName=ai-astar) 19:30:42 INFO - PID 16842 | RSS: Main: 176766976 19:30:42 INFO - PID 16842 | 19:30:42 INFO - PID 16842 | __start_tp_report 19:30:42 INFO - PID 16842 | _x_x_mozilla_page_load 19:30:42 INFO - PID 16842 | _x_x_mozilla_page_load_details 19:30:42 INFO - PID 16842 | |i|pagename|runs| 19:30:42 INFO - PID 16842 | |0;ai-astar;97;108;103;106;108;109;110;100;112;107 19:30:42 INFO - PID 16842 | |1;audio-beat-detection;143;118;140;173;121;148;151;120;172;129 19:30:42 INFO - PID 16842 | |2;audio-dft;163;164;163;167;161;162;168;168;161;164 19:30:42 INFO - PID 16842 | |3;audio-fft;76;74;75;182;75;78;75;91;96;75 19:30:43 INFO - PID 16842 | |4;audio-oscillator;84;79;132;79;80;78;141;80;81;120 19:30:43 INFO - PID 16842 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;115;119;116 19:30:43 INFO - PID 16842 | |6;imaging-darkroom;151;151;149;151;154;151;151;150;156;160 19:30:43 INFO - PID 16842 | |7;imaging-desaturate;93;97;98;94;93;94;95;94;95;94 19:30:43 INFO - PID 16842 | |8;json-parse-financial;54;57;57;59;55;54;54;53;57;58 19:30:43 INFO - PID 16842 | |9;json-stringify-tinderbox;56;54;55;54;53;58;54;62;58;54 19:30:43 INFO - PID 16842 | |10;stanford-crypto-aes;77;90;81;90;81;80;83;89;92;87 19:30:43 INFO - PID 16842 | |11;stanford-crypto-ccm;146;143;125;137;129;125;129;124;134;179 19:30:43 INFO - PID 16842 | |12;stanford-crypto-pbkdf2;179;173;174;170;170;173;177;183;194;168 19:30:43 INFO - PID 16842 | |13;stanford-crypto-sha256-iterative;64;67;66;66;65;65;69;66;66;68 19:30:43 INFO - PID 16842 | __end_tp_report 19:30:43 INFO - PID 16842 | __start_cc_report 19:30:43 INFO - PID 16842 | _x_x_mozilla_cycle_collect,972 19:30:43 INFO - PID 16842 | __end_cc_report 19:30:43 INFO - PID 16842 | __startTimestamp1502073042994__endTimestamp 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | ------- Summary: start ------- 19:30:43 INFO - PID 16842 | Number of tests: 14 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#0] ai-astar Cycles:10 Average:106.00 Median:108.50 stddev:4.67 (4.3%) stddev-sans-first:3.64 19:30:43 INFO - PID 16842 | Values: 97.0 108.0 103.0 106.0 108.0 109.0 110.0 100.0 112.0 107.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:145.50 stddev:20.14 (13.8%) stddev-sans-first:21.35 19:30:43 INFO - PID 16842 | Values: 143.0 118.0 140.0 173.0 121.0 148.0 151.0 120.0 172.0 129.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.69 (1.6%) stddev-sans-first:2.82 19:30:43 INFO - PID 16842 | Values: 163.0 164.0 163.0 167.0 161.0 162.0 168.0 168.0 161.0 164.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#3] audio-fft Cycles:10 Average:89.70 Median:75.50 stddev:33.33 (44.1%) stddev-sans-first:34.98 19:30:43 INFO - PID 16842 | Values: 76.0 74.0 75.0 182.0 75.0 78.0 75.0 91.0 96.0 75.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.50 stddev:25.11 (31.6%) stddev-sans-first:26.30 19:30:43 INFO - PID 16842 | Values: 84.0 79.0 132.0 79.0 80.0 78.0 141.0 80.0 81.0 120.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.00 stddev:1.62 (1.4%) stddev-sans-first:1.69 19:30:43 INFO - PID 16842 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 119.0 116.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:151.00 stddev:3.34 (2.2%) stddev-sans-first:3.50 19:30:43 INFO - PID 16842 | Values: 151.0 151.0 149.0 151.0 154.0 151.0 151.0 150.0 156.0 160.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.50 stddev:1.64 (1.7%) stddev-sans-first:1.62 19:30:43 INFO - PID 16842 | Values: 93.0 97.0 98.0 94.0 93.0 94.0 95.0 94.0 95.0 94.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:2.04 (3.6%) stddev-sans-first:2.06 19:30:43 INFO - PID 16842 | Values: 54.0 57.0 57.0 59.0 55.0 54.0 54.0 53.0 57.0 58.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:55.50 stddev:2.78 (5.0%) stddev-sans-first:2.95 19:30:43 INFO - PID 16842 | Values: 56.0 54.0 55.0 54.0 53.0 58.0 54.0 62.0 58.0 54.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:88.00 stddev:5.21 (5.9%) stddev-sans-first:4.65 19:30:43 INFO - PID 16842 | Values: 77.0 90.0 81.0 90.0 81.0 80.0 83.0 89.0 92.0 87.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:135.50 stddev:16.58 (12.2%) stddev-sans-first:17.27 19:30:43 INFO - PID 16842 | Values: 146.0 143.0 125.0 137.0 129.0 125.0 129.0 124.0 134.0 179.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:175.50 stddev:7.75 (4.4%) stddev-sans-first:8.15 19:30:43 INFO - PID 16842 | Values: 179.0 173.0 174.0 170.0 170.0 173.0 177.0 183.0 194.0 168.0 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.33 19:30:43 INFO - PID 16842 | Values: 64.0 67.0 66.0 66.0 65.0 65.0 69.0 66.0 66.0 68.0 19:30:43 INFO - PID 16842 | -------- Summary: end -------- 19:30:43 INFO - PID 16842 | 19:30:43 INFO - PID 16842 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:30:43 INFO - TEST-INFO | 16842: exit 0 19:30:43 INFO - TEST-OK | kraken | took 62864ms 19:30:43 INFO - SUITE-END | took 1175s 19:30:44 INFO - Completed test suite (00:19:35) 19:30:44 INFO - javascript benchmark 19:30:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8500.868288077047, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.3775244951016, 3136.310011797407, 3136.341368312655, 3167.3506931079132, 3218.1954511372155, 6147.907781383277, 6164.5376596755195, 6264.154339164205, 6286.119943207943, 6359.936400635992, 6092.299385570661, 6222.160008398865, 6250.687465626723, 6257.4368306852375, 6268.498520118391, 5672.404397538261, 5711.086226203808, 5730.914036289459, 5734.856628584298, 5760.7695692172265, 5723.771049158028, 5738.368779434259, 5771.942280577204, 5823.5341172706085, 5840.357560668344, 5720.485156335929, 5799.65202087874, 5810.854728631797, 5817.476427121558, 5843.2403787507565, 5492.148716948879, 5664.433556644344, 5677.290338707661, 5716.342620598602, 5828.941710582903, 5211.443146575468, 5601.103823388238, 5643.68959707216, 5688.061469857468, 5731.455511726421, 6109.389061093855, 6112.786052488142, 6130.264368275791, 6205.7517699291975, 6218.28489723683, 6566.540342176049, 6592.802215933481, 6609.801705948781, 6685.966570167118, 6701.195856497203, 6760.256371799098, 6767.323267673242, 6772.72909083636, 6776.593404395752, 6777.288384719583, 6250.374962503759, 6254.374562543755, 6263.71813268404, 6267.091271765568, 6268.686565671698, 6905.896411553831, 6910.827229319308, 6967.163940327092, 6988.951657251453, 7002.1947476040905, 6570.770023049266, 6588.571742836701, 6595.538312318187, 6639.933600664028, 6686.7993960181275, 6547.770828020996, 6642.501812364092, 6678.899816502756, 6703.430208432241, 6746.359095885883, 6691.531592788556, 6731.32686731323, 6733.091032710521, 6757.898631520531, 6767.120274364301, 6701.028350889093, 6720.462363010947, 6783.62690052042, 6801.863962720718, 6811.659417029129, 5403.162509810985, 5423.186522021729, 5460.563154947595, 5489.3687225969525, 5504.91742623861, 4546.363509108662, 4631.096936097429, 4632.97683511587, 4724.763761811964, 4742.0, 5803.912941305884, 5822.214001109796, 5824.708764561755, 5826.708664566755, 5857.179994800731, 6641.203055633258, 6691.096701945273, 6805.319468053155, 6817.0796942413135, 6822.3859852613505, 5757.769689212469, 5776.393478684761, 5828.038373668382, 5849.151872978395, 5861.765529378862, 5775.826725198251, 5890.646561206341, 5901.144334071536, 5968.582199246011, 6028.819135425944, 6545.574537655038, 6555.344465553407, 6572.934270657328, 6573.671316434255, 6597.30728273534, 6705.262421133769, 6731.158605174353, 6807.0, 6834.316568343126, 6840.110785597841, 6475.352464753487, 6493.448056915215, 6507.804765857032, 6583.341665833378, 6607.273199948098, 6415.518836087405, 6580.5064620154635, 6604.24051234095, 6682.231543372574, 6701.497387695845, 6823.658817059028, 6841.555298905555, 6841.62371069596, 6843.520953533205, 6871.278515755774, 6492.5455218134275, 6507.707153178213, 6602.306757790555, 6609.834754131185, 6611.867762644816, 6485.708143133665, 6494.447971922251, 6503.382178693017, 6585.440237579859, 6598.04328372393, 6314.336994615683, 6425.261094973951, 6432.2602900667025, 6493.740250389931, 6507.446867016357, 6488.545801793829, 6567.868642627216, 6617.073609694743, 6620.90068648961, 6693.799186024427, 6260.186175797117, 6341.365863413622, 6381.968090159519, 6447.6131432114225, 6498.967505162444], "value": 6125.216960628783, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.8130670599112, 873.4409977614326, 886.9024407315198, 890.8040231149147, 1178.9764204715912, 31567.684323156762, 42420.787896060516, 42862.785686071606, 42969.0, 42998.78500607496, 42954.0, 43103.78448107763, 43191.136177276436, 43242.135157296834, 43337.0, 7807.882881756764, 7935.841283174333, 7960.562169080698, 7964.323032542241, 8000.559969201691, 7767.417443691746, 7871.645775940068, 7876.173001834811, 7889.960550197241, 7891.487053341514, 7722.575258360788, 7826.608669566527, 7829.451938364316, 7833.373330133604, 7839.921600784005, 7764.650590723403, 7770.728024519171, 7827.099883513383, 7831.530108193527, 7853.607319634052, 7705.807354816118, 7773.3004029637605, 7805.219478052206, 7822.1786712395515, 7824.178461261543, 40119.19761604781, 40422.59577404247, 40430.39354409686, 40478.59521404807, 40482.39276410856, 3579.6778289954027, 3605.7475976681644, 3607.6392360763975, 3611.837467313951, 3615.7649752766247, 32191.839040804647, 32231.355372892413, 32291.354172916646, 32313.353732925443, 32341.191470213198, 5002.699838009695, 5053.393592768891, 5072.51811077947, 5080.949190508085, 5099.59203263738, 190763.0, 192081.23756287474, 192461.0, 192502.0, 192520.0, 48926.042958281985, 48944.510554894, 49148.508514915105, 49195.262071068966, 49324.506754931994, 51217.0, 51784.0, 51826.0, 51999.0, 52004.47995520072, 16215.918920405322, 16387.180640967905, 16416.0, 16583.0, 16600.169991500617, 13498.59504214875, 13509.0, 13525.256110913797, 13525.59423217305, 13530.18818870871, 13306.334683265992, 13522.594322170351, 13756.587302380945, 14771.482998095014, 15123.243837808286, 5890.0, 6076.513878889678, 6141.447269745655, 6152.692365381802, 6259.937400625936, 996.9601215951426, 998.6554638649654, 1010.6664800615779, 1023.6110278094426, 1023.8668973033458, 23084.65373019406, 28519.287017824307, 28995.695193716332, 29137.708622913924, 29389.559156612668, 1055.3140458701905, 1086.4893500054961, 1088.684281558355, 1100.5652767156928, 1102.388174563109, 12472.750544989049, 12602.432890519949, 12607.369631518388, 12622.179558328678, 16774.83225167757, 235875.0, 240970.0, 241220.0, 241279.0, 241296.0, 62331.37668623347, 62475.375246247866, 62612.0, 62750.686246568475, 62785.37214627887, 1450.3400952566558, 1512.4252783942252, 1521.0341433190003, 1533.8466153384795, 1559.9220038998005, 27538.0, 27994.44011119807, 28051.43897122087, 28297.858510708138, 28497.0, 39742.40386394149, 39859.80070099631, 39958.200835982534, 40018.0, 40067.59932400638, 213868.0, 214518.0, 223936.0, 228197.0, 230420.0, 39819.80090099531, 39841.40237896376, 40049.1990160201, 40064.3990340151, 40259.39610905897, 42834.0, 49790.0, 49799.50200498094, 50282.497175027784, 50657.240141397175, 36234.8188259057, 36681.816590916875, 36710.63289367072, 36973.6302636981, 37114.07214819651, 36043.81978090093, 36424.63575364213, 36425.271494570494, 36454.27091458103, 36863.0, 39007.219855603296, 39144.6085539141, 39467.80266098651, 39497.0, 39740.0, 34924.30151396907, 34962.0, 34965.825170873984, 35412.645873541966, 35464.46803297901, 24800.0, 25036.62445063289, 25171.87414062918, 25260.0, 25496.490070198863], "value": 18193.232877926814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4419468920457, 576.3947854752508, 587.321643501755, 594.9643021418715, 599.682168450721, 22498.775012249873, 22872.542549149006, 23256.18603348883, 23368.415789605246, 23390.181343652956, 26860.328491787666, 27406.5889011665, 27597.0, 27620.0, 27633.44733105337, 6571.408573228408, 6760.763373281936, 6761.628110453923, 6764.154480689914, 6764.729410823561, 5970.134330522072, 6505.316941721122, 6509.544331896769, 6569.080328753978, 6714.597124172566, 6495.967520162392, 6542.247641521215, 6545.803625891231, 6549.967250163742, 6552.475801935833, 6454.257760357572, 6467.870642587169, 6502.93497065028, 6531.379518945692, 6533.640649764261, 6017.879642407172, 6038.486728628071, 6050.515958723292, 6053.485453736438, 6058.96970515149, 28858.278543036384, 29595.852020739974, 30120.397592048255, 30180.547291790423, 30375.24061898448, 1872.5505878589177, 1892.3660573707825, 1898.364048043907, 1902.1535416739557, 1907.895065771382, 19881.0, 20311.0, 20333.491662708402, 20434.489137771525, 20491.897540512353, 2402.759724027583, 2445.6453814196843, 2452.497238066192, 2505.7744802967636, 2507.9498410031697, 137583.0, 140620.0, 140774.0, 141104.99999999898, 141279.29360353132, 14762.0, 15287.388504459697, 15499.147546884804, 15504.534863954099, 15517.612059698598, 23906.880465597907, 23996.64005039926, 24039.7596024041, 24106.638400423657, 24167.274981750223, 10129.341592796445, 10302.857628423253, 10369.429681367597, 10433.32183408076, 10512.684619461428, 8357.95821020891, 9444.480553569481, 9477.383970041925, 9539.284553658503, 9641.42151470914, 8216.917830821734, 9144.81710365789, 9199.218066464426, 9361.812763744823, 9531.237500999903, 2732.8770205340807, 2743.547314693053, 2804.901828435995, 2808.0, 2828.6322778038725, 956.3449037409258, 961.4711908450324, 976.916962058233, 977.2768151567789, 985.4186030242191, 19740.40778776639, 19845.244878984933, 19921.60156796856, 20358.0, 20511.692324615142, 1034.6689059501039, 1040.6773900090996, 1040.9479526023667, 1045.4197920154388, 1047.4448542272607, 10941.507632156572, 10974.780504390028, 11116.888831111748, 11176.944115279533, 11219.943900280447, 527972.0, 528815.0, 561835.0, 562159.0, 570308.2969170338, 122753.0, 123669.38165309116, 124547.0, 124691.37654311852, 124909.0, 1263.4251415605877, 1290.8450985881755, 1335.8263425754783, 1338.9263590502421, 1339.9464021439228, 20924.0, 20961.790382095984, 20991.265305714838, 21192.688522460343, 21414.892925535274, 56165.71917140388, 56766.432335676116, 57051.0, 57385.71307143437, 59129.70435147969, 69713.0, 69743.0, 69937.65031174812, 70238.29761702317, 70344.29655703582, 14689.338979745724, 15116.0, 15133.243337832844, 15159.772603410736, 15177.468788592347, 23509.177178799346, 23562.76437235674, 23615.173468928504, 23808.523829522965, 23850.52298954046, 18485.63028739391, 19037.23851045998, 19104.904475477535, 19169.712454313474, 19184.71222931685, 16641.0, 17054.658906822042, 17137.74293385625, 17196.828031719524, 17242.913785430992, 19113.61772764509, 19568.11943462519, 19749.308774192836, 19752.802471975097, 20014.599708006048, 14870.0, 14896.62758431048, 14986.85013149898, 15002.099874007594, 15057.247137643293, 18388.0, 18952.86282823035, 19090.618187635893, 19229.615407692047, 19248.903755481133], "value": 12279.077752764377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.4035204334073, 1379.2276325257856, 1384.4254634326755, 1390.9095908765926, 1393.6446206217413, 13658.31708414579, 14253.572392828206, 14257.215853128073, 14261.35823887925, 14696.0, 14440.783388249185, 14741.0, 14747.0, 14751.04118232314, 14787.778183327258, 2313.3060081975423, 2591.2096810472844, 2639.4721055788823, 2655.4556315955183, 2670.052131493321, 2281.2243837095384, 2602.8958841646404, 2656.0836511403536, 2657.481791050746, 2673.612326212698, 2624.8293860899075, 2653.177514970356, 2689.690685571165, 2695.9595606065923, 2703.2701170683904, 2546.4907018596355, 2548.197317844882, 2552.5150221457957, 2553.553128202576, 2555.0418593027616, 2510.071273628769, 2519.143491212978, 2544.4911017796517, 2561.244432892301, 2573.3566608347915, 13596.38816253271, 13951.0, 13997.230152341617, 14001.299935003311, 14005.159690418608, 7612.200718924544, 7888.053433588007, 7907.288344049006, 7911.327537159348, 7935.206479352077, 4824.842037910911, 5045.772940217699, 5121.795128194868, 5154.845354639367, 5177.689338639693, 1757.5254681235995, 1814.564504518906, 1835.0732879895568, 1859.414284500378, 1875.2967637136073, 23218.883905580533, 23254.186103486296, 23301.650475242885, 23368.883155584113, 23373.649395259086, 6734.3602357775935, 7149.142102947576, 7218.927810721931, 7262.620102180569, 7279.381252593589, 16302.962129733784, 16400.26198821056, 16452.341906323614, 16530.09084500364, 16569.171541422882, 7674.9232507674205, 7698.576578288136, 7788.299053085249, 8023.438359314909, 8084.919150808417, 7019.89470157948, 7133.108361454818, 7146.285371462812, 7156.24859389767, 7191.748288809867, 5028.195488721787, 5117.692938423706, 5139.871503212375, 5161.096808058574, 5206.245094461282, 1521.9086854788527, 1525.8855585831107, 1547.1954583616457, 1561.0, 1562.3672412672886, 890.5636238243214, 897.3494216692845, 905.3752910491871, 907.4237858959608, 907.5507623726297, 7144.64276786169, 7250.16623088341, 7315.780526584211, 7348.787450070786, 7387.889181662279, 715.1668306423063, 715.6171448275252, 719.144994372341, 741.1439787045971, 742.1761844352764, 4431.202383570923, 4725.9527404726205, 4834.903301933941, 5063.392392912874, 5145.202493613496, 18974.0, 19003.42989710311, 19022.0, 19236.71144932827, 19685.901570492057, 18680.906595467208, 19624.21503139887, 19658.41024769259, 19677.0, 19744.70382944257, 10822.134229261641, 10868.728281793019, 11000.559977600806, 11023.944880275547, 11061.778764424667, 7579.62101894892, 7842.647080881488, 7859.9607001966915, 7923.128455869734, 7940.6029698515995, 16504.17479126063, 16713.331466741194, 16931.0, 17022.659546809242, 17041.318347266468, 17101.0, 17184.484465466056, 17355.913220433817, 17412.0, 17753.289868405118, 11268.38023908693, 11522.654320370402, 11544.01875840563, 11545.942270288595, 11558.826617600911, 12778.872211277769, 13082.149660272053, 13153.736925261632, 13174.670633234246, 13217.603471895858, 10698.14414846826, 10732.570697172338, 10779.946100269763, 10815.729606759895, 11022.779544409228, 10438.0, 10554.261201715806, 10639.308444951053, 10852.891471085188, 10978.725531861768, 8996.640134394813, 9004.864927025968, 9047.140521650434, 9062.410943288665, 9101.271898248257, 6982.022516847747, 7051.365377116084, 7084.305630347641, 7183.461240406886, 7300.306470885257, 7291.489595728461, 7412.888806667796, 7495.775126746206, 7500.549967001997, 7542.245775422414], "value": 6336.174833284137, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.5997524202808, 511.0851575679534, 520.0898427751436, 521.5827338129496, 534.5216031651672, 6183.690815459231, 6259.937400625992, 6271.498280137589, 6289.088082228074, 6301.590396624216, 6101.901657701623, 6104.908426373608, 6172.629642221458, 6186.659733714644, 6203.813885583429, 5110.718910459923, 5143.665661731994, 5144.845654630367, 5173.560247378959, 5177.378714554259, 4778.976105119469, 4939.555440010398, 4998.950010499903, 5036.169032109698, 5116.0, 4805.687630304036, 4817.735024573647, 4821.963277895252, 4878.219484882419, 4895.632827537949, 4842.709437433765, 4869.14789911764, 4875.390576177978, 4880.487548807395, 4887.511248875084, 4295.613394794453, 4346.695731298811, 4390.868273951786, 4403.2954727243805, 4415.116976604692, 5839.591228613998, 5868.9413105868825, 5896.262967129109, 5956.315023772278, 5958.880822383528, 5595.1886976388605, 5623.8594035149035, 5640.689762063085, 5693.601447898649, 5703.942960570383, 6204.4944606297295, 6352.6823658816875, 6378.23906658943, 6423.325550817143, 6449.516286278548, 4745.501722319142, 4775.570198682135, 4777.378940737716, 4841.467438581753, 4865.635077369176, 6618.93381066188, 6727.495437842182, 6786.287439818847, 6829.658517074176, 6869.4847886408215, 4762.571368576845, 4839.41926968766, 4844.515548445198, 4863.562279394871, 4916.926246106311, 4915.729634870045, 4936.703797772145, 4941.901161976741, 4945.060438516671, 4955.90088198234, 5562.638428502134, 5581.441855814467, 5583.246261754693, 5604.8318550443555, 5650.124230744159, 6519.837004074936, 6522.739090436425, 6567.277599464055, 6569.67151642416, 6596.373344532261, 1760.0935518208132, 1763.615561784019, 1767.9823201768074, 1776.4670598820303, 1777.6178121703895, 1148.2995372822572, 1212.593781083347, 1224.4122821045949, 1224.6448529926222, 1242.763874863773, 5571.359293681197, 5702.2301989231755, 5730.828075157752, 5743.741531631086, 5778.451047150514, 6594.7032383542855, 6641.1404806653245, 6662.0, 6701.798946031627, 6727.562708423937, 5587.189857470644, 5640.53346130001, 5698.914516282259, 5704.971475142681, 5720.3421606515785, 3498.317828023562, 3539.734519911017, 3552.307300076512, 3563.198280386944, 3572.160542272564, 6468.741250349934, 6528.412442880163, 6548.312427195171, 6555.639439830759, 6577.914644083673, 6636.369544893228, 6717.951024937343, 6776.832248167341, 6867.695137923779, 6886.10480637514, 6320.841978950563, 6353.428191462791, 6413.038044293487, 6464.288928217892, 6520.239535325531, 6502.252240992347, 6572.737090516517, 6584.176977877765, 6619.106420633153, 6659.7003134860015, 6029.246344206974, 6523.836904077436, 6575.4410875076155, 6576.046473261446, 6582.473402127914, 6383.0, 6424.2933277338525, 6461.709223084878, 6490.7079181436, 6525.673716314071, 4931.260310953386, 4943.826966056171, 4952.653314268111, 5009.0, 5019.247112933089, 6369.617822930639, 6494.155759751202, 6597.701149425287, 6676.699548520425, 6724.260331363448, 6325.715342809676, 6366.236051673829, 6382.0, 6425.646589437439, 6462.935370646233, 6360.823247699191, 6383.297837237993, 6455.0, 6473.255575608865, 6492.285848556749, 6187.84530386744, 6298.244210694746, 6368.0, 6393.968030159819, 6402.551821372459, 6492.0, 6511.5256202642695, 6555.836573930496, 6562.245341785756, 6606.141201643755, 6324.588901721373, 6351.96824015877, 6381.521385895983, 6391.840203994937, 6404.263509696445], "value": 4998.60329025324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.5091199840091, 917.2432742987036, 931.4550987672209, 932.2728271947879, 933.1554942776781, 19235.903820480897, 20244.39266821996, 20341.389758307258, 20439.89780051098, 22640.320790376314, 20225.0, 22459.663105053438, 22490.32529024128, 22590.096396144134, 22629.773702262974, 1018.0379541333461, 1030.7165529479416, 1031.881333646629, 1031.8968103189695, 1032.220673391592, 948.6252930092609, 1032.5611615063606, 1047.1151876664208, 1051.232600201853, 1051.6739810658682, 1086.8858769829174, 1097.489667304703, 1097.6213206443765, 1098.132475344477, 1098.242212873119, 1088.847561341409, 1092.9726756831064, 1093.7211011192135, 1094.5895289266525, 1095.2552264460164, 800.8598495263363, 802.0575823407473, 806.2501873257927, 807.8747794091867, 807.9838403231961, 20154.69767953482, 20255.493612659655, 20395.8980205098, 20446.284380046774, 20905.790942090687, 21801.454963625878, 22275.108995640156, 22374.105035798548, 22770.31689049331, 22930.0, 16345.182740863029, 16506.052385734034, 16589.0, 16612.169391530377, 16970.66058678832, 3516.085817687394, 3580.695640870529, 3597.262561174979, 3619.6199399062984, 3619.8733044343585, 127613.0, 127796.0, 130843.34578327142, 131449.0, 131723.0, 17317.826821731873, 17542.473725788248, 17733.822661773218, 18221.817781822276, 18288.08559572016, 32683.34633307368, 32918.506222406686, 33194.50208246878, 33221.66778332186, 33410.66589334124, 7717.073951125901, 8057.677692892219, 8360.749177524684, 8754.387192896436, 8888.511131887808, 4263.232618128766, 4351.673624478177, 4377.299632058919, 4378.562143785596, 4382.211201983673, 5180.9740951295, 5244.239585260192, 5286.97356513215, 5320.893582128336, 5350.438203988603, 1044.9895501044891, 1069.1660504806264, 1079.1852151625471, 1080.1304949515716, 1082.8213344798178, 493.4966334338954, 495.8016793282716, 514.8095204774257, 515.8504033830147, 519.0, 10667.466626668636, 10784.13726901846, 10829.891701082888, 11031.338119712844, 12793.360331983364, 541.0963690636646, 543.8096666166889, 545.3319683387818, 545.9781608735685, 550.6833570696865, 4811.49479304668, 4878.707277563358, 4922.975385123052, 5070.670406423571, 5692.601517893708, 92649.07350926404, 100577.0, 101843.0, 102258.0, 103157.0, 85140.0, 85690.0, 86078.56960715157, 86476.5676171615, 87682.0, 76786.0, 79122.60438697769, 81786.59106704548, 83870.58064709637, 84376.57811710902, 11250.943745281222, 11469.598564050219, 11606.361650109326, 11746.119041072125, 11909.642710718692, 36088.0, 36484.45273320849, 36543.45184822177, 36559.45160822537, 36678.0, 44007.339889902316, 44737.55262447464, 44861.32708009448, 45155.54844451514, 45954.0, 15838.68322633564, 16258.51224463268, 16306.673866522366, 16518.0, 16557.58606034859, 18125.184366703266, 18169.0, 18225.90887045556, 18295.359662411753, 18463.16915738768, 16015.839841601435, 16247.187640618158, 16300.103494307927, 16335.183240838149, 16430.178491075636, 16167.27247273852, 16241.756373654169, 16292.837071629607, 16351.509454716377, 16443.67112657764, 15337.233138343261, 15416.99789513678, 15524.534263972098, 15525.146116963675, 15583.84416155824, 11108.944455277671, 11133.610323638633, 11209.55161793519, 11231.71920701989, 11577.073834093084, 12657.873421266038, 12824.935875320563, 12844.807327890276, 12898.613041608767, 13041.282729449971], "value": 8707.187312536213, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 103.0, 106.0, 108.0, 109.0, 110.0, 100.0, 112.0, 107.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 140.0, 173.0, 121.0, 148.0, 151.0, 120.0, 172.0, 129.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 167.0, 161.0, 162.0, 168.0, 168.0, 161.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 182.0, 75.0, 78.0, 75.0, 91.0, 96.0, 75.0], "value": 89.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 132.0, 79.0, 80.0, 78.0, 141.0, 80.0, 81.0, 120.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 119.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 149.0, 151.0, 154.0, 151.0, 151.0, 150.0, 156.0, 160.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 97.0, 98.0, 94.0, 93.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 57.0, 59.0, 55.0, 54.0, 54.0, 53.0, 57.0, 58.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 53.0, 58.0, 54.0, 62.0, 58.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 90.0, 81.0, 90.0, 81.0, 80.0, 83.0, 89.0, 92.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 125.0, 137.0, 129.0, 125.0, 129.0, 124.0, 134.0, 179.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 174.0, 170.0, 170.0, 173.0, 177.0, 183.0, 194.0, 168.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 66.0, 65.0, 65.0, 69.0, 66.0, 66.0, 68.0], "value": 66.2, "unit": "score"}]}]} 19:30:44 INFO - Return code: 0 19:30:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:30:44 INFO - # TBPL SUCCESS # 19:30:44 INFO - Running post-action listener: _package_coverage_data 19:30:44 INFO - Running post-action listener: _resource_record_post_action 19:30:44 INFO - [mozharness: 2017-08-07 02:30:44.274633Z] Finished run-tests step (success) 19:30:44 INFO - Running post-run listener: _resource_record_post_run 19:30:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 45056; Write bytes: 432500736; Read time: 292; Write time: 351264 19:30:44 INFO - TinderboxPrint: CPU usage
13.2% 19:30:44 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 292 19:30:44 INFO - TinderboxPrint: I/O write bytes / time
432,500,736 / 351,264 19:30:44 INFO - TinderboxPrint: CPU idle
8,265.0 (86.8%) 19:30:44 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 19:30:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:30:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106557440; Read time: 0; Write time: 97808 19:30:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:30:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 40960; Write bytes: 322801664; Read time: 256; Write time: 253144 19:30:44 INFO - Running post-run listener: _upload_blobber_files 19:30:44 INFO - Blob upload gear active. 19:30:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:44 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 19:30:44 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:30:44 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:30:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:46 INFO - (blobuploader) - INFO - Done attempting. 19:30:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:49 INFO - (blobuploader) - INFO - Done attempting. 19:30:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:30:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:30:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:50 INFO - (blobuploader) - INFO - Done attempting. 19:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:51 INFO - (blobuploader) - INFO - Done attempting. 19:30:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:51 INFO - Return code: 0 19:30:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fd7de69ef683205ece49ecb1c778637c6fc5559be09759cda145df7cbd30eb3872a1044f582c0047cb8fc0e75a83ceb0719e20ad0242c4d196a4f6ea16827e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa33dc7653e7eb15646870183cade37c5cabf8b489495709b8591b37574cb392eb532cf1699cc2e1bafac348a1b2a2318166930916522fe6b0ecc8a2741bcd53", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a7e1c108664ef22ead699e58b714e384c736303950d3dab525101072c84064ab2cd8d2b3dd7dfdbae2f968bd6b305763533ee592fe02c51310c26909e541db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e866884c6fd0dad6d50bd3eec5a7ec0f3c45bc5c50d8ba5c24896f4baabbc2c3b0350967ca0b0dcff18d43e8e86e7020270368c558d046bbf0d9717aed13"} 19:30:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:51 INFO - Contents: 19:30:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fd7de69ef683205ece49ecb1c778637c6fc5559be09759cda145df7cbd30eb3872a1044f582c0047cb8fc0e75a83ceb0719e20ad0242c4d196a4f6ea16827e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa33dc7653e7eb15646870183cade37c5cabf8b489495709b8591b37574cb392eb532cf1699cc2e1bafac348a1b2a2318166930916522fe6b0ecc8a2741bcd53", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a7e1c108664ef22ead699e58b714e384c736303950d3dab525101072c84064ab2cd8d2b3dd7dfdbae2f968bd6b305763533ee592fe02c51310c26909e541db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e866884c6fd0dad6d50bd3eec5a7ec0f3c45bc5c50d8ba5c24896f4baabbc2c3b0350967ca0b0dcff18d43e8e86e7020270368c558d046bbf0d9717aed13"} 19:30:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:51 INFO - Copying logs to upload dir... 19:30:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.450699 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 19:30:51.280294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:30:51.283787) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fd7de69ef683205ece49ecb1c778637c6fc5559be09759cda145df7cbd30eb3872a1044f582c0047cb8fc0e75a83ceb0719e20ad0242c4d196a4f6ea16827e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa33dc7653e7eb15646870183cade37c5cabf8b489495709b8591b37574cb392eb532cf1699cc2e1bafac348a1b2a2318166930916522fe6b0ecc8a2741bcd53", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a7e1c108664ef22ead699e58b714e384c736303950d3dab525101072c84064ab2cd8d2b3dd7dfdbae2f968bd6b305763533ee592fe02c51310c26909e541db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e866884c6fd0dad6d50bd3eec5a7ec0f3c45bc5c50d8ba5c24896f4baabbc2c3b0350967ca0b0dcff18d43e8e86e7020270368c558d046bbf0d9717aed13"} build_url:https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fd7de69ef683205ece49ecb1c778637c6fc5559be09759cda145df7cbd30eb3872a1044f582c0047cb8fc0e75a83ceb0719e20ad0242c4d196a4f6ea16827e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa33dc7653e7eb15646870183cade37c5cabf8b489495709b8591b37574cb392eb532cf1699cc2e1bafac348a1b2a2318166930916522fe6b0ecc8a2741bcd53", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a7e1c108664ef22ead699e58b714e384c736303950d3dab525101072c84064ab2cd8d2b3dd7dfdbae2f968bd6b305763533ee592fe02c51310c26909e541db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e866884c6fd0dad6d50bd3eec5a7ec0f3c45bc5c50d8ba5c24896f4baabbc2c3b0350967ca0b0dcff18d43e8e86e7020270368c558d046bbf0d9717aed13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:30:51.308757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:30:51.309061) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1502071798.79080-1023578315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:30:51.392295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:30:51.392611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:30:51.392888) ========= ========= Total master_lag: 0.16 =========