builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1502072363.92 results: success (0) revision: bb8de16ce00cb57b587a14c210ecc7505f366328 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:23.915306) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:23.915751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:23.916028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:23.928929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:23.929196) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 19:19:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-08-06 19:19:24 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:24.138578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:24.138980) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017114 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:24.188300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:24.188640) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb8de16ce00cb57b587a14c210ecc7505f366328 --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 bb8de16ce00cb57b587a14c210ecc7505f366328 --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=e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 19:19:24,290 truncating revision to first 12 chars 2017-08-06 19:19:24,290 Setting DEBUG logging. 2017-08-06 19:19:24,290 attempt 1/10 2017-08-06 19:19:24,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb8de16ce00c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 19:19:24,924 unpacking tar archive at: mozilla-central-bb8de16ce00c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.940879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:25.142305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:25.142624) ========= script_repo_revision: bb8de16ce00cb57b587a14c210ecc7505f366328 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:25.143116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:25.143415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:19:25.151766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-06 19:19:25.152031) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:19:25 INFO - MultiFileLogger online at 20170806 19:19:25 in /builds/slave/test 19:19:25 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:19:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:19:25 INFO - {'append_to_log': False, 19:19:25 INFO - 'base_work_dir': '/builds/slave/test', 19:19:25 INFO - 'blob_upload_branch': 'Firefox', 19:19:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:19:25 INFO - 'branch': 'Firefox', 19:19:25 INFO - 'buildbot_json_path': 'buildprops.json', 19:19:25 INFO - 'code_coverage': False, 19:19:25 INFO - 'config_files': ('talos/linux_config.py',), 19:19:25 INFO - 'default_actions': ('clobber', 19:19:25 INFO - 'read-buildbot-config', 19:19:25 INFO - 'download-and-extract', 19:19:25 INFO - 'populate-webroot', 19:19:25 INFO - 'create-virtualenv', 19:19:25 INFO - 'install', 19:19:25 INFO - 'setup-mitmproxy', 19:19:25 INFO - 'run-tests'), 19:19:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:19:25 INFO - 'disable_ccov_upload': False, 19:19:25 INFO - 'download_minidump_stackwalk': True, 19:19:25 INFO - 'download_symbols': 'ondemand', 19:19:25 INFO - 'enable_stylo': False, 19:19:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:19:25 INFO - 'tooltool.py': '/tools/tooltool.py', 19:19:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:19:25 INFO - '/tools/misc-python/virtualenv.py')}, 19:19:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:19:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:19:25 INFO - 'gecko_profile': False, 19:19:25 INFO - 'gecko_profile_interval': 0, 19:19:25 INFO - 'installer_path': 'installer.exe', 19:19:25 INFO - 'log_level': 'info', 19:19:25 INFO - 'log_name': 'talos', 19:19:25 INFO - 'log_to_console': True, 19:19:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:19:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:19:25 INFO - 'opt_config_files': (), 19:19:25 INFO - 'pip_index': False, 19:19:25 INFO - 'suite': 'dromaeojs-e10s', 19:19:25 INFO - 'system_bits': '32', 19:19:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:19:25 INFO - 'title': 'talos-linux64-ix-067', 19:19:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:19:25 INFO - 'use_talos_json': True, 19:19:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:19:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:19:25 INFO - 'work_dir': 'build'} 19:19:25 INFO - [mozharness: 2017-08-07 02:19:25.362511Z] Running clobber step. 19:19:25 INFO - Running pre-action listener: _resource_record_pre_action 19:19:25 INFO - Running main action method: clobber 19:19:25 INFO - rmtree: /builds/slave/test/build 19:19:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:19:26 INFO - Running post-action listener: _resource_record_post_action 19:19:26 INFO - [mozharness: 2017-08-07 02:19:26.385759Z] Finished clobber step (success) 19:19:26 INFO - [mozharness: 2017-08-07 02:19:26.385862Z] Running read-buildbot-config step. 19:19:26 INFO - Running pre-action listener: _resource_record_pre_action 19:19:26 INFO - Running main action method: read_buildbot_config 19:19:26 INFO - Using buildbot properties: 19:19:26 INFO - { 19:19:26 INFO - "project": "", 19:19:26 INFO - "product": "firefox", 19:19:26 INFO - "who": "ryanvm@gmail.com", 19:19:26 INFO - "installer_path": "public/build/target.tar.bz2", 19:19:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:19:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:19:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:19:26 INFO - "stage_platform": "linux64-stylosequential", 19:19:26 INFO - "basedir": "/builds/slave/test", 19:19:26 INFO - "buildnumber": 171, 19:19:26 INFO - "platform": "ubuntu64_hw_styloseq", 19:19:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:19:26 INFO - "slavebuilddir": "test", 19:19:26 INFO - "taskId": "H20i_Y_SQqCnyXN6h4NAow", 19:19:26 INFO - "branch": "mozilla-central", 19:19:26 INFO - "script_repo_revision": "production", 19:19:26 INFO - "revision": "bb8de16ce00cb57b587a14c210ecc7505f366328", 19:19:26 INFO - "slavename": "talos-linux64-ix-067", 19:19:26 INFO - "repo_path": "mozilla-central" 19:19:26 INFO - } 19:19:26 INFO - Finding installer, test and symbols from parent task. 19:19:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H20i_Y_SQqCnyXN6h4NAow'}, attempt #1 19:19:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H20i_Y_SQqCnyXN6h4NAow'}, attempt #1 19:19:27 INFO - Task dependencies: QgPvyoURQK6UatzOSij_TA 19:19:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA'}, attempt #1 19:19:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:19:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json 19:19:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip 19:19:27 INFO - Running post-action listener: _resource_record_post_action 19:19:27 INFO - [mozharness: 2017-08-07 02:19:27.799251Z] Finished read-buildbot-config step (success) 19:19:27 INFO - [mozharness: 2017-08-07 02:19:27.799475Z] Running download-and-extract step. 19:19:27 INFO - Running pre-action listener: _resource_record_pre_action 19:19:27 INFO - Running main action method: download_and_extract 19:19:27 INFO - mkdir: /builds/slave/test/build/tests 19:19:27 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:19:27 INFO - trying https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json 19:19:27 INFO - Downloading https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:19:28 INFO - Downloaded 989 bytes. 19:19:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:19:28 INFO - Using the following test package requirements: 19:19:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:19:28 INFO - u'common': [u'target.common.tests.zip'], 19:19:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:19:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:19:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:19:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:19:28 INFO - u'mozbase': [u'target.common.tests.zip'], 19:19:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:19:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:19:28 INFO - u'web-platform': [u'target.common.tests.zip', 19:19:28 INFO - u'target.web-platform.tests.tar.gz'], 19:19:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:19:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:19:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip 19:19:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:19:28 INFO - Fetch https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip into memory 19:19:29 INFO - Content-Length response header: 54284786 19:19:29 INFO - Bytes received: 54284786 19:19:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:19:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip 19:19:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:19:40 INFO - Fetch https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.common.tests.zip into memory 19:19:41 INFO - Content-Length response header: 54284786 19:19:41 INFO - Bytes received: 54284786 19:19:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.talos.tests.zip 19:19:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:19:53 INFO - Fetch https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.talos.tests.zip into memory 19:19:54 INFO - Content-Length response header: 14496008 19:19:54 INFO - Bytes received: 14496008 19:19:54 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:19:54 INFO - trying https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:19:54 INFO - Downloading https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:19:55 INFO - Downloaded 61918259 bytes. 19:19:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:19:55 INFO - mkdir: /builds/slave/test/properties 19:19:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:19:55 INFO - Writing to file /builds/slave/test/properties/build_url 19:19:55 INFO - Contents: 19:19:55 INFO - build_url:https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 19:19:55 INFO - Running post-action listener: _resource_record_post_action 19:19:55 INFO - Running post-action listener: set_extra_try_arguments 19:19:55 INFO - [mozharness: 2017-08-07 02:19:55.457094Z] Finished download-and-extract step (success) 19:19:55 INFO - [mozharness: 2017-08-07 02:19:55.457192Z] Running populate-webroot step. 19:19:55 INFO - Running pre-action listener: _resource_record_pre_action 19:19:55 INFO - Running main action method: populate_webroot 19:19:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:19:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:19:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:19:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:19:55 INFO - 'tests': ['damp', 'tps']}, 19:19:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:19:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:19:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:19:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:19:55 INFO - 'other-e10s': {'tests': ['a11yr', 19:19:55 INFO - 'ts_paint', 19:19:55 INFO - 'tpaint', 19:19:55 INFO - 'sessionrestore', 19:19:55 INFO - 'sessionrestore_many_windows', 19:19:55 INFO - 'sessionrestore_no_auto_restore', 19:19:55 INFO - 'tabpaint']}, 19:19:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:19:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:19:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:19:55 INFO - 'tsvgr_opacity', 19:19:55 INFO - 'tart', 19:19:55 INFO - 'tscrollx', 19:19:55 INFO - 'tsvg_static']}, 19:19:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:19:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:19:55 INFO - 'talos_options': ['--mitmproxy', 19:19:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:19:55 INFO - '--firstNonBlankPaint'], 19:19:55 INFO - 'tests': ['tp6_google', 19:19:55 INFO - 'tp6_youtube', 19:19:55 INFO - 'tp6_amazon', 19:19:55 INFO - 'tp6_facebook']}, 19:19:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:19:55 INFO - 'talos_options': ['--stylo', 19:19:55 INFO - '--mitmproxy', 19:19:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:19:55 INFO - '--firstNonBlankPaint'], 19:19:55 INFO - 'tests': ['tp6_google', 19:19:55 INFO - 'tp6_youtube', 19:19:55 INFO - 'tp6_amazon', 19:19:55 INFO - 'tp6_facebook']}, 19:19:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:19:55 INFO - 'talos_options': ['--stylo', 19:19:55 INFO - '--stylo-threads=1', 19:19:55 INFO - '--mitmproxy', 19:19:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:19:55 INFO - '--firstNonBlankPaint'], 19:19:55 INFO - 'tests': ['tp6_google', 19:19:55 INFO - 'tp6_youtube', 19:19:55 INFO - 'tp6_amazon', 19:19:55 INFO - 'tp6_facebook']}, 19:19:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:19:55 INFO - 'talos_options': ['--xperf_path', 19:19:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:55 INFO - 'tests': ['tp5n']}}} 19:19:55 INFO - Running post-action listener: _resource_record_post_action 19:19:55 INFO - [mozharness: 2017-08-07 02:19:55.465669Z] Finished populate-webroot step (success) 19:19:55 INFO - [mozharness: 2017-08-07 02:19:55.465771Z] Running create-virtualenv step. 19:19:55 INFO - Running pre-action listener: _resource_record_pre_action 19:19:55 INFO - Running main action method: create_virtualenv 19:19:55 INFO - Creating virtualenv /builds/slave/test/build/venv 19:19:55 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:19:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:19:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:19:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:19:55 INFO - Using real prefix '/usr' 19:19:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:19:56 INFO - Installing distribute.............................................................................................................................................................................................done. 19:19:58 INFO - Installing pip.................done. 19:19:58 INFO - Return code: 0 19:19:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:19:58 INFO - Reading from file tmpfile_stdout 19:19:58 INFO - Output received: 19:19:58 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:19:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:19:58 INFO - Using env: {'DISPLAY': ':0', 19:19:58 INFO - 'HOME': '/home/cltbld', 19:19:58 INFO - 'LANG': 'en_US.UTF-8', 19:19:58 INFO - 'LANGUAGE': 'en_US:en', 19:19:58 INFO - 'LOGNAME': 'cltbld', 19:19:58 INFO - 'MAIL': '/var/mail/cltbld', 19:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:58 INFO - 'MOZ_NO_REMOTE': '1', 19:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:58 INFO - 'NO_EM_RESTART': '1', 19:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:58 INFO - 'PWD': '/builds/slave/test', 19:19:58 INFO - 'SHELL': '/bin/bash', 19:19:58 INFO - 'SHLVL': '1', 19:19:58 INFO - 'TERM': 'linux', 19:19:58 INFO - 'TMOUT': '86400', 19:19:58 INFO - 'USER': 'cltbld', 19:19:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:58 INFO - '_': '/tools/buildbot/bin/python'} 19:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:58 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:19:58 INFO - Cleaning up... 19:19:58 INFO - Return code: 0 19:19:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:19:58 INFO - Using env: {'DISPLAY': ':0', 19:19:58 INFO - 'HOME': '/home/cltbld', 19:19:58 INFO - 'LANG': 'en_US.UTF-8', 19:19:58 INFO - 'LANGUAGE': 'en_US:en', 19:19:58 INFO - 'LOGNAME': 'cltbld', 19:19:58 INFO - 'MAIL': '/var/mail/cltbld', 19:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:58 INFO - 'MOZ_NO_REMOTE': '1', 19:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:58 INFO - 'NO_EM_RESTART': '1', 19:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:58 INFO - 'PWD': '/builds/slave/test', 19:19:58 INFO - 'SHELL': '/bin/bash', 19:19:58 INFO - 'SHLVL': '1', 19:19:58 INFO - 'TERM': 'linux', 19:19:58 INFO - 'TMOUT': '86400', 19:19:58 INFO - 'USER': 'cltbld', 19:19:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:58 INFO - '_': '/tools/buildbot/bin/python'} 19:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:58 INFO - Downloading/unpacking psutil>=3.1.1 19:19:58 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:19:58 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:19:58 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:19:58 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:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:19:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:59 INFO - Installing collected packages: psutil 19:19:59 INFO - Running setup.py install for psutil 19:19:59 INFO - building 'psutil._psutil_linux' extension 19:19:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:20:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:20:00 INFO - building 'psutil._psutil_posix' extension 19:20:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:20:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:20:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:20:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:20:00 INFO - Successfully installed psutil 19:20:00 INFO - Cleaning up... 19:20:00 INFO - Return code: 0 19:20:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:20:00 INFO - Using env: {'DISPLAY': ':0', 19:20:00 INFO - 'HOME': '/home/cltbld', 19:20:00 INFO - 'LANG': 'en_US.UTF-8', 19:20:00 INFO - 'LANGUAGE': 'en_US:en', 19:20:00 INFO - 'LOGNAME': 'cltbld', 19:20:00 INFO - 'MAIL': '/var/mail/cltbld', 19:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:00 INFO - 'MOZ_NO_REMOTE': '1', 19:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:00 INFO - 'NO_EM_RESTART': '1', 19:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:00 INFO - 'PWD': '/builds/slave/test', 19:20:00 INFO - 'SHELL': '/bin/bash', 19:20:00 INFO - 'SHLVL': '1', 19:20:00 INFO - 'TERM': 'linux', 19:20:00 INFO - 'TMOUT': '86400', 19:20:00 INFO - 'USER': 'cltbld', 19:20:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:00 INFO - '_': '/tools/buildbot/bin/python'} 19:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:20:01 INFO - Installing collected packages: mozsystemmonitor 19:20:01 INFO - Running setup.py install for mozsystemmonitor 19:20:01 INFO - Successfully installed mozsystemmonitor 19:20:01 INFO - Cleaning up... 19:20:01 INFO - Return code: 0 19:20:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:20:01 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:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:01 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:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:01 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 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:01 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:20:01 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:20:01 INFO - Using env: {'DISPLAY': ':0', 19:20:01 INFO - 'HOME': '/home/cltbld', 19:20:01 INFO - 'LANG': 'en_US.UTF-8', 19:20:01 INFO - 'LANGUAGE': 'en_US:en', 19:20:01 INFO - 'LOGNAME': 'cltbld', 19:20:01 INFO - 'MAIL': '/var/mail/cltbld', 19:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:01 INFO - 'MOZ_NO_REMOTE': '1', 19:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:01 INFO - 'NO_EM_RESTART': '1', 19:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:01 INFO - 'PWD': '/builds/slave/test', 19:20:01 INFO - 'SHELL': '/bin/bash', 19:20:01 INFO - 'SHLVL': '1', 19:20:01 INFO - 'TERM': 'linux', 19:20:01 INFO - 'TMOUT': '86400', 19:20:01 INFO - 'USER': 'cltbld', 19:20:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:01 INFO - '_': '/tools/buildbot/bin/python'} 19:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:02 INFO - Downloading/unpacking jsonschema==2.5.1 19:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:20:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:03 INFO - Downloading functools32-3.2.3-2.tar.gz 19:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:20:03 INFO - warning: no files found matching '*.txt' 19:20:03 INFO - no previously-included directories found matching 'build' 19:20:03 INFO - no previously-included directories found matching 'dist' 19:20:03 INFO - no previously-included directories found matching '.git*' 19:20:03 INFO - Installing collected packages: jsonschema, functools32 19:20:03 INFO - Running setup.py install for functools32 19:20:03 INFO - warning: no files found matching '*.txt' 19:20:03 INFO - no previously-included directories found matching 'build' 19:20:03 INFO - no previously-included directories found matching 'dist' 19:20:03 INFO - no previously-included directories found matching '.git*' 19:20:03 INFO - Successfully installed jsonschema functools32 19:20:03 INFO - Cleaning up... 19:20:03 INFO - Return code: 0 19:20:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:20:03 INFO - Using env: {'DISPLAY': ':0', 19:20:03 INFO - 'HOME': '/home/cltbld', 19:20:03 INFO - 'LANG': 'en_US.UTF-8', 19:20:03 INFO - 'LANGUAGE': 'en_US:en', 19:20:03 INFO - 'LOGNAME': 'cltbld', 19:20:03 INFO - 'MAIL': '/var/mail/cltbld', 19:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:03 INFO - 'MOZ_NO_REMOTE': '1', 19:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:03 INFO - 'NO_EM_RESTART': '1', 19:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:03 INFO - 'PWD': '/builds/slave/test', 19:20:03 INFO - 'SHELL': '/bin/bash', 19:20:03 INFO - 'SHLVL': '1', 19:20:03 INFO - 'TERM': 'linux', 19:20:03 INFO - 'TMOUT': '86400', 19:20:03 INFO - 'USER': 'cltbld', 19:20:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:03 INFO - '_': '/tools/buildbot/bin/python'} 19:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:20:03 INFO - Cleaning up... 19:20:03 INFO - Return code: 0 19:20:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:20:03 INFO - Using env: {'DISPLAY': ':0', 19:20:03 INFO - 'HOME': '/home/cltbld', 19:20:03 INFO - 'LANG': 'en_US.UTF-8', 19:20:03 INFO - 'LANGUAGE': 'en_US:en', 19:20:03 INFO - 'LOGNAME': 'cltbld', 19:20:03 INFO - 'MAIL': '/var/mail/cltbld', 19:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:03 INFO - 'MOZ_NO_REMOTE': '1', 19:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:03 INFO - 'NO_EM_RESTART': '1', 19:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:03 INFO - 'PWD': '/builds/slave/test', 19:20:03 INFO - 'SHELL': '/bin/bash', 19:20:03 INFO - 'SHLVL': '1', 19:20:03 INFO - 'TERM': 'linux', 19:20:03 INFO - 'TMOUT': '86400', 19:20:03 INFO - 'USER': 'cltbld', 19:20:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:03 INFO - '_': '/tools/buildbot/bin/python'} 19:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:03 INFO - Downloading/unpacking blobuploader==1.2.4 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:05 INFO - Downloading blobuploader-1.2.4.tar.gz 19:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:20:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:20:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:05 INFO - Downloading docopt-0.6.1.tar.gz 19:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:20:05 INFO - Installing collected packages: blobuploader, requests, docopt 19:20:05 INFO - Running setup.py install for blobuploader 19:20:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:20:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:20:05 INFO - Running setup.py install for requests 19:20:06 INFO - Running setup.py install for docopt 19:20:06 INFO - Successfully installed blobuploader requests docopt 19:20:06 INFO - Cleaning up... 19:20:06 INFO - Return code: 0 19:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:20:06 INFO - Using env: {'DISPLAY': ':0', 19:20:06 INFO - 'HOME': '/home/cltbld', 19:20:06 INFO - 'LANG': 'en_US.UTF-8', 19:20:06 INFO - 'LANGUAGE': 'en_US:en', 19:20:06 INFO - 'LOGNAME': 'cltbld', 19:20:06 INFO - 'MAIL': '/var/mail/cltbld', 19:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:06 INFO - 'MOZ_NO_REMOTE': '1', 19:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:06 INFO - 'NO_EM_RESTART': '1', 19:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:06 INFO - 'PWD': '/builds/slave/test', 19:20:06 INFO - 'SHELL': '/bin/bash', 19:20:06 INFO - 'SHLVL': '1', 19:20:06 INFO - 'TERM': 'linux', 19:20:06 INFO - 'TMOUT': '86400', 19:20:06 INFO - 'USER': 'cltbld', 19:20:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:06 INFO - '_': '/tools/buildbot/bin/python'} 19:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:20:06 INFO - Running setup.py (path:/tmp/pip-i7J4VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:20:06 INFO - Running setup.py (path:/tmp/pip-33VrqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:20:06 INFO - Running setup.py (path:/tmp/pip-l1Gke6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:20:06 INFO - Running setup.py (path:/tmp/pip-p6hV9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:20:06 INFO - Running setup.py (path:/tmp/pip-wjSBhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:20:06 INFO - Running setup.py (path:/tmp/pip-bMN22o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:20:06 INFO - Running setup.py (path:/tmp/pip-1PJx0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:20:07 INFO - Running setup.py (path:/tmp/pip-hRmmmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:20:07 INFO - Running setup.py (path:/tmp/pip-M7vvOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:20:07 INFO - Running setup.py (path:/tmp/pip-eM3z3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:20:07 INFO - Running setup.py (path:/tmp/pip-JBsE_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:20:07 INFO - Running setup.py (path:/tmp/pip-M_WSIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:20:07 INFO - Running setup.py (path:/tmp/pip-UfplmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:20:07 INFO - Running setup.py (path:/tmp/pip-_CWApU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:07 INFO - Running setup.py (path:/tmp/pip-vegaK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:20:07 INFO - Running setup.py (path:/tmp/pip-Q2dr9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:20:07 INFO - Running setup.py (path:/tmp/pip-OxHgkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:20:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:20:07 INFO - Running setup.py install for manifestparser 19:20:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:20:07 INFO - Running setup.py install for mozcrash 19:20:07 INFO - Running setup.py install for mozdebug 19:20:08 INFO - Running setup.py install for mozdevice 19:20:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Running setup.py install for mozfile 19:20:08 INFO - Running setup.py install for mozhttpd 19:20:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Running setup.py install for mozinfo 19:20:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Running setup.py install for mozInstall 19:20:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Running setup.py install for mozleak 19:20:08 INFO - Running setup.py install for mozlog 19:20:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Running setup.py install for moznetwork 19:20:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:20:08 INFO - Running setup.py install for mozprocess 19:20:08 INFO - Running setup.py install for mozprofile 19:20:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:20:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:20:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:20:09 INFO - Running setup.py install for mozrunner 19:20:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:20:09 INFO - Running setup.py install for mozscreenshot 19:20:09 INFO - Running setup.py install for moztest 19:20:09 INFO - Running setup.py install for mozversion 19:20:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:20:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:20:09 INFO - Cleaning up... 19:20:09 INFO - Return code: 0 19:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:20:09 INFO - Using env: {'DISPLAY': ':0', 19:20:09 INFO - 'HOME': '/home/cltbld', 19:20:09 INFO - 'LANG': 'en_US.UTF-8', 19:20:09 INFO - 'LANGUAGE': 'en_US:en', 19:20:09 INFO - 'LOGNAME': 'cltbld', 19:20:09 INFO - 'MAIL': '/var/mail/cltbld', 19:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:09 INFO - 'MOZ_NO_REMOTE': '1', 19:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:09 INFO - 'NO_EM_RESTART': '1', 19:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:09 INFO - 'PWD': '/builds/slave/test', 19:20:09 INFO - 'SHELL': '/bin/bash', 19:20:09 INFO - 'SHLVL': '1', 19:20:09 INFO - 'TERM': 'linux', 19:20:09 INFO - 'TMOUT': '86400', 19:20:09 INFO - 'USER': 'cltbld', 19:20:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:09 INFO - '_': '/tools/buildbot/bin/python'} 19:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:20:09 INFO - Running setup.py (path:/tmp/pip-d3cSO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:20:09 INFO - Running setup.py (path:/tmp/pip-tpEaSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:20:09 INFO - Running setup.py (path:/tmp/pip-k38CLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:20:09 INFO - Running setup.py (path:/tmp/pip-dmumW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:20:10 INFO - Running setup.py (path:/tmp/pip-pWDnqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:20:10 INFO - Running setup.py (path:/tmp/pip-7LDY0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:20:10 INFO - Running setup.py (path:/tmp/pip-8vXScC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:20:10 INFO - Running setup.py (path:/tmp/pip-bao5Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:20:10 INFO - Running setup.py (path:/tmp/pip-gDbL8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:20:10 INFO - Running setup.py (path:/tmp/pip-vzXkAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:20:10 INFO - Running setup.py (path:/tmp/pip-JmOvn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:20:10 INFO - Running setup.py (path:/tmp/pip-6m7DKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:20:10 INFO - Running setup.py (path:/tmp/pip-QOL0Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:20:10 INFO - Running setup.py (path:/tmp/pip-_ERFAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:10 INFO - Running setup.py (path:/tmp/pip-Mg1ujC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:20:10 INFO - Running setup.py (path:/tmp/pip-lv0XAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:20:10 INFO - Running setup.py (path:/tmp/pip-0K1efF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:20:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:12 INFO - Downloading blessings-1.6.tar.gz 19:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:20:12 INFO - Installing collected packages: blessings 19:20:12 INFO - Running setup.py install for blessings 19:20:12 INFO - Successfully installed blessings 19:20:12 INFO - Cleaning up... 19:20:12 INFO - Return code: 0 19:20:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:20:12 INFO - Reading from file tmpfile_stdout 19:20:12 INFO - Current package versions: 19:20:12 INFO - argparse == 1.2.1 19:20:12 INFO - blessings == 1.6 19:20:12 INFO - blobuploader == 1.2.4 19:20:12 INFO - docopt == 0.6.1 19:20:12 INFO - functools32 == 3.2.3-2 19:20:12 INFO - jsonschema == 2.5.1 19:20:12 INFO - manifestparser == 1.1 19:20:12 INFO - mozInstall == 1.13 19:20:12 INFO - mozcrash == 1.0 19:20:12 INFO - mozdebug == 0.1 19:20:12 INFO - mozdevice == 0.51 19:20:12 INFO - mozfile == 1.2 19:20:12 INFO - mozhttpd == 0.7 19:20:12 INFO - mozinfo == 0.10 19:20:12 INFO - mozleak == 0.1 19:20:12 INFO - mozlog == 3.5 19:20:12 INFO - moznetwork == 0.27 19:20:12 INFO - mozprocess == 0.25 19:20:12 INFO - mozprofile == 0.28 19:20:12 INFO - mozrunner == 6.13 19:20:12 INFO - mozscreenshot == 0.1 19:20:12 INFO - mozsystemmonitor == 0.3 19:20:12 INFO - moztest == 0.8 19:20:12 INFO - mozversion == 1.4 19:20:12 INFO - psutil == 3.1.1 19:20:12 INFO - requests == 1.2.3 19:20:12 INFO - wsgiref == 0.1.2 19:20:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:20:12 INFO - Using env: {'DISPLAY': ':0', 19:20:12 INFO - 'HOME': '/home/cltbld', 19:20:12 INFO - 'LANG': 'en_US.UTF-8', 19:20:12 INFO - 'LANGUAGE': 'en_US:en', 19:20:12 INFO - 'LOGNAME': 'cltbld', 19:20:12 INFO - 'MAIL': '/var/mail/cltbld', 19:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:12 INFO - 'MOZ_NO_REMOTE': '1', 19:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:12 INFO - 'NO_EM_RESTART': '1', 19:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:12 INFO - 'PWD': '/builds/slave/test', 19:20:12 INFO - 'SHELL': '/bin/bash', 19:20:12 INFO - 'SHLVL': '1', 19:20:12 INFO - 'TERM': 'linux', 19:20:12 INFO - 'TMOUT': '86400', 19:20:12 INFO - 'USER': 'cltbld', 19:20:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:12 INFO - '_': '/tools/buildbot/bin/python'} 19:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:20:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:20:13 INFO - Installing collected packages: simplejson 19:20:13 INFO - Running setup.py install for simplejson 19:20:13 INFO - building 'simplejson._speedups' extension 19:20:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 19:20:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 19:20:14 INFO - Successfully installed simplejson 19:20:14 INFO - Cleaning up... 19:20:14 INFO - Return code: 0 19:20:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xede1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', '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:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:20:14 INFO - Using env: {'DISPLAY': ':0', 19:20:14 INFO - 'HOME': '/home/cltbld', 19:20:14 INFO - 'LANG': 'en_US.UTF-8', 19:20:14 INFO - 'LANGUAGE': 'en_US:en', 19:20:14 INFO - 'LOGNAME': 'cltbld', 19:20:14 INFO - 'MAIL': '/var/mail/cltbld', 19:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:14 INFO - 'MOZ_NO_REMOTE': '1', 19:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:14 INFO - 'NO_EM_RESTART': '1', 19:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:14 INFO - 'PWD': '/builds/slave/test', 19:20:14 INFO - 'SHELL': '/bin/bash', 19:20:14 INFO - 'SHLVL': '1', 19:20:14 INFO - 'TERM': 'linux', 19:20:14 INFO - 'TMOUT': '86400', 19:20:14 INFO - 'USER': 'cltbld', 19:20:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:14 INFO - '_': '/tools/buildbot/bin/python'} 19:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:20:15 INFO - Cleaning up... 19:20:15 INFO - Return code: 0 19:20:15 INFO - Running post-action listener: _resource_record_post_action 19:20:15 INFO - Running post-action listener: _start_resource_monitoring 19:20:15 INFO - Starting resource monitoring. 19:20:15 INFO - [mozharness: 2017-08-07 02:20:15.185469Z] Finished create-virtualenv step (success) 19:20:15 INFO - [mozharness: 2017-08-07 02:20:15.186051Z] Running install step. 19:20:15 INFO - Running pre-action listener: _resource_record_pre_action 19:20:15 INFO - Running main action method: install 19:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:20:15 INFO - Reading from file tmpfile_stdout 19:20:15 INFO - Detecting whether we're running mozinstall >=1.0... 19:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:20:15 INFO - Reading from file tmpfile_stdout 19:20:15 INFO - Output received: 19:20:15 INFO - Usage: mozinstall [options] installer 19:20:15 INFO - Options: 19:20:15 INFO - -h, --help show this help message and exit 19:20:15 INFO - -d DEST, --destination=DEST 19:20:15 INFO - Directory to install application into. [default: 19:20:15 INFO - "/builds/slave/test"] 19:20:15 INFO - --app=APP Application being installed. [default: firefox] 19:20:15 INFO - mkdir: /builds/slave/test/build/application 19:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:20:33 INFO - Reading from file tmpfile_stdout 19:20:33 INFO - Output received: 19:20:33 INFO - /builds/slave/test/build/application/firefox/firefox 19:20:33 INFO - Running post-action listener: _resource_record_post_action 19:20:33 INFO - [mozharness: 2017-08-07 02:20:33.477675Z] Finished install step (success) 19:20:33 INFO - [mozharness: 2017-08-07 02:20:33.477937Z] Running setup-mitmproxy step. 19:20:33 INFO - Running pre-action listener: _resource_record_pre_action 19:20:33 INFO - Running main action method: setup_mitmproxy 19:20:33 INFO - Skipping: mitmproxy is not required 19:20:33 INFO - Running post-action listener: _resource_record_post_action 19:20:33 INFO - [mozharness: 2017-08-07 02:20:33.479077Z] Finished setup-mitmproxy step (success) 19:20:33 INFO - [mozharness: 2017-08-07 02:20:33.479297Z] Running run-tests step. 19:20:33 INFO - Running pre-action listener: _resource_record_pre_action 19:20:33 INFO - Running pre-action listener: _set_gcov_prefix 19:20:33 INFO - Running main action method: run_tests 19:20:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:20:33 INFO - Python 2.7.3 19:20:33 INFO - Return code: 0 19:20:33 INFO - grabbing minidump binary from tooltool 19:20: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:20:33 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 0x124aeb0>, '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 0x124bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:20:33 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:20:33 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:20:33 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:20:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:20:33 INFO - Return code: 0 19:20:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:20:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:20:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:20:33 INFO - ENV: RUST_BACKTRACE is now 1 19:20:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:20:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:20:33 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/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:20:33 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/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:20:33 INFO - Using env: {'DISPLAY': ':0', 19:20:33 INFO - 'HOME': '/home/cltbld', 19:20:33 INFO - 'LANG': 'en_US.UTF-8', 19:20:33 INFO - 'LANGUAGE': 'en_US:en', 19:20:33 INFO - 'LOGNAME': 'cltbld', 19:20:33 INFO - 'MAIL': '/var/mail/cltbld', 19:20:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:20:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:33 INFO - 'MOZ_NO_REMOTE': '1', 19:20:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:20:33 INFO - 'NO_EM_RESTART': '1', 19:20:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:33 INFO - 'PWD': '/builds/slave/test', 19:20:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:20:33 INFO - 'RUST_BACKTRACE': '1', 19:20:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:20:33 INFO - 'SHELL': '/bin/bash', 19:20:33 INFO - 'SHLVL': '1', 19:20:33 INFO - 'STYLO_FORCE_ENABLED': '1', 19:20:33 INFO - 'TERM': 'linux', 19:20:33 INFO - 'TMOUT': '86400', 19:20:33 INFO - 'USER': 'cltbld', 19:20:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181', 19:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:33 INFO - '_': '/tools/buildbot/bin/python'} 19:20:33 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/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:20:33 INFO - mozversion application_buildid: 20170807011813 19:20:33 INFO - mozversion application_changeset: bb8de16ce00cb57b587a14c210ecc7505f366328 19:20:33 INFO - mozversion application_display_name: Nightly 19:20:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:20:33 INFO - mozversion application_name: Firefox 19:20:33 INFO - mozversion application_remotingname: firefox 19:20:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:20:33 INFO - mozversion application_vendor: Mozilla 19:20:33 INFO - mozversion application_version: 57.0a1 19:20:33 INFO - mozversion platform_buildid: 20170807011813 19:20:33 INFO - mozversion platform_changeset: bb8de16ce00cb57b587a14c210ecc7505f366328 19:20:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:20:33 INFO - mozversion platform_version: 57.0a1 19:20:33 INFO - using testdate: 1502072433 19:20:33 INFO - actual date: 1502072433 19:20:33 INFO - starting webserver on 'localhost:42820' 19:20:33 INFO - SUITE-START | Running 2 tests 19:20:33 INFO - TEST-START | dromaeo_css 19:20:33 INFO - Initialising browser for dromaeo_css test... 19:20:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42820/getInfo.html -profile /tmp/tmpDR8Rzw/profile 19:20:33 INFO - TEST-INFO | started process 23188 (/builds/slave/test/build/application/firefox/firefox http://localhost:42820/getInfo.html) 19:20:39 INFO - TEST-INFO | 23188: exit 0 19:20:39 INFO - Browser initialized. 19:20:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:20:39 INFO - TEST-INFO | started process 23413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDR8Rzw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:40 INFO - PID 23413 | 19:20:40 INFO - PID 23413 | (/builds/slave/test/build/application/firefox/firefox:23467): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:20:40 INFO - PID 23413 | 19:20:50 INFO - PID 23413 | RSS: Main: 169975808 19:20:50 INFO - PID 23413 | 19:20:50 INFO - PID 23413 | serialization: Helvetica 19:20:50 INFO - PID 23413 | serialization: Arial 19:23:49 INFO - PID 23413 | Cycle 1(1): loaded http://localhost:42820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42820/tests/dromaeo/cssquery-ext.html) 19:23:51 INFO - PID 23413 | RSS: Main: 172695552 19:23:51 INFO - PID 23413 | 19:23:51 INFO - PID 23413 | serialization: Helvetica 19:23:51 INFO - PID 23413 | serialization: Arial 19:26:53 INFO - PID 23413 | Cycle 1(1): loaded http://localhost:42820/tests/dromaeo/cssquery-ext.html (next: http://localhost:42820/tests/dromaeo/cssquery-jquery.html) 19:26:54 INFO - PID 23413 | RSS: Main: 172949504 19:26:54 INFO - PID 23413 | 19:26:54 INFO - PID 23413 | serialization: Helvetica 19:26:54 INFO - PID 23413 | serialization: Arial 19:29:55 INFO - PID 23413 | Cycle 1(1): loaded http://localhost:42820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42820/tests/dromaeo/cssquery-mootools.html) 19:29:56 INFO - PID 23413 | RSS: Main: 174460928 19:29:56 INFO - PID 23413 | 19:29:56 INFO - PID 23413 | serialization: Helvetica 19:29:56 INFO - PID 23413 | serialization: Arial 19:32:58 INFO - PID 23413 | Cycle 1(1): loaded http://localhost:42820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42820/tests/dromaeo/cssquery-prototype.html) 19:32:58 INFO - PID 23413 | RSS: Main: 172986368 19:32:58 INFO - PID 23413 | 19:32:58 INFO - PID 23413 | serialization: Helvetica 19:32:58 INFO - PID 23413 | serialization: Arial 19:36:02 INFO - PID 23413 | Cycle 1(1): loaded http://localhost:42820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42820/tests/dromaeo/cssquery-yui.html) 19:36:03 INFO - PID 23413 | RSS: Main: 176304128 19:36:03 INFO - PID 23413 | 19:36:03 INFO - PID 23413 | serialization: Helvetica 19:36:03 INFO - PID 23413 | serialization: Arial 19:39:04 INFO - PID 23413 | Cycle 1(1): loaded http://localhost:42820/tests/dromaeo/cssquery-yui.html (next: http://localhost:42820/tests/dromaeo/cssquery-dojo.html) 19:39:05 INFO - PID 23413 | RSS: Main: 177176576 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | __start_tp_report 19:39:05 INFO - PID 23413 | _x_x_mozilla_page_load 19:39:05 INFO - PID 23413 | _x_x_mozilla_page_load_details 19:39:05 INFO - PID 23413 | |i|pagename|runs| 19:39:05 INFO - PID 23413 | |0;dojo.html;3121.126084696286;3149.4960806271;3159.73142282906;3165.082126183407;3172.6510083890767;6183.690815459226;6218.471429928451;6246.219222597176;6282;6307.526935479835;6260.593061451013;6260.937390626093;6270.749170033205;6276.058591211309;6318.74725010999;5782.335031471372;5802.5938184327115;5818.650880947157;5837.445442682938;5851.122331650244;5785.27684039495;5818.8254352369495;5821.359650438449;5857.589968702193;5888.499477544414;5745.741441635116;5858.73635686393;5867.911981320283;5871.8532036699;5883.76464941404;5736.8852622947725;5817.418258174149;5820.767169313222;5880.059190529516;5892.823215303548;5538.252335934638;5681.0910254359105;5699.2306038684665;5743.052396354597;5778.0466223073145;6231.40801623845;6242.5942313749465;6255.249370075575;6264.686765661699;6297.370262973712;6699.665016749143;6705.966470167667;6792.558483698594;6799.252082270947;6807.591544507296;6776.593404395752;6784.59292442455;6859.108315918898;6860.828479288008;6866.279040700754;6152;6250.093736408241;6250.9373406521;6250.937490625081;6260.655663938436;6879.208890977501;6954.478414118961;6959.37365637085;6970.442364610819;6982.546134501241;6568.6058836469965;6660.167479065117;6664.766733164316;6679.899801502884;6682.732690692318;6723.294054124344;6779.35596118368;6803.251642319341;6804.693788779517;6811.557248778813;6536.281009088996;6666.366695163952;6695.899561506581;6770.52606317553;6773.93226067733;6655.733770649216;6669.199696036507;6672.466202703869;6681.799546013627;6715.832104197434;5371.4897084776885;5383.650062745909;5418.91871621926;5437.945620543744;5450;4670.322803193586;4678.415198100238;4692.0381321828945;4704.835330763407;4738.810447582058;5738.311402631711;5818.912716309259;5826.475617194473;5830.067189249699;5834.124881267844;6723.327667233335;6752.459803215731;6836.965815170893;6838.350356716104;6860.862782744317;5657.405972372924;5744.626599271034;5759.020966435716;5765.654060756368;5777.711114444261;5834.095715164156;5909.320428150818;5915.438033386821;5931.110333450017;5946.791862284799;6522.152120224436;6591.176102987127;6594.472442204612;6597.043428702811;6599.274079851117;6402.295747467868;6722.058911752456;6760.96619516919;6851.520393572402;6856.5200435969;6506.121673574007;6514.120593719977;6593.835154121185;6598.571092878948;6604.867902641824;6439.839004024937;6557.540972131905;6560.015997600398;6642.667866606747;6710.362515561014;6760.357766012221;6826.795196144124;6849.965750171217;6854.554453960476;6861.691223894837;6541.215054193527;6613.768518101843;6617.1066905969;6619.735210591522;6655.367740064686;6426.710798014007;6446.161998940108;6526.216853977363;6604.0093985902495;6620.205575330991;6373;6396.6481843497195;6443.613383197023;6537.836554086186;6542.476601871744;6379.681015949277;6587;6596.472282217507;6601.405873471411;6629.801105966829;5972.820815375546;6361.459275961595;6365.554411191358;6368.044793281045;6390.265119511316 19:39:05 INFO - PID 23413 | |1;ext.html;835.2274146414569;888.6845169964662;900.693764120199;915.4873270968257;1174.765046990601;32206.35587288256;33059.17352066196;45044.54955450445;46089.53910460894;46107.538924610744;45467.54532454674;46079;46119.30821037679;46129.308060379124;46172;7828.882566761503;8025.678972841109;8036.27673509384;8041.396895232851;8043.11525732169;7884.32983196429;7988.4408091433625;7994.840103197933;7995.2804247617705;7999.360051195919;7977.720779772709;8022.438429309951;8060.919390806105;8061.6372263248295;8062.798430039237;7955.244251796128;7975.521468711867;8006.439549231556;8031.196880311952;8031.2771850533145;7834.059912810442;7879.369650427952;7951.761447156537;7956.960215198945;7960;40855.591444085774;41203.793981030205;41219;41222.793886030675;41278.1744365114;3627.3470775260444;3663;3666.981665091684;3670.100825297819;3673.761205521659;32787.83606081954;32835;32846;32912.34175316504;33017.50473742896;5123.538881500645;5141.331626888518;5219.530242278175;5221.895562088775;5223.764930578133;195480;195586;196907;196926;197179;50534.49465505298;50743;50765.49234507682;50806;50826.49173508291;52213.47786522162;52279.477205227464;52577;52975.47024529782;52983.73508132435;14439.422423103168;14674;16185.352585896433;16544.338226470805;16704.498865034067;13618;13675.589732308046;13682.52111176124;13685.178889266675;13687.04190706641;15234.238288085551;15253.161076140697;15335;15426.691466170838;15501.457448989231;5914.112883067488;5994.400559943971;6105.633661980295;6154.230721159855;6177.752889884444;1000.4097582426404;1004.5379125602304;1019.6431249062917;1023.3706270643501;1035.6530562261576;23396.415089622555;23973.640395394083;24064.639030414557;30836.69163308338;31492.37015259682;1110.4225802582773;1117.8155604325195;1123.662901129658;1124.9775004500027;1131.5813149134872;12697.619071427873;12820.358982051046;12879.356032198353;12933.870661293455;12988.025898057684;241315;241964;241987;242088;243103;57267;58259.41740582624;58259.70870145622;58260;58617.41382586205;1458.8176477940258;1478.859508346684;1501.9699606008037;1507.6984603079427;1526.1682383101236;23970.64044039306;28665.28336791597;29585;29891.850540747157;30324;56483.15275270792;56932.715336423054;57049.42950570607;57145;57180.42819571918;211444;213259;213571;213954;213999;38834.417483737205;40508;41262.58737412708;41308;41366.86331366959;48863.755681222785;50877.49122508727;51159.48840511547;51290.74354628203;51504.22743658773;36695.449568255965;36742.8162859184;37340.6265937348;37400.25199496049;37668.24663506769;35907.82046089753;36070.8196459016;36331.45502817513;36845.63154368422;36925.26149476942;39622.40566391449;39677.404838926865;39711.20577588374;39779.60220397759;39841.80079099586;35540.822295888356;35587.28825423529;35614;35730.821345893106;35798.8210058948;25280.36799079964;25580.616290756025;25632.359191020372;25927.351816204748;26357 19:39:05 INFO - PID 23413 | |2;jquery.html;580.5848818095061;587.8354060862958;593.7684303121786;597.3936454498681;604.7973928733874;22943.54112917743;23726.932288047035;23785.881070594645;23817;23923.5215295694;21521.031553580087;21595.892020539875;23195.76804231957;24882.751172488268;27703.445931081365;6418.614883107005;6562.606243625374;6567.211934567858;6568.310327415625;6571.67141642916;6521.217453905538;6544.901826472606;6560.179977502812;6566.901496477557;6578.0132980052895;6016.187814645011;6509.837254068662;6603.438707709851;6616.768413105542;6618.4705223582;6547.476201903836;6562.80311590653;6571.112899758519;6597.307282735315;6600.504962127836;6090.147379366892;6121.051237058263;6124.2650881894015;6125.295591007047;6133.907991380132;29425;29868.253293667614;30538.236544086354;30592.388152236832;31442.37115257705;1884.7738271407381;1949.9025048747505;1952.5899561092187;1953.2675246782458;1955.0615704461939;19934.70097948532;20613.07241174151;20705.482362940897;20761.480962975897;20769.480762980897;2343.109618345035;2395.9161429350065;2420.165043060141;2443.4135807406096;2569.1393383216646;131675.34162329222;139567;139828;139905;142487;14735.452777458213;15469.303881325368;15475.226238688021;15684.215789210493;16090.517284481484;24783;24808.00767969297;24821.751782482304;24822;24861.254162375157;10524.789504209873;10587.205959553065;10633.361998280128;10782.245242833083;10858.294210876267;9772.413655180711;9774.706758797247;9846.113849753556;9946.502674866228;9978.850317245247;9459.621615135455;9796.559154838049;9863.901360986441;9921.900780992242;9949.701508954742;2630.1983141548103;2632.8157029007784;2641.656584643984;2648.165827764248;2694.191742477249;979.2606582030521;991.3011327014437;998.7702828349375;1008.7578981044643;1014.5383850348074;19674.60650786976;19926.103325350396;20027.399178024683;20223.696644550342;20440;1061.7239517725448;1063.2822844580032;1066.402814423925;1070.261519551507;1071.4856868702911;10898.291611045257;11275.887241127484;11336.773264534662;11366.033887119522;11410.37242951629;507626;523222.53554928687;529694;534767;535194;113983;114571;115050;115268.42365788117;117579;1062.5112448273726;1211.4366819429008;1224.675461002835;1252.8684488128615;1265.0322503284995;20813;21154.471138221666;21196.470088247916;21318.573628527654;21617.567648647255;56762.432375675715;56812.43187568071;57217.42782572287;58773.412265876796;62486.6875665637;71412.64293678498;71744;72124.63937680278;72863;73560.63219684082;14973.925130374279;15583.298751556435;15610.843891560939;15623.609409764847;15676.68646627084;24239.878800605886;24907.252782416555;25047.248582542554;25566;26069;19480.8051919479;19568.315108971117;19758.703619445434;19860.80139198647;19948.10233539465;17819.910900445415;17993.936760511675;18327.816721832613;18347.26610935601;18589.44231673052;19338.129784160028;20068.39794806158;20561;20657.17371305131;20881.477963050438;14893.702125957638;15073.095614263179;15208.46770363032;15254.313555890234;15285.694286114438;18841.528961776065;19181.136848842114;19384.70922936185;19388.321408750628;19449.805501945364 19:39:05 INFO - PID 23413 | |3;mootools.html;1355.7491864005158;1423.4662001749343;1436.4613270023744;1437.6693360527072;1443.4226309476207;13747.793783093262;14335.641608959768;14416.927915360422;14455.638609034779;14459.5662130136;13767;14870.33083511242;14885.92557037216;14928.925355373234;14955.177465239407;2648.549746543092;2685.530032244359;2696.9460610787773;2718.877650505722;2729.140320798942;2526.9494610107786;2565.0637517306236;2679.624852520639;2720.1295585412677;2733.4669739400824;2737.2609395463214;2764.8755805988676;2764.8894044238205;2765.184270640156;2769.10004248619;2604.427026054265;2626.8292560983473;2666.386731051869;2670.8531030793297;2680.3299175206103;2516.8615726135054;2549.2734570647276;2549.821512494126;2555.782758465533;2558.616207568861;13807.585772426843;14127.929360353235;14140.434382624786;14142.50501232452;14159.71680566383;7644.770656880302;7865.252800983897;7916.485428447132;7936.603169841543;7969.282764551218;4872.853814385574;4999.700017998932;5092.26162206478;5110.821121260738;5114.846554603368;1834.9449516514526;1837.9908100459413;1854.7866995295578;1865.5149661088215;1884.180381534037;23371.298861034196;23591.528169436515;23591.646125308132;23628.409289767893;23677;6501.804945851632;6575.210974682973;6649.135612370457;6757.594544327356;6759.695813688298;15376.461823836113;16505.6698866022;16571.25429355682;16577.254023568727;16603.252853621616;7585.962070189614;7641.961790191124;7733.033370828646;7761.214920568301;7830.138684744674;7127.10911136108;7142.357187853014;7216.278372162742;7277.8544429111125;7339.266073392618;5093.9745301274;5221.738913054408;5238.816641417532;5254.894902101936;5276.234945932895;1559.3684557754127;1559.555526674915;1565.4833904811385;1565.968680626404;1575.9133247671489;868.9826203475895;895.4492986813063;899.50077706872;903.4127816919055;905.0813424374265;7221.711131554784;8423.410361274775;8843.513606751561;8949.776255593531;9010.684626038057;981.2444417798256;1002.7743757654615;1005.0753306957616;1005.6982905128432;1015.2030655935056;4935.259711043301;5034.295198672189;5332.680039197583;5340.946590534123;5410.513053825174;19249.13378897953;19280.22879084821;19697;19725.309614163434;19958;19135.425937221906;19697.606047878962;19707.901460492605;19737.111829967685;19765.505862353555;10410.68767936963;10764.192685548614;10899.83650245247;11144.665660030212;11175.105991520659;8063.717769878261;8325.209105135002;8447.915520844714;8698.695545655872;8841.381103322705;17101;17205.827941720923;17748.733768993734;17822.5544361392;17984;17659.558511036812;17794.733079004083;17937.103144842444;17969.281228750704;17980.91009544944;11527.135464840003;11730.354830484406;11734.471948762155;11795.056395488169;11876.76246475083;12717.427715752998;13172.802407963696;13176.868231317565;13177.868221317663;13185.142965707582;10784.299020563638;10865.348079115278;10933.070688991525;11007.449627518432;11176.608818691308;10211.489425528545;10352.689419317432;10807.459627018461;11106.888931110585;11225;9387.624495020396;9495.192908602847;9507.239420846454;9510.762230944281;9529.237660987243;6749.662516874038;6935.271796461299;6948.235694073547;6953.33943275388;7014.649267536704;7145.571265724073;7201.603911784902;7217.24218957002;7299.124105107421;7396.0754905636795 19:39:05 INFO - PID 23413 | |4;prototype.html;499.9750012499374;507.3353906382639;522.5767128625813;524.824183898394;534.6658338538414;6208.348123447029;6224.502039836813;6292.307846136921;6292.685365731712;6299.968500157504;6093.9889836354005;6123.418275263843;6176.783812566561;6185.144456663005;6217.316095229532;5110.897782044357;5136.178211486163;5136.332276804011;5158.9742051289695;5173.6119791015635;4738.265568836836;4986.476419975905;5095.751540872491;5129.281900533928;5170.53465188133;4909.779059942293;4943.332650092228;4961.18140506816;4963.627727920402;4989.65072444929;4906.484819093979;4934.25986102084;4945.975270123627;4987.675801072936;4988.42633097193;4429.614681465358;4496.5278645742055;4499.325101234841;4501.41481607389;4501.864944051684;5962.582619216657;5985.431384018511;6054.790960790788;6062.939370606282;6139.478144357735;5686.857828554278;5706.258186435778;5706.71466426677;5740.368559458456;5765.769369225226;6352.968235158794;6465.83835404114;6500.642464664442;6526.445252153572;6564.474842012628;4877.414840176957;4897.804087836482;4900.289458028566;4902.65681402302;4917.385326834145;6565.93434065658;6657.23441804189;6730.697118629673;6813.9318606813795;6997.615131167784;4792.856214313576;4971.527704868032;4983.327250821165;5001.574866136347;5020.874478138003;5029.471905449948;5037.11850426174;5048.29323894655;5060.772265247999;5084.339035925306;5663.688497132614;5691.373948865621;5727.684977326204;5733.8566535836935;5775.971120144372;6573.506986975996;6629.900551491732;6631.801045968628;6649.534532582769;6685.966570167216;1751.1769468349855;1755.920983555743;1778.9110544472724;1780.3323753592404;1796.9281228750965;1153.5904753812445;1210.5581462766027;1229.5512138069719;1229.8893099621077;1250.8498980122445;5721.39925307845;5745.482906538348;5761.452661997104;5800;5805.477507024304;6741.797746067527;6767.221769496571;6772.288909664513;6794.655843733904;6805.183377994672;5737.282839645044;5746.88506229873;5763.625364351304;5766.625169363978;5780.88438231233;3567.8037707925796;3583.928321433557;3608.530890984155;3623.148560088377;3628.256207477461;6461.547691661539;6477.838054048592;6486.6702326024;6488.513361497907;6534.509911756542;6823.897641535381;6826.726930922708;6920.377166055079;6960.651967401711;6981.232064472904;6453.548251622341;6520.250171230275;6574.868502630016;6630.469562434993;6634.966825165843;6647.767328143492;6679.265280819009;6683.331666833472;6713;6740.797776066725;6099.725512351866;6521.217453905561;6661.93480021195;6682.63245521501;6763.425108865801;6439.3238709934785;6440.388163124496;6455;6547.541672083099;6584.506162037962;5039.319691841554;5052.393712754493;5070.721110338966;5090.898182036412;5097.847064588068;6539.378759017885;6688.83277918056;6699.832504187434;6832.350926661959;6841.692123854538;6415.679216039272;6529.67351632426;6570.5400621956005;6584.901226481511;6596.60420374779;6415.582987105823;6558.311377305505;6561.934380656132;6576.243731970884;6587.538872278895;6494.447971922439;6505.381988711065;6507.642079685663;6510.18622672166;6553;6539.673016349258;6636.601803891782;6652.368025037614;6664.366885145903;6678.966605166943;6360.650164241011;6409.230892292955;6453.225612926479;6459.580127291711;6489.156409666713 19:39:05 INFO - PID 23413 | |5;yui.html;895.3911340288605;901.5582364641326;921.9400738951967;924.1405492891616;924.5192499900052;16845.91577042116;17754.64490710185;17779.73330400045;20860.791392086074;21919.890400547974;19444.51388715283;19456.805431945675;19838.20647174115;19943.10256038478;20291.28980485683;1008.9293749437543;1043.1081425381303;1043.2957753516384;1043.6503771236607;1045.4302405189153;1022.4478781458041;1050.4327663061938;1052.3790963331633;1064.0689396777818;1067.146282973618;1117.2235296468957;1117.8211486162215;1118.6084870295372;1120.1430905357408;1120.9495572699248;1098.5880294889378;1104.9337039777638;1107.640016994472;1108.3294606762872;1109.7447587054983;810.6190090657382;813.0852790610563;813.4387272781762;815.6655771133807;816.5753808019797;18686.25254989799;19321.613567728567;19671.704924426143;19718.112684929212;19950.401487955238;21402.357929262147;21716.34850954474;21986.230481933057;22206.555868882693;22377.10491580335;15328.770068448983;15521.379144834305;15536.067835929767;15578.376864925389;15697.529074127795;3655.0679576708035;3707.9073023174365;3713.6472035156617;3725.8137093145233;3735.0475628714776;127873;128376.58117094108;129880;131760;131970;15813.762793558106;16018.199090045451;16300;16365.83634163667;16450.67098658044;30594.38811223763;31147.84426077855;31206.687933120833;31501.212469687984;31616;8582.227599516074;8607.913920860712;8670;8679.696210632725;8696.434731742416;4267.5732426757695;4462.196804575207;4490.50604433512;4508.887277818081;4518.909621807546;5201.531862132426;5248.422673505911;5258.290130832365;5283.233931079972;5724.856878577985;1087.331291255872;1113.4154568851418;1129.1249281806665;1132.6262333429947;1139.4132022008673;529.0635575032171;531.6066111077774;531.9228711836762;536.6806749983754;536.8013834881119;10622.670357453333;11033.062189713804;11210.159238057178;11631.47658355376;11801.52793888235;539.9055165346127;541.2341536725568;545.4845171313071;555.2698201864536;558.2826068501955;4910.926336104962;4936.703797772145;5199;5237.8428647140645;5427.29445172133;99698;103965.48017259865;104197.47901260445;106235;108890;84310.15689843145;87964;90377.54811225901;91653;95685.52157239169;78777.60611196907;79602.20397795948;79692.60153699195;82457;85709;10356.326838755456;10397.688069357931;10470.214733894836;10589.258751887293;10682;37014.814925925195;37262.813685931396;37281.25437491289;38574.42138367983;38582;44342.77828610966;47415;47435;48331.758341209475;49034;14459.927700361432;14565.344559494637;14741.705165896836;14878.479253226518;14890.181040042902;15075.09549426994;15214.391424343345;15234.466793662168;15310;15581.844181558039;14130.434782608581;14547.490837820626;14588.562343129723;14637.634059148606;16309.26608302653;16889.155542223085;16989.745153822456;17556.561085972953;17683;17886.5528361792;15757;15849.68300634004;15880.761788573413;15902.840971590598;16782.412615558398;11383.772324553296;11561.653150405502;11645.126615503701;11849.407529623657;12261.816072758736;12477.688057798629;12525.812112818132;12844.165129266568;12862;12877.420516076987 19:39:05 INFO - PID 23413 | __end_tp_report 19:39:05 INFO - PID 23413 | __start_cc_report 19:39:05 INFO - PID 23413 | _x_x_mozilla_cycle_collect,352 19:39:05 INFO - PID 23413 | __end_cc_report 19:39:05 INFO - PID 23413 | __startTimestamp1502073545234__endTimestamp 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | ------- Summary: start ------- 19:39:05 INFO - PID 23413 | Number of tests: 6 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | [#0] dojo.html Cycles:165 Average:6200.52 Median:6396.65 stddev:736.10 (11.5%) stddev-sans-first:697.59 19:39:05 INFO - PID 23413 | Values: 3121.1 3149.5 3159.7 3165.1 3172.7 6183.7 6218.5 6246.2 6282.0 6307.5 6260.6 6260.9 6270.7 6276.1 6318.7 5782.3 5802.6 5818.7 5837.4 5851.1 5785.3 5818.8 5821.4 5857.6 5888.5 5745.7 5858.7 5867.9 5871.9 5883.8 5736.9 5817.4 5820.8 5880.1 5892.8 5538.3 5681.1 5699.2 5743.1 5778.0 6231.4 6242.6 6255.2 6264.7 6297.4 6699.7 6706.0 6792.6 6799.3 6807.6 6776.6 6784.6 6859.1 6860.8 6866.3 6152.0 6250.1 6250.9 6250.9 6260.7 6879.2 6954.5 6959.4 6970.4 6982.5 6568.6 6660.2 6664.8 6679.9 6682.7 6723.3 6779.4 6803.3 6804.7 6811.6 6536.3 6666.4 6695.9 6770.5 6773.9 6655.7 6669.2 6672.5 6681.8 6715.8 5371.5 5383.7 5418.9 5437.9 5450.0 4670.3 4678.4 4692.0 4704.8 4738.8 5738.3 5818.9 5826.5 5830.1 5834.1 6723.3 6752.5 6837.0 6838.4 6860.9 5657.4 5744.6 5759.0 5765.7 5777.7 5834.1 5909.3 5915.4 5931.1 5946.8 6522.2 6591.2 6594.5 6597.0 6599.3 6402.3 6722.1 6761.0 6851.5 6856.5 6506.1 6514.1 6593.8 6598.6 6604.9 6439.8 6557.5 6560.0 6642.7 6710.4 6760.4 6826.8 6850.0 6854.6 6861.7 6541.2 6613.8 6617.1 6619.7 6655.4 6426.7 6446.2 6526.2 6604.0 6620.2 6373.0 6396.6 6443.6 6537.8 6542.5 6379.7 6587.0 6596.5 6601.4 6629.8 5972.8 6361.5 6365.6 6368.0 6390.3 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | [#1] ext.html Cycles:180 Average:40807.71 Median:37370.44 stddev:56549.67 (151.3%) stddev-sans-first:56628.65 19:39:05 INFO - PID 23413 | Values: 835.2 888.7 900.7 915.5 1174.8 32206.4 33059.2 45044.5 46089.5 46107.5 45467.5 46079.0 46119.3 46129.3 46172.0 7828.9 8025.7 8036.3 8041.4 8043.1 7884.3 7988.4 7994.8 7995.3 7999.4 7977.7 8022.4 8060.9 8061.6 8062.8 7955.2 7975.5 8006.4 8031.2 8031.3 7834.1 7879.4 7951.8 7957.0 7960.0 40855.6 41203.8 41219.0 41222.8 41278.2 3627.3 3663.0 3667.0 3670.1 3673.8 32787.8 32835.0 32846.0 32912.3 33017.5 5123.5 5141.3 5219.5 5221.9 5223.8 195480.0 195586.0 196907.0 196926.0 197179.0 50534.5 50743.0 50765.5 50806.0 50826.5 52213.5 52279.5 52577.0 52975.5 52983.7 14439.4 14674.0 16185.4 16544.3 16704.5 13618.0 13675.6 13682.5 13685.2 13687.0 15234.2 15253.2 15335.0 15426.7 15501.5 5914.1 5994.4 6105.6 6154.2 6177.8 1000.4 1004.5 1019.6 1023.4 1035.7 23396.4 23973.6 24064.6 30836.7 31492.4 1110.4 1117.8 1123.7 1125.0 1131.6 12697.6 12820.4 12879.4 12933.9 12988.0 241315.0 241964.0 241987.0 242088.0 243103.0 57267.0 58259.4 58259.7 58260.0 58617.4 1458.8 1478.9 1502.0 1507.7 1526.2 23970.6 28665.3 29585.0 29891.9 30324.0 56483.2 56932.7 57049.4 57145.0 57180.4 211444.0 213259.0 213571.0 213954.0 213999.0 38834.4 40508.0 41262.6 41308.0 41366.9 48863.8 50877.5 51159.5 51290.7 51504.2 36695.4 36742.8 37340.6 37400.3 37668.2 35907.8 36070.8 36331.5 36845.6 36925.3 39622.4 39677.4 39711.2 39779.6 39841.8 35540.8 35587.3 35614.0 35730.8 35798.8 25280.4 25580.6 25632.4 25927.4 26357.0 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | [#2] jquery.html Cycles:180 Average:36355.70 Median:12769.44 stddev:88113.50 (690.0%) stddev-sans-first:88319.74 19:39:05 INFO - PID 23413 | Values: 580.6 587.8 593.8 597.4 604.8 22943.5 23726.9 23785.9 23817.0 23923.5 21521.0 21595.9 23195.8 24882.8 27703.4 6418.6 6562.6 6567.2 6568.3 6571.7 6521.2 6544.9 6560.2 6566.9 6578.0 6016.2 6509.8 6603.4 6616.8 6618.5 6547.5 6562.8 6571.1 6597.3 6600.5 6090.1 6121.1 6124.3 6125.3 6133.9 29425.0 29868.3 30538.2 30592.4 31442.4 1884.8 1949.9 1952.6 1953.3 1955.1 19934.7 20613.1 20705.5 20761.5 20769.5 2343.1 2395.9 2420.2 2443.4 2569.1 131675.3 139567.0 139828.0 139905.0 142487.0 14735.5 15469.3 15475.2 15684.2 16090.5 24783.0 24808.0 24821.8 24822.0 24861.3 10524.8 10587.2 10633.4 10782.2 10858.3 9772.4 9774.7 9846.1 9946.5 9978.9 9459.6 9796.6 9863.9 9921.9 9949.7 2630.2 2632.8 2641.7 2648.2 2694.2 979.3 991.3 998.8 1008.8 1014.5 19674.6 19926.1 20027.4 20223.7 20440.0 1061.7 1063.3 1066.4 1070.3 1071.5 10898.3 11275.9 11336.8 11366.0 11410.4 507626.0 523222.5 529694.0 534767.0 535194.0 113983.0 114571.0 115050.0 115268.4 117579.0 1062.5 1211.4 1224.7 1252.9 1265.0 20813.0 21154.5 21196.5 21318.6 21617.6 56762.4 56812.4 57217.4 58773.4 62486.7 71412.6 71744.0 72124.6 72863.0 73560.6 14973.9 15583.3 15610.8 15623.6 15676.7 24239.9 24907.3 25047.2 25566.0 26069.0 19480.8 19568.3 19758.7 19860.8 19948.1 17819.9 17993.9 18327.8 18347.3 18589.4 19338.1 20068.4 20561.0 20657.2 20881.5 14893.7 15073.1 15208.5 15254.3 15285.7 18841.5 19181.1 19384.7 19388.3 19449.8 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | [#3] mootools.html Cycles:180 Average:8903.64 Median:2538.11 stddev:6079.64 (239.5%) stddev-sans-first:6070.25 19:39:05 INFO - PID 23413 | Values: 1355.7 1423.5 1436.5 1437.7 1443.4 13747.8 14335.6 14416.9 14455.6 14459.6 13767.0 14870.3 14885.9 14928.9 14955.2 2648.5 2685.5 2696.9 2718.9 2729.1 2526.9 2565.1 2679.6 2720.1 2733.5 2737.3 2764.9 2764.9 2765.2 2769.1 2604.4 2626.8 2666.4 2670.9 2680.3 2516.9 2549.3 2549.8 2555.8 2558.6 13807.6 14127.9 14140.4 14142.5 14159.7 7644.8 7865.3 7916.5 7936.6 7969.3 4872.9 4999.7 5092.3 5110.8 5114.8 1834.9 1838.0 1854.8 1865.5 1884.2 23371.3 23591.5 23591.6 23628.4 23677.0 6501.8 6575.2 6649.1 6757.6 6759.7 15376.5 16505.7 16571.3 16577.3 16603.3 7586.0 7642.0 7733.0 7761.2 7830.1 7127.1 7142.4 7216.3 7277.9 7339.3 5094.0 5221.7 5238.8 5254.9 5276.2 1559.4 1559.6 1565.5 1566.0 1575.9 869.0 895.4 899.5 903.4 905.1 7221.7 8423.4 8843.5 8949.8 9010.7 981.2 1002.8 1005.1 1005.7 1015.2 4935.3 5034.3 5332.7 5340.9 5410.5 19249.1 19280.2 19697.0 19725.3 19958.0 19135.4 19697.6 19707.9 19737.1 19765.5 10410.7 10764.2 10899.8 11144.7 11175.1 8063.7 8325.2 8447.9 8698.7 8841.4 17101.0 17205.8 17748.7 17822.6 17984.0 17659.6 17794.7 17937.1 17969.3 17980.9 11527.1 11730.4 11734.5 11795.1 11876.8 12717.4 13172.8 13176.9 13177.9 13185.1 10784.3 10865.3 10933.1 11007.4 11176.6 10211.5 10352.7 10807.5 11106.9 11225.0 9387.6 9495.2 9507.2 9510.8 9529.2 6749.7 6935.3 6948.2 6953.3 7014.6 7145.6 7201.6 7217.2 7299.1 7396.1 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | [#4] prototype.html Cycles:180 Average:5521.86 Median:6111.57 stddev:1543.35 (25.3%) stddev-sans-first:1500.95 19:39:05 INFO - PID 23413 | Values: 500.0 507.3 522.6 524.8 534.7 6208.3 6224.5 6292.3 6292.7 6300.0 6094.0 6123.4 6176.8 6185.1 6217.3 5110.9 5136.2 5136.3 5159.0 5173.6 4738.3 4986.5 5095.8 5129.3 5170.5 4909.8 4943.3 4961.2 4963.6 4989.7 4906.5 4934.3 4946.0 4987.7 4988.4 4429.6 4496.5 4499.3 4501.4 4501.9 5962.6 5985.4 6054.8 6062.9 6139.5 5686.9 5706.3 5706.7 5740.4 5765.8 6353.0 6465.8 6500.6 6526.4 6564.5 4877.4 4897.8 4900.3 4902.7 4917.4 6565.9 6657.2 6730.7 6813.9 6997.6 4792.9 4971.5 4983.3 5001.6 5020.9 5029.5 5037.1 5048.3 5060.8 5084.3 5663.7 5691.4 5727.7 5733.9 5776.0 6573.5 6629.9 6631.8 6649.5 6686.0 1751.2 1755.9 1778.9 1780.3 1796.9 1153.6 1210.6 1229.6 1229.9 1250.8 5721.4 5745.5 5761.5 5800.0 5805.5 6741.8 6767.2 6772.3 6794.7 6805.2 5737.3 5746.9 5763.6 5766.6 5780.9 3567.8 3583.9 3608.5 3623.1 3628.3 6461.5 6477.8 6486.7 6488.5 6534.5 6823.9 6826.7 6920.4 6960.7 6981.2 6453.5 6520.3 6574.9 6630.5 6635.0 6647.8 6679.3 6683.3 6713.0 6740.8 6099.7 6521.2 6661.9 6682.6 6763.4 6439.3 6440.4 6455.0 6547.5 6584.5 5039.3 5052.4 5070.7 5090.9 5097.8 6539.4 6688.8 6699.8 6832.4 6841.7 6415.7 6529.7 6570.5 6584.9 6596.6 6415.6 6558.3 6561.9 6576.2 6587.5 6494.4 6505.4 6507.6 6510.2 6553.0 6539.7 6636.6 6652.4 6664.4 6679.0 6360.7 6409.2 6453.2 6459.6 6489.2 19:39:05 INFO - PID 23413 | 19:39:05 INFO - PID 23413 | [#5] yui.html Cycles:180 Average:22057.12 Median:17833.14 stddev:30705.93 (172.2%) stddev-sans-first:30750.95 19:39:05 INFO - PID 23413 | Values: 895.4 901.6 921.9 924.1 924.5 16845.9 17754.6 17779.7 20860.8 21919.9 19444.5 19456.8 19838.2 19943.1 20291.3 1008.9 1043.1 1043.3 1043.7 1045.4 1022.4 1050.4 1052.4 1064.1 1067.1 1117.2 1117.8 1118.6 1120.1 1120.9 1098.6 1104.9 1107.6 1108.3 1109.7 810.6 813.1 813.4 815.7 816.6 18686.3 19321.6 19671.7 19718.1 19950.4 21402.4 21716.3 21986.2 22206.6 22377.1 15328.8 15521.4 15536.1 15578.4 15697.5 3655.1 3707.9 3713.6 3725.8 3735.0 127873.0 128376.6 129880.0 131760.0 131970.0 15813.8 16018.2 16300.0 16365.8 16450.7 30594.4 31147.8 31206.7 31501.2 31616.0 8582.2 8607.9 8670.0 8679.7 8696.4 4267.6 4462.2 4490.5 4508.9 4518.9 5201.5 5248.4 5258.3 5283.2 5724.9 1087.3 1113.4 1129.1 1132.6 1139.4 529.1 531.6 531.9 536.7 536.8 10622.7 11033.1 11210.2 11631.5 11801.5 539.9 541.2 545.5 555.3 558.3 4910.9 4936.7 5199.0 5237.8 5427.3 99698.0 103965.5 104197.5 106235.0 108890.0 84310.2 87964.0 90377.5 91653.0 95685.5 78777.6 79602.2 79692.6 82457.0 85709.0 10356.3 10397.7 10470.2 10589.3 10682.0 37014.8 37262.8 37281.3 38574.4 38582.0 44342.8 47415.0 47435.0 48331.8 49034.0 14459.9 14565.3 14741.7 14878.5 14890.2 15075.1 15214.4 15234.5 15310.0 15581.8 14130.4 14547.5 14588.6 14637.6 16309.3 16889.2 16989.7 17556.6 17683.0 17886.6 15757.0 15849.7 15880.8 15902.8 16782.4 11383.8 11561.7 11645.1 11849.4 12261.8 12477.7 12525.8 12844.2 12862.0 12877.4 19:39:05 INFO - PID 23413 | -------- Summary: end -------- 19:39:05 INFO - PID 23413 | 19:39:05 INFO - TEST-INFO | 23413: exit 0 19:39:05 INFO - TEST-OK | dromaeo_css | took 1112046ms 19:39:05 INFO - TEST-START | kraken 19:39:05 INFO - Initialising browser for kraken test... 19:39:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42820/getInfo.html -profile /tmp/tmpgblCgH/profile 19:39:05 INFO - TEST-INFO | started process 23781 (/builds/slave/test/build/application/firefox/firefox http://localhost:42820/getInfo.html) 19:39:10 INFO - TEST-INFO | 23781: exit 0 19:39:11 INFO - Browser initialized. 19:39:11 INFO - Running cycle 1/1 for kraken test... 19:39:11 INFO - TEST-INFO | started process 24008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgblCgH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:39:11 INFO - PID 24008 | 19:39:11 INFO - PID 24008 | (/builds/slave/test/build/application/firefox/firefox:24061): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:39:12 INFO - PID 24008 | 19:39:22 INFO - PID 24008 | RSS: Main: 173944832 19:39:22 INFO - PID 24008 | 19:39:22 INFO - PID 24008 | serialization: Helvetica 19:39:22 INFO - PID 24008 | serialization: Arial 19:39:25 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42820/tests/kraken/driver.html?testName=audio-beat-detection) 19:39:25 INFO - PID 24008 | RSS: Main: 178851840 19:39:25 INFO - PID 24008 | 19:39:26 INFO - PID 24008 | serialization: Helvetica 19:39:26 INFO - PID 24008 | serialization: Arial 19:39:28 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42820/tests/kraken/driver.html?testName=audio-dft) 19:39:29 INFO - PID 24008 | RSS: Main: 179650560 19:39:29 INFO - PID 24008 | 19:39:29 INFO - PID 24008 | serialization: Helvetica 19:39:29 INFO - PID 24008 | serialization: Arial 19:39:32 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42820/tests/kraken/driver.html?testName=audio-fft) 19:39:33 INFO - PID 24008 | RSS: Main: 174395392 19:39:33 INFO - PID 24008 | 19:39:33 INFO - PID 24008 | serialization: Helvetica 19:39:33 INFO - PID 24008 | serialization: Arial 19:39:35 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42820/tests/kraken/driver.html?testName=audio-oscillator) 19:39:35 INFO - PID 24008 | RSS: Main: 174718976 19:39:35 INFO - PID 24008 | 19:39:35 INFO - PID 24008 | serialization: Helvetica 19:39:35 INFO - PID 24008 | serialization: Arial 19:39:38 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:39:38 INFO - PID 24008 | RSS: Main: 174874624 19:39:38 INFO - PID 24008 | 19:39:38 INFO - PID 24008 | serialization: Helvetica 19:39:38 INFO - PID 24008 | serialization: Arial 19:39:41 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42820/tests/kraken/driver.html?testName=imaging-darkroom) 19:39:42 INFO - PID 24008 | RSS: Main: 177283072 19:39:42 INFO - PID 24008 | 19:39:42 INFO - PID 24008 | serialization: Helvetica 19:39:42 INFO - PID 24008 | serialization: Arial 19:39:46 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42820/tests/kraken/driver.html?testName=imaging-desaturate) 19:39:46 INFO - PID 24008 | RSS: Main: 176254976 19:39:46 INFO - PID 24008 | 19:39:46 INFO - PID 24008 | serialization: Helvetica 19:39:46 INFO - PID 24008 | serialization: Arial 19:39:49 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42820/tests/kraken/driver.html?testName=json-parse-financial) 19:39:50 INFO - PID 24008 | RSS: Main: 177377280 19:39:50 INFO - PID 24008 | 19:39:50 INFO - PID 24008 | serialization: Helvetica 19:39:50 INFO - PID 24008 | serialization: Arial 19:39:51 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:39:52 INFO - PID 24008 | RSS: Main: 177192960 19:39:52 INFO - PID 24008 | 19:39:52 INFO - PID 24008 | serialization: Helvetica 19:39:52 INFO - PID 24008 | serialization: Arial 19:39:54 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:55 INFO - PID 24008 | RSS: Main: 174710784 19:39:55 INFO - PID 24008 | 19:39:55 INFO - PID 24008 | serialization: Helvetica 19:39:55 INFO - PID 24008 | serialization: Arial 19:39:57 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:57 INFO - PID 24008 | RSS: Main: 174522368 19:39:57 INFO - PID 24008 | 19:39:58 INFO - PID 24008 | serialization: Helvetica 19:39:58 INFO - PID 24008 | serialization: Arial 19:40:00 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:40:01 INFO - PID 24008 | RSS: Main: 175308800 19:40:01 INFO - PID 24008 | 19:40:01 INFO - PID 24008 | serialization: Helvetica 19:40:01 INFO - PID 24008 | serialization: Arial 19:40:04 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:40:05 INFO - PID 24008 | RSS: Main: 175165440 19:40:05 INFO - PID 24008 | 19:40:05 INFO - PID 24008 | serialization: Helvetica 19:40:05 INFO - PID 24008 | serialization: Arial 19:40:07 INFO - PID 24008 | Cycle 1(1): loaded http://localhost:42820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42820/tests/kraken/driver.html?testName=ai-astar) 19:40:07 INFO - PID 24008 | RSS: Main: 176574464 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | __start_tp_report 19:40:07 INFO - PID 24008 | _x_x_mozilla_page_load 19:40:07 INFO - PID 24008 | _x_x_mozilla_page_load_details 19:40:07 INFO - PID 24008 | |i|pagename|runs| 19:40:07 INFO - PID 24008 | |0;ai-astar;99;106;109;107;111;112;109;101;110;107 19:40:07 INFO - PID 24008 | |1;audio-beat-detection;151;122;148;171;119;143;145;129;187;118 19:40:07 INFO - PID 24008 | |2;audio-dft;163;170;165;163;167;166;168;168;165;163 19:40:07 INFO - PID 24008 | |3;audio-fft;75;74;74;174;76;75;74;75;163;76 19:40:07 INFO - PID 24008 | |4;audio-oscillator;80;83;135;86;80;79;130;79;77;130 19:40:07 INFO - PID 24008 | |5;imaging-gaussian-blur;114;116;115;117;114;114;119;118;118;115 19:40:07 INFO - PID 24008 | |6;imaging-darkroom;151;150;153;151;150;152;156;155;150;156 19:40:07 INFO - PID 24008 | |7;imaging-desaturate;94;101;100;99;95;94;94;93;95;94 19:40:07 INFO - PID 24008 | |8;json-parse-financial;56;54;55;55;54;54;53;54;55;59 19:40:07 INFO - PID 24008 | |9;json-stringify-tinderbox;54;53;64;53;54;53;58;52;54;53 19:40:07 INFO - PID 24008 | |10;stanford-crypto-aes;81;79;79;87;84;79;77;80;80;77 19:40:07 INFO - PID 24008 | |11;stanford-crypto-ccm;137;133;132;130;130;129;132;132;126;164 19:40:07 INFO - PID 24008 | |12;stanford-crypto-pbkdf2;179;178;177;179;173;180;192;175;172;179 19:40:07 INFO - PID 24008 | |13;stanford-crypto-sha256-iterative;68;65;72;65;66;66;66;69;70;66 19:40:07 INFO - PID 24008 | __end_tp_report 19:40:07 INFO - PID 24008 | __start_cc_report 19:40:07 INFO - PID 24008 | _x_x_mozilla_cycle_collect,969 19:40:07 INFO - PID 24008 | __end_cc_report 19:40:07 INFO - PID 24008 | __startTimestamp1502073607321__endTimestamp 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | ------- Summary: start ------- 19:40:07 INFO - PID 24008 | Number of tests: 14 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.50 stddev:4.20 (3.8%) stddev-sans-first:3.28 19:40:07 INFO - PID 24008 | Values: 99.0 106.0 109.0 107.0 111.0 112.0 109.0 101.0 110.0 107.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:146.50 stddev:22.73 (15.5%) stddev-sans-first:23.94 19:40:07 INFO - PID 24008 | Values: 151.0 122.0 148.0 171.0 119.0 143.0 145.0 129.0 187.0 118.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.50 stddev:2.44 (1.5%) stddev-sans-first:2.37 19:40:07 INFO - PID 24008 | Values: 163.0 170.0 165.0 163.0 167.0 166.0 168.0 168.0 165.0 163.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:39.57 (52.8%) stddev-sans-first:41.39 19:40:07 INFO - PID 24008 | Values: 75.0 74.0 74.0 174.0 76.0 75.0 74.0 75.0 163.0 76.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:79.50 stddev:24.84 (31.2%) stddev-sans-first:25.67 19:40:07 INFO - PID 24008 | Values: 80.0 83.0 135.0 86.0 80.0 79.0 130.0 79.0 77.0 130.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.50 stddev:1.89 (1.6%) stddev-sans-first:1.86 19:40:07 INFO - PID 24008 | Values: 114.0 116.0 115.0 117.0 114.0 114.0 119.0 118.0 118.0 115.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.50 stddev:2.46 (1.6%) stddev-sans-first:2.55 19:40:07 INFO - PID 24008 | Values: 151.0 150.0 153.0 151.0 150.0 152.0 156.0 155.0 150.0 156.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:94.00 stddev:2.92 (3.1%) stddev-sans-first:3.02 19:40:07 INFO - PID 24008 | Values: 94.0 101.0 100.0 99.0 95.0 94.0 94.0 93.0 95.0 94.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.72 19:40:07 INFO - PID 24008 | Values: 56.0 54.0 55.0 55.0 54.0 54.0 53.0 54.0 55.0 59.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.00 stddev:3.61 (6.7%) stddev-sans-first:3.82 19:40:07 INFO - PID 24008 | Values: 54.0 53.0 64.0 53.0 54.0 53.0 58.0 52.0 54.0 53.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:3.09 (3.9%) stddev-sans-first:3.27 19:40:07 INFO - PID 24008 | Values: 81.0 79.0 79.0 87.0 84.0 79.0 77.0 80.0 80.0 77.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:132.00 stddev:10.75 (8.1%) stddev-sans-first:11.37 19:40:07 INFO - PID 24008 | Values: 137.0 133.0 132.0 130.0 130.0 129.0 132.0 132.0 126.0 164.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:179.00 stddev:5.50 (3.1%) stddev-sans-first:5.83 19:40:07 INFO - PID 24008 | Values: 179.0 178.0 177.0 179.0 173.0 180.0 192.0 175.0 172.0 179.0 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.36 (3.5%) stddev-sans-first:2.49 19:40:07 INFO - PID 24008 | Values: 68.0 65.0 72.0 65.0 66.0 66.0 66.0 69.0 70.0 66.0 19:40:07 INFO - PID 24008 | -------- Summary: end -------- 19:40:07 INFO - PID 24008 | 19:40:07 INFO - PID 24008 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:40:08 INFO - TEST-INFO | 24008: exit 0 19:40:08 INFO - TEST-OK | kraken | took 62233ms 19:40:08 INFO - SUITE-END | took 1174s 19:40:08 INFO - Completed test suite (00:19:34) 19:40:08 INFO - javascript benchmark 19:40:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8583.553854629898, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.126084696286, 3149.4960806271, 3159.73142282906, 3165.082126183407, 3172.6510083890767, 6183.690815459226, 6218.471429928451, 6246.219222597176, 6282.0, 6307.526935479835, 6260.593061451013, 6260.937390626093, 6270.749170033205, 6276.058591211309, 6318.74725010999, 5782.335031471372, 5802.5938184327115, 5818.650880947157, 5837.445442682938, 5851.122331650244, 5785.27684039495, 5818.8254352369495, 5821.359650438449, 5857.589968702193, 5888.499477544414, 5745.741441635116, 5858.73635686393, 5867.911981320283, 5871.8532036699, 5883.76464941404, 5736.8852622947725, 5817.418258174149, 5820.767169313222, 5880.059190529516, 5892.823215303548, 5538.252335934638, 5681.0910254359105, 5699.2306038684665, 5743.052396354597, 5778.0466223073145, 6231.40801623845, 6242.5942313749465, 6255.249370075575, 6264.686765661699, 6297.370262973712, 6699.665016749143, 6705.966470167667, 6792.558483698594, 6799.252082270947, 6807.591544507296, 6776.593404395752, 6784.59292442455, 6859.108315918898, 6860.828479288008, 6866.279040700754, 6152.0, 6250.093736408241, 6250.9373406521, 6250.937490625081, 6260.655663938436, 6879.208890977501, 6954.478414118961, 6959.37365637085, 6970.442364610819, 6982.546134501241, 6568.6058836469965, 6660.167479065117, 6664.766733164316, 6679.899801502884, 6682.732690692318, 6723.294054124344, 6779.35596118368, 6803.251642319341, 6804.693788779517, 6811.557248778813, 6536.281009088996, 6666.366695163952, 6695.899561506581, 6770.52606317553, 6773.93226067733, 6655.733770649216, 6669.199696036507, 6672.466202703869, 6681.799546013627, 6715.832104197434, 5371.4897084776885, 5383.650062745909, 5418.91871621926, 5437.945620543744, 5450.0, 4670.322803193586, 4678.415198100238, 4692.0381321828945, 4704.835330763407, 4738.810447582058, 5738.311402631711, 5818.912716309259, 5826.475617194473, 5830.067189249699, 5834.124881267844, 6723.327667233335, 6752.459803215731, 6836.965815170893, 6838.350356716104, 6860.862782744317, 5657.405972372924, 5744.626599271034, 5759.020966435716, 5765.654060756368, 5777.711114444261, 5834.095715164156, 5909.320428150818, 5915.438033386821, 5931.110333450017, 5946.791862284799, 6522.152120224436, 6591.176102987127, 6594.472442204612, 6597.043428702811, 6599.274079851117, 6402.295747467868, 6722.058911752456, 6760.96619516919, 6851.520393572402, 6856.5200435969, 6506.121673574007, 6514.120593719977, 6593.835154121185, 6598.571092878948, 6604.867902641824, 6439.839004024937, 6557.540972131905, 6560.015997600398, 6642.667866606747, 6710.362515561014, 6760.357766012221, 6826.795196144124, 6849.965750171217, 6854.554453960476, 6861.691223894837, 6541.215054193527, 6613.768518101843, 6617.1066905969, 6619.735210591522, 6655.367740064686, 6426.710798014007, 6446.161998940108, 6526.216853977363, 6604.0093985902495, 6620.205575330991, 6373.0, 6396.6481843497195, 6443.613383197023, 6537.836554086186, 6542.476601871744, 6379.681015949277, 6587.0, 6596.472282217507, 6601.405873471411, 6629.801105966829, 5972.820815375546, 6361.459275961595, 6365.554411191358, 6368.044793281045, 6390.265119511316], "value": 6144.842757626982, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.2274146414569, 888.6845169964662, 900.693764120199, 915.4873270968257, 1174.765046990601, 32206.35587288256, 33059.17352066196, 45044.54955450445, 46089.53910460894, 46107.538924610744, 45467.54532454674, 46079.0, 46119.30821037679, 46129.308060379124, 46172.0, 7828.882566761503, 8025.678972841109, 8036.27673509384, 8041.396895232851, 8043.11525732169, 7884.32983196429, 7988.4408091433625, 7994.840103197933, 7995.2804247617705, 7999.360051195919, 7977.720779772709, 8022.438429309951, 8060.919390806105, 8061.6372263248295, 8062.798430039237, 7955.244251796128, 7975.521468711867, 8006.439549231556, 8031.196880311952, 8031.2771850533145, 7834.059912810442, 7879.369650427952, 7951.761447156537, 7956.960215198945, 7960.0, 40855.591444085774, 41203.793981030205, 41219.0, 41222.793886030675, 41278.1744365114, 3627.3470775260444, 3663.0, 3666.981665091684, 3670.100825297819, 3673.761205521659, 32787.83606081954, 32835.0, 32846.0, 32912.34175316504, 33017.50473742896, 5123.538881500645, 5141.331626888518, 5219.530242278175, 5221.895562088775, 5223.764930578133, 195480.0, 195586.0, 196907.0, 196926.0, 197179.0, 50534.49465505298, 50743.0, 50765.49234507682, 50806.0, 50826.49173508291, 52213.47786522162, 52279.477205227464, 52577.0, 52975.47024529782, 52983.73508132435, 14439.422423103168, 14674.0, 16185.352585896433, 16544.338226470805, 16704.498865034067, 13618.0, 13675.589732308046, 13682.52111176124, 13685.178889266675, 13687.04190706641, 15234.238288085551, 15253.161076140697, 15335.0, 15426.691466170838, 15501.457448989231, 5914.112883067488, 5994.400559943971, 6105.633661980295, 6154.230721159855, 6177.752889884444, 1000.4097582426404, 1004.5379125602304, 1019.6431249062917, 1023.3706270643501, 1035.6530562261576, 23396.415089622555, 23973.640395394083, 24064.639030414557, 30836.69163308338, 31492.37015259682, 1110.4225802582773, 1117.8155604325195, 1123.662901129658, 1124.9775004500027, 1131.5813149134872, 12697.619071427873, 12820.358982051046, 12879.356032198353, 12933.870661293455, 12988.025898057684, 241315.0, 241964.0, 241987.0, 242088.0, 243103.0, 57267.0, 58259.41740582624, 58259.70870145622, 58260.0, 58617.41382586205, 1458.8176477940258, 1478.859508346684, 1501.9699606008037, 1507.6984603079427, 1526.1682383101236, 23970.64044039306, 28665.28336791597, 29585.0, 29891.850540747157, 30324.0, 56483.15275270792, 56932.715336423054, 57049.42950570607, 57145.0, 57180.42819571918, 211444.0, 213259.0, 213571.0, 213954.0, 213999.0, 38834.417483737205, 40508.0, 41262.58737412708, 41308.0, 41366.86331366959, 48863.755681222785, 50877.49122508727, 51159.48840511547, 51290.74354628203, 51504.22743658773, 36695.449568255965, 36742.8162859184, 37340.6265937348, 37400.25199496049, 37668.24663506769, 35907.82046089753, 36070.8196459016, 36331.45502817513, 36845.63154368422, 36925.26149476942, 39622.40566391449, 39677.404838926865, 39711.20577588374, 39779.60220397759, 39841.80079099586, 35540.822295888356, 35587.28825423529, 35614.0, 35730.821345893106, 35798.8210058948, 25280.36799079964, 25580.616290756025, 25632.359191020372, 25927.351816204748, 26357.0], "value": 18539.627432632242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5848818095061, 587.8354060862958, 593.7684303121786, 597.3936454498681, 604.7973928733874, 22943.54112917743, 23726.932288047035, 23785.881070594645, 23817.0, 23923.5215295694, 21521.031553580087, 21595.892020539875, 23195.76804231957, 24882.751172488268, 27703.445931081365, 6418.614883107005, 6562.606243625374, 6567.211934567858, 6568.310327415625, 6571.67141642916, 6521.217453905538, 6544.901826472606, 6560.179977502812, 6566.901496477557, 6578.0132980052895, 6016.187814645011, 6509.837254068662, 6603.438707709851, 6616.768413105542, 6618.4705223582, 6547.476201903836, 6562.80311590653, 6571.112899758519, 6597.307282735315, 6600.504962127836, 6090.147379366892, 6121.051237058263, 6124.2650881894015, 6125.295591007047, 6133.907991380132, 29425.0, 29868.253293667614, 30538.236544086354, 30592.388152236832, 31442.37115257705, 1884.7738271407381, 1949.9025048747505, 1952.5899561092187, 1953.2675246782458, 1955.0615704461939, 19934.70097948532, 20613.07241174151, 20705.482362940897, 20761.480962975897, 20769.480762980897, 2343.109618345035, 2395.9161429350065, 2420.165043060141, 2443.4135807406096, 2569.1393383216646, 131675.34162329222, 139567.0, 139828.0, 139905.0, 142487.0, 14735.452777458213, 15469.303881325368, 15475.226238688021, 15684.215789210493, 16090.517284481484, 24783.0, 24808.00767969297, 24821.751782482304, 24822.0, 24861.254162375157, 10524.789504209873, 10587.205959553065, 10633.361998280128, 10782.245242833083, 10858.294210876267, 9772.413655180711, 9774.706758797247, 9846.113849753556, 9946.502674866228, 9978.850317245247, 9459.621615135455, 9796.559154838049, 9863.901360986441, 9921.900780992242, 9949.701508954742, 2630.1983141548103, 2632.8157029007784, 2641.656584643984, 2648.165827764248, 2694.191742477249, 979.2606582030521, 991.3011327014437, 998.7702828349375, 1008.7578981044643, 1014.5383850348074, 19674.60650786976, 19926.103325350396, 20027.399178024683, 20223.696644550342, 20440.0, 1061.7239517725448, 1063.2822844580032, 1066.402814423925, 1070.261519551507, 1071.4856868702911, 10898.291611045257, 11275.887241127484, 11336.773264534662, 11366.033887119522, 11410.37242951629, 507626.0, 523222.53554928687, 529694.0, 534767.0, 535194.0, 113983.0, 114571.0, 115050.0, 115268.42365788117, 117579.0, 1062.5112448273726, 1211.4366819429008, 1224.675461002835, 1252.8684488128615, 1265.0322503284995, 20813.0, 21154.471138221666, 21196.470088247916, 21318.573628527654, 21617.567648647255, 56762.432375675715, 56812.43187568071, 57217.42782572287, 58773.412265876796, 62486.6875665637, 71412.64293678498, 71744.0, 72124.63937680278, 72863.0, 73560.63219684082, 14973.925130374279, 15583.298751556435, 15610.843891560939, 15623.609409764847, 15676.68646627084, 24239.878800605886, 24907.252782416555, 25047.248582542554, 25566.0, 26069.0, 19480.8051919479, 19568.315108971117, 19758.703619445434, 19860.80139198647, 19948.10233539465, 17819.910900445415, 17993.936760511675, 18327.816721832613, 18347.26610935601, 18589.44231673052, 19338.129784160028, 20068.39794806158, 20561.0, 20657.17371305131, 20881.477963050438, 14893.702125957638, 15073.095614263179, 15208.46770363032, 15254.313555890234, 15285.694286114438, 18841.528961776065, 19181.136848842114, 19384.70922936185, 19388.321408750628, 19449.805501945364], "value": 12366.769978650429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.7491864005158, 1423.4662001749343, 1436.4613270023744, 1437.6693360527072, 1443.4226309476207, 13747.793783093262, 14335.641608959768, 14416.927915360422, 14455.638609034779, 14459.5662130136, 13767.0, 14870.33083511242, 14885.92557037216, 14928.925355373234, 14955.177465239407, 2648.549746543092, 2685.530032244359, 2696.9460610787773, 2718.877650505722, 2729.140320798942, 2526.9494610107786, 2565.0637517306236, 2679.624852520639, 2720.1295585412677, 2733.4669739400824, 2737.2609395463214, 2764.8755805988676, 2764.8894044238205, 2765.184270640156, 2769.10004248619, 2604.427026054265, 2626.8292560983473, 2666.386731051869, 2670.8531030793297, 2680.3299175206103, 2516.8615726135054, 2549.2734570647276, 2549.821512494126, 2555.782758465533, 2558.616207568861, 13807.585772426843, 14127.929360353235, 14140.434382624786, 14142.50501232452, 14159.71680566383, 7644.770656880302, 7865.252800983897, 7916.485428447132, 7936.603169841543, 7969.282764551218, 4872.853814385574, 4999.700017998932, 5092.26162206478, 5110.821121260738, 5114.846554603368, 1834.9449516514526, 1837.9908100459413, 1854.7866995295578, 1865.5149661088215, 1884.180381534037, 23371.298861034196, 23591.528169436515, 23591.646125308132, 23628.409289767893, 23677.0, 6501.804945851632, 6575.210974682973, 6649.135612370457, 6757.594544327356, 6759.695813688298, 15376.461823836113, 16505.6698866022, 16571.25429355682, 16577.254023568727, 16603.252853621616, 7585.962070189614, 7641.961790191124, 7733.033370828646, 7761.214920568301, 7830.138684744674, 7127.10911136108, 7142.357187853014, 7216.278372162742, 7277.8544429111125, 7339.266073392618, 5093.9745301274, 5221.738913054408, 5238.816641417532, 5254.894902101936, 5276.234945932895, 1559.3684557754127, 1559.555526674915, 1565.4833904811385, 1565.968680626404, 1575.9133247671489, 868.9826203475895, 895.4492986813063, 899.50077706872, 903.4127816919055, 905.0813424374265, 7221.711131554784, 8423.410361274775, 8843.513606751561, 8949.776255593531, 9010.684626038057, 981.2444417798256, 1002.7743757654615, 1005.0753306957616, 1005.6982905128432, 1015.2030655935056, 4935.259711043301, 5034.295198672189, 5332.680039197583, 5340.946590534123, 5410.513053825174, 19249.13378897953, 19280.22879084821, 19697.0, 19725.309614163434, 19958.0, 19135.425937221906, 19697.606047878962, 19707.901460492605, 19737.111829967685, 19765.505862353555, 10410.68767936963, 10764.192685548614, 10899.83650245247, 11144.665660030212, 11175.105991520659, 8063.717769878261, 8325.209105135002, 8447.915520844714, 8698.695545655872, 8841.381103322705, 17101.0, 17205.827941720923, 17748.733768993734, 17822.5544361392, 17984.0, 17659.558511036812, 17794.733079004083, 17937.103144842444, 17969.281228750704, 17980.91009544944, 11527.135464840003, 11730.354830484406, 11734.471948762155, 11795.056395488169, 11876.76246475083, 12717.427715752998, 13172.802407963696, 13176.868231317565, 13177.868221317663, 13185.142965707582, 10784.299020563638, 10865.348079115278, 10933.070688991525, 11007.449627518432, 11176.608818691308, 10211.489425528545, 10352.689419317432, 10807.459627018461, 11106.888931110585, 11225.0, 9387.624495020396, 9495.192908602847, 9507.239420846454, 9510.762230944281, 9529.237660987243, 6749.662516874038, 6935.271796461299, 6948.235694073547, 6953.33943275388, 7014.649267536704, 7145.571265724073, 7201.603911784902, 7217.24218957002, 7299.124105107421, 7396.0754905636795], "value": 6496.924738119647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.9750012499374, 507.3353906382639, 522.5767128625813, 524.824183898394, 534.6658338538414, 6208.348123447029, 6224.502039836813, 6292.307846136921, 6292.685365731712, 6299.968500157504, 6093.9889836354005, 6123.418275263843, 6176.783812566561, 6185.144456663005, 6217.316095229532, 5110.897782044357, 5136.178211486163, 5136.332276804011, 5158.9742051289695, 5173.6119791015635, 4738.265568836836, 4986.476419975905, 5095.751540872491, 5129.281900533928, 5170.53465188133, 4909.779059942293, 4943.332650092228, 4961.18140506816, 4963.627727920402, 4989.65072444929, 4906.484819093979, 4934.25986102084, 4945.975270123627, 4987.675801072936, 4988.42633097193, 4429.614681465358, 4496.5278645742055, 4499.325101234841, 4501.41481607389, 4501.864944051684, 5962.582619216657, 5985.431384018511, 6054.790960790788, 6062.939370606282, 6139.478144357735, 5686.857828554278, 5706.258186435778, 5706.71466426677, 5740.368559458456, 5765.769369225226, 6352.968235158794, 6465.83835404114, 6500.642464664442, 6526.445252153572, 6564.474842012628, 4877.414840176957, 4897.804087836482, 4900.289458028566, 4902.65681402302, 4917.385326834145, 6565.93434065658, 6657.23441804189, 6730.697118629673, 6813.9318606813795, 6997.615131167784, 4792.856214313576, 4971.527704868032, 4983.327250821165, 5001.574866136347, 5020.874478138003, 5029.471905449948, 5037.11850426174, 5048.29323894655, 5060.772265247999, 5084.339035925306, 5663.688497132614, 5691.373948865621, 5727.684977326204, 5733.8566535836935, 5775.971120144372, 6573.506986975996, 6629.900551491732, 6631.801045968628, 6649.534532582769, 6685.966570167216, 1751.1769468349855, 1755.920983555743, 1778.9110544472724, 1780.3323753592404, 1796.9281228750965, 1153.5904753812445, 1210.5581462766027, 1229.5512138069719, 1229.8893099621077, 1250.8498980122445, 5721.39925307845, 5745.482906538348, 5761.452661997104, 5800.0, 5805.477507024304, 6741.797746067527, 6767.221769496571, 6772.288909664513, 6794.655843733904, 6805.183377994672, 5737.282839645044, 5746.88506229873, 5763.625364351304, 5766.625169363978, 5780.88438231233, 3567.8037707925796, 3583.928321433557, 3608.530890984155, 3623.148560088377, 3628.256207477461, 6461.547691661539, 6477.838054048592, 6486.6702326024, 6488.513361497907, 6534.509911756542, 6823.897641535381, 6826.726930922708, 6920.377166055079, 6960.651967401711, 6981.232064472904, 6453.548251622341, 6520.250171230275, 6574.868502630016, 6630.469562434993, 6634.966825165843, 6647.767328143492, 6679.265280819009, 6683.331666833472, 6713.0, 6740.797776066725, 6099.725512351866, 6521.217453905561, 6661.93480021195, 6682.63245521501, 6763.425108865801, 6439.3238709934785, 6440.388163124496, 6455.0, 6547.541672083099, 6584.506162037962, 5039.319691841554, 5052.393712754493, 5070.721110338966, 5090.898182036412, 5097.847064588068, 6539.378759017885, 6688.83277918056, 6699.832504187434, 6832.350926661959, 6841.692123854538, 6415.679216039272, 6529.67351632426, 6570.5400621956005, 6584.901226481511, 6596.60420374779, 6415.582987105823, 6558.311377305505, 6561.934380656132, 6576.243731970884, 6587.538872278895, 6494.447971922439, 6505.381988711065, 6507.642079685663, 6510.18622672166, 6553.0, 6539.673016349258, 6636.601803891782, 6652.368025037614, 6664.366885145903, 6678.966605166943, 6360.650164241011, 6409.230892292955, 6453.225612926479, 6459.580127291711, 6489.156409666713], "value": 5068.220218164092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.3911340288605, 901.5582364641326, 921.9400738951967, 924.1405492891616, 924.5192499900052, 16845.91577042116, 17754.64490710185, 17779.73330400045, 20860.791392086074, 21919.890400547974, 19444.51388715283, 19456.805431945675, 19838.20647174115, 19943.10256038478, 20291.28980485683, 1008.9293749437543, 1043.1081425381303, 1043.2957753516384, 1043.6503771236607, 1045.4302405189153, 1022.4478781458041, 1050.4327663061938, 1052.3790963331633, 1064.0689396777818, 1067.146282973618, 1117.2235296468957, 1117.8211486162215, 1118.6084870295372, 1120.1430905357408, 1120.9495572699248, 1098.5880294889378, 1104.9337039777638, 1107.640016994472, 1108.3294606762872, 1109.7447587054983, 810.6190090657382, 813.0852790610563, 813.4387272781762, 815.6655771133807, 816.5753808019797, 18686.25254989799, 19321.613567728567, 19671.704924426143, 19718.112684929212, 19950.401487955238, 21402.357929262147, 21716.34850954474, 21986.230481933057, 22206.555868882693, 22377.10491580335, 15328.770068448983, 15521.379144834305, 15536.067835929767, 15578.376864925389, 15697.529074127795, 3655.0679576708035, 3707.9073023174365, 3713.6472035156617, 3725.8137093145233, 3735.0475628714776, 127873.0, 128376.58117094108, 129880.0, 131760.0, 131970.0, 15813.762793558106, 16018.199090045451, 16300.0, 16365.83634163667, 16450.67098658044, 30594.38811223763, 31147.84426077855, 31206.687933120833, 31501.212469687984, 31616.0, 8582.227599516074, 8607.913920860712, 8670.0, 8679.696210632725, 8696.434731742416, 4267.5732426757695, 4462.196804575207, 4490.50604433512, 4508.887277818081, 4518.909621807546, 5201.531862132426, 5248.422673505911, 5258.290130832365, 5283.233931079972, 5724.856878577985, 1087.331291255872, 1113.4154568851418, 1129.1249281806665, 1132.6262333429947, 1139.4132022008673, 529.0635575032171, 531.6066111077774, 531.9228711836762, 536.6806749983754, 536.8013834881119, 10622.670357453333, 11033.062189713804, 11210.159238057178, 11631.47658355376, 11801.52793888235, 539.9055165346127, 541.2341536725568, 545.4845171313071, 555.2698201864536, 558.2826068501955, 4910.926336104962, 4936.703797772145, 5199.0, 5237.8428647140645, 5427.29445172133, 99698.0, 103965.48017259865, 104197.47901260445, 106235.0, 108890.0, 84310.15689843145, 87964.0, 90377.54811225901, 91653.0, 95685.52157239169, 78777.60611196907, 79602.20397795948, 79692.60153699195, 82457.0, 85709.0, 10356.326838755456, 10397.688069357931, 10470.214733894836, 10589.258751887293, 10682.0, 37014.814925925195, 37262.813685931396, 37281.25437491289, 38574.42138367983, 38582.0, 44342.77828610966, 47415.0, 47435.0, 48331.758341209475, 49034.0, 14459.927700361432, 14565.344559494637, 14741.705165896836, 14878.479253226518, 14890.181040042902, 15075.09549426994, 15214.391424343345, 15234.466793662168, 15310.0, 15581.844181558039, 14130.434782608581, 14547.490837820626, 14588.562343129723, 14637.634059148606, 16309.26608302653, 16889.155542223085, 16989.745153822456, 17556.561085972953, 17683.0, 17886.5528361792, 15757.0, 15849.68300634004, 15880.761788573413, 15902.840971590598, 16782.412615558398, 11383.772324553296, 11561.653150405502, 11645.126615503701, 11849.407529623657, 12261.816072758736, 12477.688057798629, 12525.812112818132, 12844.165129266568, 12862.0, 12877.420516076987], "value": 8620.70721889484, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 106.0, 109.0, 107.0, 111.0, 112.0, 109.0, 101.0, 110.0, 107.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 148.0, 171.0, 119.0, 143.0, 145.0, 129.0, 187.0, 118.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 170.0, 165.0, 163.0, 167.0, 166.0, 168.0, 168.0, 165.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 174.0, 76.0, 75.0, 74.0, 75.0, 163.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 135.0, 86.0, 80.0, 79.0, 130.0, 79.0, 77.0, 130.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 117.0, 114.0, 114.0, 119.0, 118.0, 118.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 153.0, 151.0, 150.0, 152.0, 156.0, 155.0, 150.0, 156.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 100.0, 99.0, 95.0, 94.0, 94.0, 93.0, 95.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 55.0, 54.0, 54.0, 53.0, 54.0, 55.0, 59.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 64.0, 53.0, 54.0, 53.0, 58.0, 52.0, 54.0, 53.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 87.0, 84.0, 79.0, 77.0, 80.0, 80.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 132.0, 130.0, 130.0, 129.0, 132.0, 132.0, 126.0, 164.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 177.0, 179.0, 173.0, 180.0, 192.0, 175.0, 172.0, 179.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 72.0, 65.0, 66.0, 66.0, 66.0, 69.0, 70.0, 66.0], "value": 67.3, "unit": "score"}]}]} 19:40:08 INFO - Return code: 0 19:40:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:40:08 INFO - # TBPL SUCCESS # 19:40:08 INFO - Running post-action listener: _package_coverage_data 19:40:08 INFO - Running post-action listener: _resource_record_post_action 19:40:08 INFO - [mozharness: 2017-08-07 02:40:08.622110Z] Finished run-tests step (success) 19:40:08 INFO - Running post-run listener: _resource_record_post_run 19:40:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 81920; Write bytes: 442687488; Read time: 200; Write time: 271892 19:40:08 INFO - TinderboxPrint: CPU usage
13.2% 19:40:08 INFO - TinderboxPrint: I/O read bytes / time
81,920 / 200 19:40:08 INFO - TinderboxPrint: I/O write bytes / time
442,687,488 / 271,892 19:40:08 INFO - TinderboxPrint: CPU idle
8,258.6 (86.8%) 19:40:08 INFO - TinderboxPrint: CPU user
1,204.8 (12.7%) 19:40:08 INFO - TinderboxPrint: Swap in / out
0 / 0 19:40:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115257344; Read time: 0; Write time: 93928 19:40:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:40:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 326307840; Read time: 0; Write time: 177920 19:40:09 INFO - Running post-run listener: _upload_blobber_files 19:40:09 INFO - Blob upload gear active. 19:40:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:40:09 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:40:09 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:40:09 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:40:09 INFO - (blobuploader) - INFO - Open directory for files ... 19:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:10 INFO - (blobuploader) - INFO - Done attempting. 19:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:11 INFO - (blobuploader) - INFO - Done attempting. 19:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:40:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:14 INFO - (blobuploader) - INFO - Done attempting. 19:40:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:40:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:40:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:15 INFO - (blobuploader) - INFO - Done attempting. 19:40:15 INFO - (blobuploader) - INFO - Iteration through files over. 19:40:15 INFO - Return code: 0 19:40:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:40:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:40:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14dfa98a3d89774fa620e29d7a12c6eca24d45fb757f4a49720fe1ca5bc2697847785fe382736f8d0df76ad0950a738b9a2aebf7e075e1d4ffcdd47d06e95e39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6aeb26f1001c839e935b0dce3e1745311327ba5721502e84e103f712674c58497b303475fdfc026085fbc4e07e8a010148481e9524c8e21457e86feab45231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b390d12b16282d0202d761037908599da70b7f88e93e3fc4cc3aba8d2f65576b1aaf739b4721e036aac72a2dc2607b208142a62e48707bca7b036b1aae978734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a467fe73c58988205088516c372992e85418a61e05ca1c92b6d2ea775d28685fa29734eb74ec935a206dd7d8e14e40ee1111d10e41f146c6fe1810fc4463c73"} 19:40:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:40:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:40:15 INFO - Contents: 19:40:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14dfa98a3d89774fa620e29d7a12c6eca24d45fb757f4a49720fe1ca5bc2697847785fe382736f8d0df76ad0950a738b9a2aebf7e075e1d4ffcdd47d06e95e39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6aeb26f1001c839e935b0dce3e1745311327ba5721502e84e103f712674c58497b303475fdfc026085fbc4e07e8a010148481e9524c8e21457e86feab45231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b390d12b16282d0202d761037908599da70b7f88e93e3fc4cc3aba8d2f65576b1aaf739b4721e036aac72a2dc2607b208142a62e48707bca7b036b1aae978734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a467fe73c58988205088516c372992e85418a61e05ca1c92b6d2ea775d28685fa29734eb74ec935a206dd7d8e14e40ee1111d10e41f146c6fe1810fc4463c73"} 19:40:15 INFO - Running post-run listener: copy_logs_to_upload_dir 19:40:15 INFO - Copying logs to upload dir... 19:40:15 INFO - mkdir: /builds/slave/test/build/upload/logs 19:40:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.365852 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-06 19:40:15.515318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:40:15.518908) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181 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/14dfa98a3d89774fa620e29d7a12c6eca24d45fb757f4a49720fe1ca5bc2697847785fe382736f8d0df76ad0950a738b9a2aebf7e075e1d4ffcdd47d06e95e39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6aeb26f1001c839e935b0dce3e1745311327ba5721502e84e103f712674c58497b303475fdfc026085fbc4e07e8a010148481e9524c8e21457e86feab45231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b390d12b16282d0202d761037908599da70b7f88e93e3fc4cc3aba8d2f65576b1aaf739b4721e036aac72a2dc2607b208142a62e48707bca7b036b1aae978734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a467fe73c58988205088516c372992e85418a61e05ca1c92b6d2ea775d28685fa29734eb74ec935a206dd7d8e14e40ee1111d10e41f146c6fe1810fc4463c73"} build_url:https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/QgPvyoURQK6UatzOSij_TA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14dfa98a3d89774fa620e29d7a12c6eca24d45fb757f4a49720fe1ca5bc2697847785fe382736f8d0df76ad0950a738b9a2aebf7e075e1d4ffcdd47d06e95e39", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c6aeb26f1001c839e935b0dce3e1745311327ba5721502e84e103f712674c58497b303475fdfc026085fbc4e07e8a010148481e9524c8e21457e86feab45231", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b390d12b16282d0202d761037908599da70b7f88e93e3fc4cc3aba8d2f65576b1aaf739b4721e036aac72a2dc2607b208142a62e48707bca7b036b1aae978734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a467fe73c58988205088516c372992e85418a61e05ca1c92b6d2ea775d28685fa29734eb74ec935a206dd7d8e14e40ee1111d10e41f146c6fe1810fc4463c73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:40:15.544169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:40:15.544518) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1502072363.471690-279722181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:40:15.630438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:40:15.630877) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:40:15.631199) ========= ========= Total master_lag: 0.15 =========