builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1502134998.03 results: success (0) revision: fde1450a4368d04e97174e2eb00fb48901179857 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.027022) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.027500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.027780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.073046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.073430) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 12:43:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-08-07 12:43:18 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.258303 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.382860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.384866) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014749 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.435558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:18.435868) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fde1450a4368d04e97174e2eb00fb48901179857 --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 fde1450a4368d04e97174e2eb00fb48901179857 --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=934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 12:43:18,456 truncating revision to first 12 chars 2017-08-07 12:43:18,456 Setting DEBUG logging. 2017-08-07 12:43:18,456 attempt 1/10 2017-08-07 12:43:18,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fde1450a4368?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-07 12:43:18,766 unpacking tar archive at: mozilla-central-fde1450a4368/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:19.096755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:19.097054) ========= script_repo_revision: fde1450a4368d04e97174e2eb00fb48901179857 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:19.097434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:19.097705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 12:43:19.108811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-07 12:43:19.109103) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:43:19 INFO - MultiFileLogger online at 20170807 12:43:19 in /builds/slave/test 12:43:19 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 12:43:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:43:19 INFO - {'append_to_log': False, 12:43:19 INFO - 'base_work_dir': '/builds/slave/test', 12:43:19 INFO - 'blob_upload_branch': 'Firefox', 12:43:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:43:19 INFO - 'branch': 'Firefox', 12:43:19 INFO - 'buildbot_json_path': 'buildprops.json', 12:43:19 INFO - 'code_coverage': False, 12:43:19 INFO - 'config_files': ('talos/linux_config.py',), 12:43:19 INFO - 'default_actions': ('clobber', 12:43:19 INFO - 'read-buildbot-config', 12:43:19 INFO - 'download-and-extract', 12:43:19 INFO - 'populate-webroot', 12:43:19 INFO - 'create-virtualenv', 12:43:19 INFO - 'install', 12:43:19 INFO - 'setup-mitmproxy', 12:43:19 INFO - 'run-tests'), 12:43:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:43:19 INFO - 'disable_ccov_upload': False, 12:43:19 INFO - 'download_minidump_stackwalk': True, 12:43:19 INFO - 'download_symbols': 'ondemand', 12:43:19 INFO - 'enable_stylo': False, 12:43:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:43:19 INFO - 'tooltool.py': '/tools/tooltool.py', 12:43:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:43:19 INFO - '/tools/misc-python/virtualenv.py')}, 12:43:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:43:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:43:19 INFO - 'gecko_profile': False, 12:43:19 INFO - 'gecko_profile_interval': 0, 12:43:19 INFO - 'installer_path': 'installer.exe', 12:43:19 INFO - 'log_level': 'info', 12:43:19 INFO - 'log_name': 'talos', 12:43:19 INFO - 'log_to_console': True, 12:43:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:43:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:43:19 INFO - 'opt_config_files': (), 12:43:19 INFO - 'pip_index': False, 12:43:19 INFO - 'suite': 'dromaeojs-e10s', 12:43:19 INFO - 'system_bits': '32', 12:43:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:43:19 INFO - 'title': 'talos-linux64-ix-057', 12:43:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:43:19 INFO - 'use_talos_json': True, 12:43:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:43:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:43:19 INFO - 'work_dir': 'build'} 12:43:19 INFO - [mozharness: 2017-08-07 19:43:19.347827Z] Running clobber step. 12:43:19 INFO - Running pre-action listener: _resource_record_pre_action 12:43:19 INFO - Running main action method: clobber 12:43:19 INFO - rmtree: /builds/slave/test/build 12:43:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:43:20 INFO - Running post-action listener: _resource_record_post_action 12:43:20 INFO - [mozharness: 2017-08-07 19:43:20.347067Z] Finished clobber step (success) 12:43:20 INFO - [mozharness: 2017-08-07 19:43:20.347169Z] Running read-buildbot-config step. 12:43:20 INFO - Running pre-action listener: _resource_record_pre_action 12:43:20 INFO - Running main action method: read_buildbot_config 12:43:20 INFO - Using buildbot properties: 12:43:20 INFO - { 12:43:20 INFO - "project": "", 12:43:20 INFO - "product": "firefox", 12:43:20 INFO - "who": "kwierso@gmail.com", 12:43:20 INFO - "installer_path": "public/build/target.tar.bz2", 12:43:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 12:43:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:43:20 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 12:43:20 INFO - "stage_platform": "linux64-stylosequential", 12:43:20 INFO - "basedir": "/builds/slave/test", 12:43:20 INFO - "buildnumber": 172, 12:43:20 INFO - "platform": "ubuntu64_hw_styloseq", 12:43:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:43:20 INFO - "slavebuilddir": "test", 12:43:20 INFO - "taskId": "YHtwOsiSQ2uXEtUXlXDc3A", 12:43:20 INFO - "branch": "mozilla-central", 12:43:20 INFO - "script_repo_revision": "production", 12:43:20 INFO - "revision": "fde1450a4368d04e97174e2eb00fb48901179857", 12:43:20 INFO - "slavename": "talos-linux64-ix-057", 12:43:20 INFO - "repo_path": "mozilla-central" 12:43:20 INFO - } 12:43:20 INFO - Finding installer, test and symbols from parent task. 12:43:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YHtwOsiSQ2uXEtUXlXDc3A'}, attempt #1 12:43:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YHtwOsiSQ2uXEtUXlXDc3A'}, attempt #1 12:43:21 INFO - Task dependencies: eQ_3dHouQGmbtpzvbd4Udw 12:43:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw'}, attempt #1 12:43:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2 12:43:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.test_packages.json 12:43:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.crashreporter-symbols.zip 12:43:21 INFO - Running post-action listener: _resource_record_post_action 12:43:21 INFO - [mozharness: 2017-08-07 19:43:21.755942Z] Finished read-buildbot-config step (success) 12:43:21 INFO - [mozharness: 2017-08-07 19:43:21.756164Z] Running download-and-extract step. 12:43:21 INFO - Running pre-action listener: _resource_record_pre_action 12:43:21 INFO - Running main action method: download_and_extract 12:43:21 INFO - mkdir: /builds/slave/test/build/tests 12:43:21 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')]} 12:43:21 INFO - trying https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.test_packages.json 12:43:21 INFO - Downloading https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:43:22 INFO - Downloaded 989 bytes. 12:43:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:43:22 INFO - Using the following test package requirements: 12:43:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:43:22 INFO - u'common': [u'target.common.tests.zip'], 12:43:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:43:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:43:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:43:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:43:22 INFO - u'mozbase': [u'target.common.tests.zip'], 12:43:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:43:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:43:22 INFO - u'web-platform': [u'target.common.tests.zip', 12:43:22 INFO - u'target.web-platform.tests.tar.gz'], 12:43:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:43:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:43:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.common.tests.zip 12:43:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:43:22 INFO - Fetch https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.common.tests.zip into memory 12:43:23 INFO - Content-Length response header: 54284421 12:43:23 INFO - Bytes received: 54284421 12:43:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:43:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.common.tests.zip 12:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:43:35 INFO - Fetch https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.common.tests.zip into memory 12:43:36 INFO - Content-Length response header: 54284421 12:43:36 INFO - Bytes received: 54284421 12:43:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.talos.tests.zip 12:43:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:43:49 INFO - Fetch https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.talos.tests.zip into memory 12:43:50 INFO - Content-Length response header: 14496008 12:43:50 INFO - Bytes received: 14496008 12:43:50 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')]} 12:43:50 INFO - trying https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2 12:43:50 INFO - Downloading https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:43:51 INFO - Downloaded 61763660 bytes. 12:43:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2 12:43:51 INFO - mkdir: /builds/slave/test/properties 12:43:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:43:51 INFO - Writing to file /builds/slave/test/properties/build_url 12:43:51 INFO - Contents: 12:43:51 INFO - build_url:https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2 12:43:51 INFO - Running post-action listener: _resource_record_post_action 12:43:51 INFO - Running post-action listener: set_extra_try_arguments 12:43:51 INFO - [mozharness: 2017-08-07 19:43:51.424600Z] Finished download-and-extract step (success) 12:43:51 INFO - [mozharness: 2017-08-07 19:43:51.424698Z] Running populate-webroot step. 12:43:51 INFO - Running pre-action listener: _resource_record_pre_action 12:43:51 INFO - Running main action method: populate_webroot 12:43:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:43:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:43:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:43:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:43:51 INFO - 'tests': ['damp', 'tps']}, 12:43:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:43:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:43:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:43:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:43:51 INFO - 'other-e10s': {'tests': ['a11yr', 12:43:51 INFO - 'ts_paint', 12:43:51 INFO - 'tpaint', 12:43:51 INFO - 'sessionrestore', 12:43:51 INFO - 'sessionrestore_many_windows', 12:43:51 INFO - 'sessionrestore_no_auto_restore', 12:43:51 INFO - 'tabpaint']}, 12:43:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:43:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 12:43:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:43:51 INFO - 'tsvgr_opacity', 12:43:51 INFO - 'tart', 12:43:51 INFO - 'tscrollx', 12:43:51 INFO - 'tsvg_static']}, 12:43:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:43:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:43:51 INFO - 'talos_options': ['--mitmproxy', 12:43:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:43:51 INFO - '--firstNonBlankPaint'], 12:43:51 INFO - 'tests': ['tp6_google', 12:43:51 INFO - 'tp6_youtube', 12:43:51 INFO - 'tp6_amazon', 12:43:51 INFO - 'tp6_facebook']}, 12:43:51 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:43:51 INFO - 'talos_options': ['--stylo', 12:43:51 INFO - '--mitmproxy', 12:43:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:43:51 INFO - '--firstNonBlankPaint'], 12:43:51 INFO - 'tests': ['tp6_google', 12:43:51 INFO - 'tp6_youtube', 12:43:51 INFO - 'tp6_amazon', 12:43:51 INFO - 'tp6_facebook']}, 12:43:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:43:51 INFO - 'talos_options': ['--stylo', 12:43:51 INFO - '--stylo-threads=1', 12:43:51 INFO - '--mitmproxy', 12:43:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:43:51 INFO - '--firstNonBlankPaint'], 12:43:51 INFO - 'tests': ['tp6_google', 12:43:51 INFO - 'tp6_youtube', 12:43:51 INFO - 'tp6_amazon', 12:43:51 INFO - 'tp6_facebook']}, 12:43:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:43:51 INFO - 'talos_options': ['--xperf_path', 12:43:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:51 INFO - 'tests': ['tp5n']}}} 12:43:51 INFO - Running post-action listener: _resource_record_post_action 12:43:51 INFO - [mozharness: 2017-08-07 19:43:51.433108Z] Finished populate-webroot step (success) 12:43:51 INFO - [mozharness: 2017-08-07 19:43:51.433198Z] Running create-virtualenv step. 12:43:51 INFO - Running pre-action listener: _resource_record_pre_action 12:43:51 INFO - Running main action method: create_virtualenv 12:43:51 INFO - Creating virtualenv /builds/slave/test/build/venv 12:43:51 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 12:43:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:43:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:43:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:43:51 INFO - Using real prefix '/usr' 12:43:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:43:52 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:54 INFO - Installing pip.................done. 12:43:54 INFO - Return code: 0 12:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:43:54 INFO - Reading from file tmpfile_stdout 12:43:54 INFO - Output received: 12:43:54 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) 12:43:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43: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')]} 12:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:54 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:43:54 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 12:43:54 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 12:43:54 INFO - Using env: {'DISPLAY': ':0', 12:43:54 INFO - 'HOME': '/home/cltbld', 12:43:54 INFO - 'LANG': 'en_US.UTF-8', 12:43:54 INFO - 'LANGUAGE': 'en_US:en', 12:43:54 INFO - 'LOGNAME': 'cltbld', 12:43:54 INFO - 'MAIL': '/var/mail/cltbld', 12:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:54 INFO - 'MOZ_NO_REMOTE': '1', 12:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:54 INFO - 'NO_EM_RESTART': '1', 12:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:54 INFO - 'PWD': '/builds/slave/test', 12:43:54 INFO - 'SHELL': '/bin/bash', 12:43:54 INFO - 'SHLVL': '1', 12:43:54 INFO - 'TERM': 'linux', 12:43:54 INFO - 'TMOUT': '86400', 12:43:54 INFO - 'USER': 'cltbld', 12:43:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:54 INFO - '_': '/tools/buildbot/bin/python'} 12:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:54 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 12:43:54 INFO - Cleaning up... 12:43:54 INFO - Return code: 0 12:43:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43: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')]} 12:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:54 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:43:54 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 12:43:54 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 12:43:54 INFO - Using env: {'DISPLAY': ':0', 12:43:54 INFO - 'HOME': '/home/cltbld', 12:43:54 INFO - 'LANG': 'en_US.UTF-8', 12:43:54 INFO - 'LANGUAGE': 'en_US:en', 12:43:54 INFO - 'LOGNAME': 'cltbld', 12:43:54 INFO - 'MAIL': '/var/mail/cltbld', 12:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:54 INFO - 'MOZ_NO_REMOTE': '1', 12:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:54 INFO - 'NO_EM_RESTART': '1', 12:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:54 INFO - 'PWD': '/builds/slave/test', 12:43:54 INFO - 'SHELL': '/bin/bash', 12:43:54 INFO - 'SHLVL': '1', 12:43:54 INFO - 'TERM': 'linux', 12:43:54 INFO - 'TMOUT': '86400', 12:43:54 INFO - 'USER': 'cltbld', 12:43:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:54 INFO - '_': '/tools/buildbot/bin/python'} 12:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:54 INFO - Downloading/unpacking psutil>=3.1.1 12:43:54 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 12:43:54 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 12:43:54 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 12:43:54 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 12:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:56 INFO - Installing collected packages: psutil 12:43:56 INFO - Running setup.py install for psutil 12:43:56 INFO - building 'psutil._psutil_linux' extension 12:43:56 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 12:43:57 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 12:43:57 INFO - building 'psutil._psutil_posix' extension 12:43:57 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 12:43:57 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 12:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:57 INFO - Successfully installed psutil 12:43:57 INFO - Cleaning up... 12:43:57 INFO - Return code: 0 12:43:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:43:57 INFO - Using env: {'DISPLAY': ':0', 12:43:57 INFO - 'HOME': '/home/cltbld', 12:43:57 INFO - 'LANG': 'en_US.UTF-8', 12:43:57 INFO - 'LANGUAGE': 'en_US:en', 12:43:57 INFO - 'LOGNAME': 'cltbld', 12:43:57 INFO - 'MAIL': '/var/mail/cltbld', 12:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:57 INFO - 'MOZ_NO_REMOTE': '1', 12:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:57 INFO - 'NO_EM_RESTART': '1', 12:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:57 INFO - 'PWD': '/builds/slave/test', 12:43:57 INFO - 'SHELL': '/bin/bash', 12:43:57 INFO - 'SHLVL': '1', 12:43:57 INFO - 'TERM': 'linux', 12:43:57 INFO - 'TMOUT': '86400', 12:43:57 INFO - 'USER': 'cltbld', 12:43:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:57 INFO - '_': '/tools/buildbot/bin/python'} 12:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:43:58 INFO - Installing collected packages: mozsystemmonitor 12:43:58 INFO - Running setup.py install for mozsystemmonitor 12:43:59 INFO - Successfully installed mozsystemmonitor 12:43:59 INFO - Cleaning up... 12:43:59 INFO - Return code: 0 12:43:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:59 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:43:59 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 12:43:59 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 12:43:59 INFO - Using env: {'DISPLAY': ':0', 12:43:59 INFO - 'HOME': '/home/cltbld', 12:43:59 INFO - 'LANG': 'en_US.UTF-8', 12:43:59 INFO - 'LANGUAGE': 'en_US:en', 12:43:59 INFO - 'LOGNAME': 'cltbld', 12:43:59 INFO - 'MAIL': '/var/mail/cltbld', 12:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:59 INFO - 'MOZ_NO_REMOTE': '1', 12:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:59 INFO - 'NO_EM_RESTART': '1', 12:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:59 INFO - 'PWD': '/builds/slave/test', 12:43:59 INFO - 'SHELL': '/bin/bash', 12:43:59 INFO - 'SHLVL': '1', 12:43:59 INFO - 'TERM': 'linux', 12:43:59 INFO - 'TMOUT': '86400', 12:43:59 INFO - 'USER': 'cltbld', 12:43:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:59 INFO - '_': '/tools/buildbot/bin/python'} 12:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:59 INFO - Downloading/unpacking jsonschema==2.5.1 12:43:59 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 12:43:59 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 12:43:59 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 12:43:59 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 12:44:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:44:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:44:01 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 12:44:01 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 12:44:01 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 12:44:01 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 12:44:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:44:01 INFO - warning: no files found matching '*.txt' 12:44:01 INFO - no previously-included directories found matching 'build' 12:44:01 INFO - no previously-included directories found matching 'dist' 12:44:01 INFO - no previously-included directories found matching '.git*' 12:44:01 INFO - Installing collected packages: jsonschema, functools32 12:44:01 INFO - Running setup.py install for functools32 12:44:01 INFO - warning: no files found matching '*.txt' 12:44:01 INFO - no previously-included directories found matching 'build' 12:44:01 INFO - no previously-included directories found matching 'dist' 12:44:01 INFO - no previously-included directories found matching '.git*' 12:44:01 INFO - Successfully installed jsonschema functools32 12:44:01 INFO - Cleaning up... 12:44:01 INFO - Return code: 0 12:44:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44: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')]} 12:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44: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', '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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:44: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:44: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 functools32==3.2.3-2 12:44:01 INFO - Using env: {'DISPLAY': ':0', 12:44:01 INFO - 'HOME': '/home/cltbld', 12:44:01 INFO - 'LANG': 'en_US.UTF-8', 12:44:01 INFO - 'LANGUAGE': 'en_US:en', 12:44:01 INFO - 'LOGNAME': 'cltbld', 12:44:01 INFO - 'MAIL': '/var/mail/cltbld', 12:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:01 INFO - 'MOZ_NO_REMOTE': '1', 12:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:01 INFO - 'NO_EM_RESTART': '1', 12:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:01 INFO - 'PWD': '/builds/slave/test', 12:44:01 INFO - 'SHELL': '/bin/bash', 12:44:01 INFO - 'SHLVL': '1', 12:44:01 INFO - 'TERM': 'linux', 12:44:01 INFO - 'TMOUT': '86400', 12:44:01 INFO - 'USER': 'cltbld', 12:44:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:01 INFO - '_': '/tools/buildbot/bin/python'} 12:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:44:01 INFO - Cleaning up... 12:44:01 INFO - Return code: 0 12:44:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:44:02 INFO - Using env: {'DISPLAY': ':0', 12:44:02 INFO - 'HOME': '/home/cltbld', 12:44:02 INFO - 'LANG': 'en_US.UTF-8', 12:44:02 INFO - 'LANGUAGE': 'en_US:en', 12:44:02 INFO - 'LOGNAME': 'cltbld', 12:44:02 INFO - 'MAIL': '/var/mail/cltbld', 12:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:02 INFO - 'MOZ_NO_REMOTE': '1', 12:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:02 INFO - 'NO_EM_RESTART': '1', 12:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:02 INFO - 'PWD': '/builds/slave/test', 12:44:02 INFO - 'SHELL': '/bin/bash', 12:44:02 INFO - 'SHLVL': '1', 12:44:02 INFO - 'TERM': 'linux', 12:44:02 INFO - 'TMOUT': '86400', 12:44:02 INFO - 'USER': 'cltbld', 12:44:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:02 INFO - '_': '/tools/buildbot/bin/python'} 12:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:02 INFO - Downloading/unpacking blobuploader==1.2.4 12:44: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 12:44: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 12:44: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 12:44: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 12:44:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:44:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:44: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 12:44: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 12:44: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 12:44: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 12:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:44:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:44: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 12:44: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 12:44: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 12:44: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 12:44:03 INFO - Downloading docopt-0.6.1.tar.gz 12:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:44:03 INFO - Installing collected packages: blobuploader, requests, docopt 12:44:03 INFO - Running setup.py install for blobuploader 12:44:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:44:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:44:04 INFO - Running setup.py install for requests 12:44:04 INFO - Running setup.py install for docopt 12:44:04 INFO - Successfully installed blobuploader requests docopt 12:44:04 INFO - Cleaning up... 12:44:04 INFO - Return code: 0 12:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:04 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:44:04 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 12:44:04 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 12:44:04 INFO - Using env: {'DISPLAY': ':0', 12:44:04 INFO - 'HOME': '/home/cltbld', 12:44:04 INFO - 'LANG': 'en_US.UTF-8', 12:44:04 INFO - 'LANGUAGE': 'en_US:en', 12:44:04 INFO - 'LOGNAME': 'cltbld', 12:44:04 INFO - 'MAIL': '/var/mail/cltbld', 12:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:04 INFO - 'MOZ_NO_REMOTE': '1', 12:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:04 INFO - 'NO_EM_RESTART': '1', 12:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:04 INFO - 'PWD': '/builds/slave/test', 12:44:04 INFO - 'SHELL': '/bin/bash', 12:44:04 INFO - 'SHLVL': '1', 12:44:04 INFO - 'TERM': 'linux', 12:44:04 INFO - 'TMOUT': '86400', 12:44:04 INFO - 'USER': 'cltbld', 12:44:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:04 INFO - '_': '/tools/buildbot/bin/python'} 12:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:44:04 INFO - Running setup.py (path:/tmp/pip-wCMIBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:44:04 INFO - Running setup.py (path:/tmp/pip-K0TAEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:44:04 INFO - Running setup.py (path:/tmp/pip-9cansj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:44:04 INFO - Running setup.py (path:/tmp/pip-JikWKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:44:05 INFO - Running setup.py (path:/tmp/pip-ti57AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:44:05 INFO - Running setup.py (path:/tmp/pip-DvistG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:44:05 INFO - Running setup.py (path:/tmp/pip-5iaIOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:44:05 INFO - Running setup.py (path:/tmp/pip-oNQJX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:44:05 INFO - Running setup.py (path:/tmp/pip-XBQQYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:44:05 INFO - Running setup.py (path:/tmp/pip-B67TeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:44:05 INFO - Running setup.py (path:/tmp/pip-k5be8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:44:05 INFO - Running setup.py (path:/tmp/pip-hv4CMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:44:05 INFO - Running setup.py (path:/tmp/pip-j3PUmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:44:05 INFO - Running setup.py (path:/tmp/pip-tMEMcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:05 INFO - Running setup.py (path:/tmp/pip-mZSN3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:44:05 INFO - Running setup.py (path:/tmp/pip-Gsyj7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:44:05 INFO - Running setup.py (path:/tmp/pip-pfJiBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:44:05 INFO - Running setup.py install for manifestparser 12:44:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Running setup.py install for mozcrash 12:44:06 INFO - Running setup.py install for mozdebug 12:44:06 INFO - Running setup.py install for mozdevice 12:44:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Running setup.py install for mozfile 12:44:06 INFO - Running setup.py install for mozhttpd 12:44:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Running setup.py install for mozinfo 12:44:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Running setup.py install for mozInstall 12:44:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Running setup.py install for mozleak 12:44:06 INFO - Running setup.py install for mozlog 12:44:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:44:06 INFO - Running setup.py install for moznetwork 12:44:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:44:07 INFO - Running setup.py install for mozprocess 12:44:07 INFO - Running setup.py install for mozprofile 12:44:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:44:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:44:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:44:07 INFO - Running setup.py install for mozrunner 12:44:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:44:07 INFO - Running setup.py install for mozscreenshot 12:44:07 INFO - Running setup.py install for moztest 12:44:07 INFO - Running setup.py install for mozversion 12:44:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:44:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:44:07 INFO - Cleaning up... 12:44:07 INFO - Return code: 0 12:44:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44:07 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')]} 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:07 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')]} 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:07 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:44:07 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 12:44:07 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 12:44:07 INFO - Using env: {'DISPLAY': ':0', 12:44:07 INFO - 'HOME': '/home/cltbld', 12:44:07 INFO - 'LANG': 'en_US.UTF-8', 12:44:07 INFO - 'LANGUAGE': 'en_US:en', 12:44:07 INFO - 'LOGNAME': 'cltbld', 12:44:07 INFO - 'MAIL': '/var/mail/cltbld', 12:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:07 INFO - 'MOZ_NO_REMOTE': '1', 12:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:07 INFO - 'NO_EM_RESTART': '1', 12:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:07 INFO - 'PWD': '/builds/slave/test', 12:44:07 INFO - 'SHELL': '/bin/bash', 12:44:07 INFO - 'SHLVL': '1', 12:44:07 INFO - 'TERM': 'linux', 12:44:07 INFO - 'TMOUT': '86400', 12:44:07 INFO - 'USER': 'cltbld', 12:44:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:07 INFO - '_': '/tools/buildbot/bin/python'} 12:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:44:07 INFO - Running setup.py (path:/tmp/pip-zRlZBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:44:08 INFO - Running setup.py (path:/tmp/pip-T5zruk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:44:08 INFO - Running setup.py (path:/tmp/pip-r3nEhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:44:08 INFO - Running setup.py (path:/tmp/pip-c4nLgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:44:08 INFO - Running setup.py (path:/tmp/pip-ZQvaUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:44:08 INFO - Running setup.py (path:/tmp/pip-JlS9FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:44:08 INFO - Running setup.py (path:/tmp/pip-YuwJDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:44:08 INFO - Running setup.py (path:/tmp/pip-GJYyoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:44:08 INFO - Running setup.py (path:/tmp/pip-RLIyM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:44:08 INFO - Running setup.py (path:/tmp/pip-s0EHm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:44:08 INFO - Running setup.py (path:/tmp/pip-3MKKdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:44:08 INFO - Running setup.py (path:/tmp/pip-cZCY7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:44:08 INFO - Running setup.py (path:/tmp/pip-Hg6CAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:44:08 INFO - Running setup.py (path:/tmp/pip-3I3QNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:44:08 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)) 12:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:08 INFO - Running setup.py (path:/tmp/pip-t4fhJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:09 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)) 12:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:44:09 INFO - Running setup.py (path:/tmp/pip-shU88y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:44:09 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)) 12:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:44:09 INFO - Running setup.py (path:/tmp/pip-ds6k2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:44:09 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)) 12:44:09 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)) 12:44:09 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)) 12:44:09 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)) 12:44:09 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)) 12:44:09 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)) 12:44:09 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)) 12:44:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:44:09 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 12:44:09 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 12:44:09 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 12:44:09 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 12:44:10 INFO - Downloading blessings-1.6.tar.gz 12:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:44:10 INFO - Installing collected packages: blessings 12:44:10 INFO - Running setup.py install for blessings 12:44:10 INFO - Successfully installed blessings 12:44:10 INFO - Cleaning up... 12:44:10 INFO - Return code: 0 12:44:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:44:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:44:10 INFO - Reading from file tmpfile_stdout 12:44:10 INFO - Current package versions: 12:44:10 INFO - argparse == 1.2.1 12:44:10 INFO - blessings == 1.6 12:44:10 INFO - blobuploader == 1.2.4 12:44:10 INFO - docopt == 0.6.1 12:44:10 INFO - functools32 == 3.2.3-2 12:44:10 INFO - jsonschema == 2.5.1 12:44:10 INFO - manifestparser == 1.1 12:44:10 INFO - mozInstall == 1.13 12:44:10 INFO - mozcrash == 1.0 12:44:10 INFO - mozdebug == 0.1 12:44:10 INFO - mozdevice == 0.51 12:44:10 INFO - mozfile == 1.2 12:44:10 INFO - mozhttpd == 0.7 12:44:10 INFO - mozinfo == 0.10 12:44:10 INFO - mozleak == 0.1 12:44:10 INFO - mozlog == 3.5 12:44:10 INFO - moznetwork == 0.27 12:44:10 INFO - mozprocess == 0.25 12:44:10 INFO - mozprofile == 0.28 12:44:10 INFO - mozrunner == 6.13 12:44:10 INFO - mozscreenshot == 0.1 12:44:10 INFO - mozsystemmonitor == 0.3 12:44:10 INFO - moztest == 0.8 12:44:10 INFO - mozversion == 1.4 12:44:10 INFO - psutil == 3.1.1 12:44:10 INFO - requests == 1.2.3 12:44:10 INFO - wsgiref == 0.1.2 12:44:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44:10 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')]} 12:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:10 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')]} 12:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:10 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:44:10 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 12:44:10 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 12:44:10 INFO - Using env: {'DISPLAY': ':0', 12:44:10 INFO - 'HOME': '/home/cltbld', 12:44:10 INFO - 'LANG': 'en_US.UTF-8', 12:44:10 INFO - 'LANGUAGE': 'en_US:en', 12:44:10 INFO - 'LOGNAME': 'cltbld', 12:44:10 INFO - 'MAIL': '/var/mail/cltbld', 12:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:10 INFO - 'MOZ_NO_REMOTE': '1', 12:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:10 INFO - 'NO_EM_RESTART': '1', 12:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:10 INFO - 'PWD': '/builds/slave/test', 12:44:10 INFO - 'SHELL': '/bin/bash', 12:44:10 INFO - 'SHLVL': '1', 12:44:10 INFO - 'TERM': 'linux', 12:44:10 INFO - 'TMOUT': '86400', 12:44:10 INFO - 'USER': 'cltbld', 12:44:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:10 INFO - '_': '/tools/buildbot/bin/python'} 12:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 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)) 12:44:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:44: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 12:44: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 12:44: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 12:44: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 12:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:44:12 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)) 12:44:12 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)) 12:44:12 INFO - Installing collected packages: simplejson 12:44:12 INFO - Running setup.py install for simplejson 12:44:12 INFO - building 'simplejson._speedups' extension 12:44:12 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 12:44:13 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 12:44:13 INFO - Successfully installed simplejson 12:44:13 INFO - Cleaning up... 12:44:13 INFO - Return code: 0 12:44:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:44:13 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')]} 12:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:13 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')]} 12:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:13 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 0x11311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14a0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', '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 12:44:13 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 12:44:13 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 12:44:13 INFO - Using env: {'DISPLAY': ':0', 12:44:13 INFO - 'HOME': '/home/cltbld', 12:44:13 INFO - 'LANG': 'en_US.UTF-8', 12:44:13 INFO - 'LANGUAGE': 'en_US:en', 12:44:13 INFO - 'LOGNAME': 'cltbld', 12:44:13 INFO - 'MAIL': '/var/mail/cltbld', 12:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:13 INFO - 'MOZ_NO_REMOTE': '1', 12:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:13 INFO - 'NO_EM_RESTART': '1', 12:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:13 INFO - 'PWD': '/builds/slave/test', 12:44:13 INFO - 'SHELL': '/bin/bash', 12:44:13 INFO - 'SHLVL': '1', 12:44:13 INFO - 'TERM': 'linux', 12:44:13 INFO - 'TMOUT': '86400', 12:44:13 INFO - 'USER': 'cltbld', 12:44:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:13 INFO - '_': '/tools/buildbot/bin/python'} 12:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:44:13 INFO - Cleaning up... 12:44:13 INFO - Return code: 0 12:44:13 INFO - Running post-action listener: _resource_record_post_action 12:44:13 INFO - Running post-action listener: _start_resource_monitoring 12:44:13 INFO - Starting resource monitoring. 12:44:13 INFO - [mozharness: 2017-08-07 19:44:13.461615Z] Finished create-virtualenv step (success) 12:44:13 INFO - [mozharness: 2017-08-07 19:44:13.462627Z] Running install step. 12:44:13 INFO - Running pre-action listener: _resource_record_pre_action 12:44:13 INFO - Running main action method: install 12:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:44:13 INFO - Reading from file tmpfile_stdout 12:44:13 INFO - Detecting whether we're running mozinstall >=1.0... 12:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:44:13 INFO - Reading from file tmpfile_stdout 12:44:13 INFO - Output received: 12:44:13 INFO - Usage: mozinstall [options] installer 12:44:13 INFO - Options: 12:44:13 INFO - -h, --help show this help message and exit 12:44:13 INFO - -d DEST, --destination=DEST 12:44:13 INFO - Directory to install application into. [default: 12:44:13 INFO - "/builds/slave/test"] 12:44:13 INFO - --app=APP Application being installed. [default: firefox] 12:44:13 INFO - mkdir: /builds/slave/test/build/application 12:44:13 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'] 12:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:44:31 INFO - Reading from file tmpfile_stdout 12:44:31 INFO - Output received: 12:44:31 INFO - /builds/slave/test/build/application/firefox/firefox 12:44:31 INFO - Running post-action listener: _resource_record_post_action 12:44:31 INFO - [mozharness: 2017-08-07 19:44:31.769954Z] Finished install step (success) 12:44:31 INFO - [mozharness: 2017-08-07 19:44:31.770208Z] Running setup-mitmproxy step. 12:44:31 INFO - Running pre-action listener: _resource_record_pre_action 12:44:31 INFO - Running main action method: setup_mitmproxy 12:44:31 INFO - Skipping: mitmproxy is not required 12:44:31 INFO - Running post-action listener: _resource_record_post_action 12:44:31 INFO - [mozharness: 2017-08-07 19:44:31.771438Z] Finished setup-mitmproxy step (success) 12:44:31 INFO - [mozharness: 2017-08-07 19:44:31.771661Z] Running run-tests step. 12:44:31 INFO - Running pre-action listener: _resource_record_pre_action 12:44:31 INFO - Running pre-action listener: _set_gcov_prefix 12:44:31 INFO - Running main action method: run_tests 12:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:44:31 INFO - Python 2.7.3 12:44:31 INFO - Return code: 0 12:44:31 INFO - grabbing minidump binary from tooltool 12:44:31 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')]} 12:44:31 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 0x149deb0>, '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 0x149edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149f240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:44:31 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 12:44:31 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 12:44:31 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 12:44:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:32 INFO - Return code: 0 12:44:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:44:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:44:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:44:32 INFO - ENV: RUST_BACKTRACE is now 1 12:44:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:44:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:44:32 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/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 12:44:32 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/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 12:44:32 INFO - Using env: {'DISPLAY': ':0', 12:44:32 INFO - 'HOME': '/home/cltbld', 12:44:32 INFO - 'LANG': 'en_US.UTF-8', 12:44:32 INFO - 'LANGUAGE': 'en_US:en', 12:44:32 INFO - 'LOGNAME': 'cltbld', 12:44:32 INFO - 'MAIL': '/var/mail/cltbld', 12:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:32 INFO - 'MOZ_NO_REMOTE': '1', 12:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:32 INFO - 'NO_EM_RESTART': '1', 12:44:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:32 INFO - 'PWD': '/builds/slave/test', 12:44:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:44:32 INFO - 'RUST_BACKTRACE': '1', 12:44:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:44:32 INFO - 'SHELL': '/bin/bash', 12:44:32 INFO - 'SHLVL': '1', 12:44:32 INFO - 'STYLO_FORCE_ENABLED': '1', 12:44:32 INFO - 'TERM': 'linux', 12:44:32 INFO - 'TMOUT': '86400', 12:44:32 INFO - 'USER': 'cltbld', 12:44:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291', 12:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:32 INFO - '_': '/tools/buildbot/bin/python'} 12:44:32 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/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 12:44:32 INFO - mozversion application_buildid: 20170807190002 12:44:32 INFO - mozversion application_changeset: fde1450a4368d04e97174e2eb00fb48901179857 12:44:32 INFO - mozversion application_display_name: Nightly 12:44:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:32 INFO - mozversion application_name: Firefox 12:44:32 INFO - mozversion application_remotingname: firefox 12:44:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:44:32 INFO - mozversion application_vendor: Mozilla 12:44:32 INFO - mozversion application_version: 57.0a1 12:44:32 INFO - mozversion platform_buildid: 20170807190002 12:44:32 INFO - mozversion platform_changeset: fde1450a4368d04e97174e2eb00fb48901179857 12:44:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:44:32 INFO - mozversion platform_version: 57.0a1 12:44:32 INFO - using testdate: 1502135072 12:44:32 INFO - actual date: 1502135072 12:44:32 INFO - starting webserver on 'localhost:36751' 12:44:32 INFO - SUITE-START | Running 2 tests 12:44:32 INFO - TEST-START | dromaeo_css 12:44:32 INFO - Initialising browser for dromaeo_css test... 12:44:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36751/getInfo.html -profile /tmp/tmpvNpiqZ/profile 12:44:32 INFO - TEST-INFO | started process 3319 (/builds/slave/test/build/application/firefox/firefox http://localhost:36751/getInfo.html) 12:44:39 INFO - TEST-INFO | 3319: exit 0 12:44:39 INFO - Browser initialized. 12:44:39 INFO - Running cycle 1/1 for dromaeo_css test... 12:44:39 INFO - TEST-INFO | started process 3544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNpiqZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:40 INFO - PID 3544 | 12:44:40 INFO - PID 3544 | (/builds/slave/test/build/application/firefox/firefox:3599): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:44:40 INFO - PID 3544 | 12:44:50 INFO - PID 3544 | RSS: Main: 173412352 12:44:50 INFO - PID 3544 | 12:47:49 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36751/tests/dromaeo/cssquery-ext.html) 12:47:50 INFO - PID 3544 | RSS: Main: 175411200 12:47:50 INFO - PID 3544 | 12:50:52 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-ext.html (next: http://localhost:36751/tests/dromaeo/cssquery-jquery.html) 12:50:53 INFO - PID 3544 | RSS: Main: 173268992 12:50:53 INFO - PID 3544 | 12:53:55 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36751/tests/dromaeo/cssquery-mootools.html) 12:53:55 INFO - PID 3544 | RSS: Main: 175239168 12:53:55 INFO - PID 3544 | 12:56:57 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36751/tests/dromaeo/cssquery-prototype.html) 12:56:58 INFO - PID 3544 | RSS: Main: 173916160 12:56:58 INFO - PID 3544 | 13:00:01 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36751/tests/dromaeo/cssquery-yui.html) 13:00:02 INFO - PID 3544 | RSS: Main: 177127424 13:00:02 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:36751/tests/dromaeo/cssquery-yui.html (next: http://localhost:36751/tests/dromaeo/cssquery-dojo.html) 13:03:04 INFO - PID 3544 | RSS: Main: 177500160 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | __start_tp_report 13:03:04 INFO - PID 3544 | _x_x_mozilla_page_load 13:03:04 INFO - PID 3544 | _x_x_mozilla_page_load_details 13:03:04 INFO - PID 3544 | |i|pagename|runs| 13:03:04 INFO - PID 3544 | |0;dojo.html;3153.7634677399187;3184.47456169732;3186.681331866815;3187.521871719242;3222.130024893279;6160.476359509442;6278.843028924279;6311.842203944903;6320.778772742955;6353.936460635392;6130.0804879268135;6254.499640028798;6268.185135932323;6287.497000239981;6289.276733175675;5707.971460142693;5715.77136914524;5732.140178973145;5755.827325180251;5818.4181581841685;5729.598928075036;5759;5771.740271687784;5779.450952159538;5797.855053623651;241.68788953336772;5649.632773869726;5755.510781583571;5792.884142317151;5806.071028635398;5650.208970744099;5671.291088613923;5677.148427735831;5728.77084916607;5762.4525670061275;5629.099344104964;5645.745941432645;5690.345610254791;5702.686352250625;5719.14212868069;6108.450239478424;6182.598131121463;6220.564560480768;6254.030625253093;6266.561340706153;6678.632675202862;6692.866142677168;6782.5252232343755;6787.185537735454;6798.184217893835;6676.365745254193;6728.730850765964;6774.661266936682;6866.313368663144;6867.519273650846;6227.283862355842;6236.844078898019;6256.624602523818;6265.185525881606;6266.968665156645;6887.655617219119;6910.516263861582;6913.308669133046;6919.550229235084;6928.7228510859;6573.868522629521;6603.504737144734;6603.70283337251;6608.2730899601;6609.107770450928;6670.899936500957;6680.732770689118;6681.432078273401;6712.228093769279;6712.731490740413;6622.006698995189;6651.467882569383;6725.327467253333;6743.527953043338;6749.358810912955;6562.278149403562;6692.063111164441;6696.59820410777;6701.262861085277;6813.216480104752;5455.645383050089;5456.91814622781;5481.616286859881;5486.039943010037;5494.340679118532;4680.461746899082;4720.244760838249;4723.527647235249;4764.356811830427;4771.23660214364;5834.387389324144;5897;5932.970335148297;5937.406259374028;5938.792142275;6746.561473504206;6781.593104413652;6850.520463567503;6863.450923926074;6867.896981545281;5795.652260864277;5840.503557197686;5851.444112809277;5877.853053673607;5933.436323549256;5986.491148252448;5993.670348130808;6001.489873360726;6004.729787159588;6009.519238460913;6465.741370345228;6499.512536559682;6590.7693230736695;6591.373819487237;6594.835129121714;6741.056252124608;6750.1562304711915;6816.488763342769;6835.760748373783;6857.588544687334;6362.204724409449;6488.2538508072175;6500.609963402211;6508.121403610641;6592.110065141144;6632.436242919406;6637.1703537057865;6681.398674119158;6686.3313668632745;6709.865802684017;6766.695498702668;6773.390394864486;6774.356436138559;6806.217285012287;6870.896936545856;6364.490840732823;6522.934770652422;6546.345365463416;6646;6648.368405001517;6501.1548498694865;6538;6622.503312251504;6624.205095388585;6644.667766611554;6272.7804526843165;6424.196975378078;6435.356464353527;6534.150560427114;6556.639384833689;6375.043743438521;6462.806115816533;6536;6536.117624120873;6537.771178008747;6312.210973628296;6352.237731472253;6504.284528701934;6515.446187073962;6522.119513865568 13:03:04 INFO - PID 3544 | |1;ext.html;804.1194891593702;851.2423942691004;876.110747591195;879.4195830751703;1144.1361771862244;31391.68608313916;31809.204769880736;31866.99999999997;42859.78570107153;43690.56309436905;43483.56516434842;44244.55755442445;44267.11465770683;44270.7786461068;44498.33252501207;7771.300582947533;7772.378209743235;7932.3257523110315;7989.520628762264;7999.720009799658;7770.57261850598;7856.450048496579;7868.763937081897;7870.2916737493615;7872.724454644089;7816.218378162195;7866.567338796364;7877.724279650213;7878.527288362688;7888.842223155562;7726.690932362699;7752.418568607349;7755.72854950074;7767.18444563324;7807.492512986666;7650.770476885702;7713.190115037896;7732.690692372298;7773.727919522789;7820.374370050382;39474.407883881766;40146.197076058605;40308.193836123115;40308.59691403078;40315.395269070985;3488.6860182583437;3524.1189702574356;3525.312564050011;3527.805970671612;3531.841067151984;30965.535516967262;31071;31164.688353116406;31242.37515249682;31272.530912036338;4865.124277630025;4989.925151122736;5032.2703208035;5041.798328066873;5052.646314757969;188759;188881;188925;189199.05400473048;189366;47926.760366197945;48388;48528.7573562137;48536.27195591998;48609.5139048612;49884;50599.74700126476;50668.49331506711;50791.492085079415;51031;14544.85455145435;14868.70262594742;16138.273777680033;16466.42367517131;16476.588085297724;13442.529511467248;13653.522126725517;13673.726525469436;13686.31568421575;13687.589372318846;14399.856001440061;14404.85595144056;14460.421583136556;14557.199354035629;14724.263786810616;5852.414758524199;5860.355360910296;5875.353711091777;5974.402559744078;6004.219451471368;957.9952100239454;977.2768151567931;983.6606370802061;989.2333441582831;998.5306905754284;22811.31566053021;22973.540529189322;22975;22990.195343162908;23168.768312317;1064.9520771565299;1086.6359769477156;1090.2477290669572;1091.7106966653844;1108.6175269531998;11998.280103193836;12027.27836329823;12102.636920892388;12118.515259389702;12133.453994570265;226215;227272;227410;227749;228382;54851;55034.72482637561;55064.44935550593;55125;55315;1388.4931999819994;1426.7360538300447;1432.8925330600246;1447.507847331891;1454.9636259093395;22447.551048978603;22875.542489150455;22933.54132917366;22961;23359;37390.62609373871;37439.62560374361;37507.624923750416;37527.81236093911;37559.812200939916;195450;197164;198236;198568;198829;34100;35781.64218357783;36446.635533645385;36466.453003205505;36631.633683662825;47948.760256199894;48713.5128648709;48836.2674559889;48870.02259954852;48884.51115488942;35156.82421587978;35260.294794104484;35277;35562.82218588891;35636.28727425385;34180.31639367149;34458.62165513451;34532.30935381329;34865.30269394648;34872.82563587166;37282;37746.81126594349;37991.62008379881;38036.42945355877;38108.23783524369;33457.33085338231;33687;33760;34070.65929340675;34166.14584635404;24671.50656986886;24723.62914556247;24776.380590485383;24992.62511062299;25523.74476255288 13:03:04 INFO - PID 3544 | |2;jquery.html;566.4703502225419;573.9971300143499;576.3919065386016;586.9295684517857;593.5518683394038;22215.666764998517;23057.654135187942;23174.88412557937;23194.88402557989;23206.767932320672;26775.86612066937;27245.45509089817;27407.451850962967;27461.588076178872;27504;6459.903101453482;6624.171978502687;6631.137952066225;6633.800985970404;6640.900386494206;6027.939720602782;6295.338989406115;6558.508111891627;6561.114249576318;6576.210854697443;6542.247641521215;6546.050822630739;6546.116274302955;6552.639604821733;6553.3446655334565;6490.837729056764;6500.902486462707;6526.28210896801;6536.575122617039;6547.934520654804;6040.395960403925;6079;6083.7870674526175;6094.146819445281;6097.57316987811;28918;29457.852710736523;29858.253543661584;30006.399872002658;30504.8474757627;1886.1889387563342;1908.5324095596668;1911.1017821623955;1922.7884932657396;1923.8653294269407;19631.116599753044;20385.4903627409;20398.490037749027;20436.38690839277;20464.38606841797;2369.597168481362;2382.6545150953016;2418.9758102418928;2427.053449154831;2477.95044099117;134833.3258333702;138701.30649346788;138807;141027.29486352604;141812.58187418096;14139;15361.692766144615;15552;15584.298706558233;16092.436764713178;22805.771942280695;24083.277501674977;24206.51586968251;24331.635025474632;24577;10717.89282107169;10722.73193170177;10748.677539673823;10913.39976301311;11082.667519974413;10111.393316400892;10134.391936483835;10136.18910487174;10139.695809125738;10154.898451015542;9572;9672.614584895231;9811.803763924681;9834.213262938947;9842.60629574809;2801.411703542279;2805.228562145426;2805.7054009329136;2831.150654803551;2943.1464875186384;945.3146468810195;965.8068386322623;974.6101559376306;975.439297124595;980.1374790184734;20330.79669203289;20499.69250461244;20705.68941465879;24981.00075996976;26020.73979260183;1036.2435422141878;1036.3988886445843;1058.3279617442824;1062.7661914378825;1063.728749168957;11226.21416500837;11284.266522676;11345.773084538263;11557.653270401901;11563.537458501734;525465;548486;550862;554428;555422;132030.33984830015;132359;133577.3321133388;138409.3079534616;139111.99999999796;1239.4918083585867;1328.2960031183488;1330.7072444062292;1335.3923964596086;1339.1161833190047;21383.25158619503;21594.244201452875;21997.450063748533;22028.559428811655;22174.223902163347;56920.430795691515;57657.711711441174;60253.69873150606;60451;63502.36497634964;71946;72949.27050729425;73440;73837.26162738304;73959.26040739524;20360.490987725425;20654.483637909172;20802.167913283298;20971.8951405242;21098.57802843904;23831.64252536248;24073.51852962966;24118.276451706475;24154.913028914092;24220.39449013789;18747.250109995446;18838.3406580769;19028.809711903257;19120.80879191246;19278.614427711087;16779.412720554723;16963.151842407584;17372.13139343053;17670;17801.73297400566;18460.630787384445;19144.71282930785;19288.8071119287;19294.22823087061;19508.414747557596;20090;20709.689354659993;21232;21249.468763280423;21486.462838429165;18870.71693924565;19156.32952846644;19197.136128873954;19290.324838630582;19501.902490487457 13:03:04 INFO - PID 3544 | |3;mootools.html;1361.088070992435;1412.2091628687929;1414.8302203735552;1419.0775995602853;1421.6303761022139;13574.660633484167;14171.858281417195;14184.929075354608;14202.289885505736;14208.147511149313;13956.44174233032;14340.569782906503;14719.484818031371;14804.777928331083;14829.110253384804;2666.0668765931914;2744.2316151477517;2744.945101097977;2749.6562929633797;2756.186924857172;2601.908933187339;2624.868756562174;2678.6919504256966;2693.4478431921507;2727.1818454463682;2632.697239817426;2662.254568720761;2663.4273631169294;2665.4802313548867;2667.1198504493473;2560.0655760647323;2603.0498867913266;2604.6874375075017;2610.6475625790467;2622.357522407003;2568.4221050263727;2571.9228423147338;2607.8044146689076;2616.123598594454;2617.149426436416;13721.519746808814;14043.297835108204;14056.297185140702;14058.086224395483;14064.156150630995;7378.704851805921;7645.770626881147;7655.157932627407;7658.8468230635635;7665.271799179125;4923.138450771136;4952.281919121743;5036.974815125937;5076.847694569132;5077.339945807058;1745.1797655102082;1756.9033703146322;1768.0982698823564;1786.8749187556875;1810.8822926509736;23377.649335259986;23555.528889422116;23624.17315393953;23646.881765591235;23651.881740591187;6012.338642749294;6137.7851775187655;6318.304986451487;6323;6389.297177310492;15519.379224831106;16083.678326433639;16115.113668748332;16206.513804585882;16483.175841207893;7261.636918154177;7566.3190312871;7569.243075692497;7570.432217583703;7572.962135189288;6843.863122737517;7003.439724822002;7009.0537777399395;7139.643017849191;7194.38847697941;5115.38615366151;5282.630215884851;5298.6290959633225;5355.785768569213;5370.62405631602;1498.715244103617;1501.0693370110382;1502.4290769507518;1505.8343582205948;1520.4222395489644;855.781775647206;869.3219288954625;885.7431344909904;890.9198172164537;893.946363218209;7248.601326926964;7285.562866228043;8706.956465217634;9062;9104.681336153202;959.4818797849223;962.711186644018;982.8476586129161;989.2728844299434;996.367306760198;4878.0975519529;5278.419373868871;5647.1529270609735;5669.092945128842;5740.253767010346;18827.623447530972;19222;19691.60616787685;19755.50611234702;19808.70286945697;19013.90493047526;19042;19103.904480477508;19117.330893418664;19305.227790888206;9946.154576861049;10622.468876556295;10711.357318560911;10783.730406739895;10933;7832.84334313322;8270.19224525878;8355.373346998878;8498.150184981452;8756.25571826402;16804.24380902838;17238.827611723722;17441.127943603024;17554.122293885;17606.911965440602;17459.38892138769;17528.474145775646;17699.849509781823;18118.818811811714;18214.089295535436;11426.314421134759;11502.53989840397;11735.941320293345;11736.295822250693;11747.588834391097;12798.61604151877;12914.806277906027;13106.082574220094;13159.47362105505;13189.670258243237;10514.789704206027;10668.679939601825;10668.83996740034;10829.133669306595;10943.28868623537;10340.844887326846;10455.738606534898;10598.31110977784;10780.514876830404;10835.458227088771;8941.150590693873;9479.668211612561;9540.570674319533;9576.180525700094;9577.664781732607;7220.3140701633265;7317.487775855639;7326.450516211199;7421.628918554159;7425.591592462466;7255.09311336083;7371.741989030358;7374.778756637309;7424.331810137113;7479.962600186965 13:03:04 INFO - PID 3544 | |4;prototype.html;480.9086273608013;484.80607756897234;487.2690963554668;496.0871995528227;496.5456607204406;6079.2097027386435;6159.969200154004;6166.132748272053;6173.876522469548;6223.471004964584;5987.610805297652;6014.827108713803;6027;6030.427109424598;6032.909506357408;4877.8780530486665;4887.608991280698;4888.706677599338;4896.804127834882;4910.435299940516;4762.809487620491;4848.127337079324;4882.487338829425;4883.462819089915;4885.557221389306;4844.66087373884;4853.199222128344;4867.829625963092;4872.171730805754;4880.609551235911;4835.443923948756;4841.443234028096;4843.4813896773485;4853.417589889201;4873.951260487385;4313.525512193656;4342.869713908588;4349.913001739979;4357.520672725997;4363.192809330284;5844.707764611752;5919.881602367972;5996.640201587918;6010.78962236324;6026.186464827236;5501.697406642633;5514;5543.695096769676;5558.610897237195;5568.972155139239;6315.336889626615;6378.489720822323;6415.326390728999;6416.422521973045;6425;4702.130105930414;4737.341930324394;4748.311494833264;4751.287306903958;4759.190937540627;6454.903176452357;6458.451031662267;6567.57863614113;6694.49791265657;6824.1128653275255;4658.1848176568965;4760.357351757538;4795.304680821261;4800.591949684246;4823.649378174046;4851.805927762921;4874.8781280467565;4887.120318342732;4887.780049897763;4940.876478088005;5480.342358916955;5508.3114610673665;5521.3926468089285;5535.58483113768;5553.861153471114;6450.645214513153;6486.902696459557;6510.641914694643;6518.380753828379;6555.345704549728;1708.2654458582929;1721.7933847938077;1722.3627257914652;1728.395061728385;1729.0749449044952;1131.3947038334452;1174.9177557571059;1178.8585369755513;1188.120790614956;1193.76721539299;5673.659580425187;5701.885962280731;5712.371639119693;5750.079987202028;5770.653760774367;6431.5819471734185;6544.411003009752;6632.701528431232;6634.834129146713;6677.799666010027;5618.494335509824;5638.915416268759;5660.094384898479;5683.346415162227;5720.456556627114;3432.4508078707286;3520.4543295789194;3529.1882866940746;3543.3976224041976;3548.2016546277396;6337.65142917144;6348.523860710373;6354.936450635527;6376.489880809524;6382.521310901701;6811.148606424197;6812.727490900407;6828.5902845829405;6856.211535673461;6860.5197636164985;6316.778912738124;6374.74501019954;6389.201349831271;6411.6153030818305;6443.838904027437;6620.867582648224;6622.251765517256;6631.834204144935;6672.999050142517;6693.230278518033;6517.641529715911;6531.314212007861;6547.541672082908;6560.245571759118;6570.145881035435;6356.364363563792;6359.395857393541;6374.776882809079;6396.200474940632;6424.261209960914;4796.160671882337;4829.589484893823;4835.95164048369;4853.223484242504;4872.951270487391;6275.560710750204;6413.8717225656155;6550;6613.305602911625;6663.13379260693;6295.338989406229;6308;6309.779157729457;6326.177596912372;6365.936340636535;6259.530535209787;6300.338464461165;6338.778142764981;6392.328805475358;6422.389872962061;6186.19579454668;6289.119523266655;6348.508100596264;6349.714262858275;6375;6421.5825971311715;6435.903461447989;6452.290248072803;6502.73989040452;6503.106117777733;6234;6234.688265586793;6259.12372267892;6260.686965651608;6271.3415091414745 13:03:04 INFO - PID 3544 | |5;yui.html;881.8236352729456;906.5150144672601;910.5265262063731;911.9544022798858;922.6816748221863;18645.62708745826;19515.804841951576;19750.90124549377;19765.50586235343;22305.55388892221;21120.894395528;21917.452063698416;22048.44878878025;22069.337919862388;22172.667409988862;1025.4718819807786;1060.2631171335925;1061.8885017073212;1063.643679367413;1067.3862529045791;1020.1226944827442;1049.3546468921597;1050.049705016957;1050.994745026274;1051.7686109055996;1105.4748994227757;1119.1941801902617;1120.1822669451306;1120.383788916097;1121.1031175059961;1088.5917780832187;1095.769888323453;1098.7967226063163;1100.9174311926558;1100.9889901100967;807.9636416361219;809.0897740042452;809.8663720486113;810.9594520274022;811.2495941254375;16083.758743618739;16385.262663180187;16746.832531674772;17084;17311.220995055253;21205.681914771292;21322.573548528944;21339.35981920545;21784.891075544678;21796.891015544978;15830;15914.840851591453;16132.59668508285;16140.838591614169;16159.353625854952;3619.1314084619503;3627.2745450909924;3672.2839046385966;3683.336999340118;3685;122210;127365;128560;129633.35183324023;130841.34579327042;17067.40264090751;17427.56431089233;17471.475855724348;17474.301027958994;17488.213030413663;29609.851950740107;31785.205369865474;31972.68027319697;32140;32233.67766322307;7530.322270995636;7785.922140778633;7787.454878158588;8078.313343365762;8186.959065204635;3767.3595488766973;3942.0539070623418;3946.7631942083567;3988;4014.959850401517;5321.9622173676535;5490.670559766427;5504.119340905436;5515.310586176728;5518.558515318845;853.5007020892847;875.8248350329832;879.5909901895521;881.0792721605937;892.3307519360479;661.256086902235;674.4570620650326;678.176016140382;680.4658343200663;688.1054628982403;11488.77022459546;11729.237599556001;11958.521659133712;12662.303573303372;12814.615561533168;664.139938779282;666.8399584099781;672.1732269308679;685.3420716112588;690.5614934516618;5395.919061214085;5435.456454354533;5516.200150978086;6002.189704389939;6421.903671444932;98440.50779746055;98735;102906;104070.47964760127;104304;89291;90237.54881225553;91851;93914.53042734879;94364;78522.21477785263;81686.59156704179;83000.58499707463;83044.99999999879;83254.16745832586;12726.300053497147;12935.547255846;12997.285149316878;13003.869961300266;13128.737425251633;36187.81906090453;36739.63260367362;36901.63098368982;37089.814550927076;39104.2179156421;47746.76126619345;48031.75984120057;67078;68172.31827681858;71171.28828711646;17704.91147544254;17712.2029508675;17713.645727085128;17952.192151353483;17968.91015544914;16603.88613873307;19045.90477047606;19060;21114.15543378309;21830.345089647337;19553;19856.801431986074;20227.494312642302;20371.59256814885;20548.38354849357;18948.147333370307;19412.611747764684;19477.123529440927;19528;20095.799042009392;16913;17204.13979301055;17356.39252626152;17490.387836425663;19945.900270499136;12897.290649014394;13576;14006.509772157926;14008.649783755487;14422.278886055445;14384.208868512333;14550.5634830951;14723.779143312644;14797.260136992893;14934.402623894923 13:03:04 INFO - PID 3544 | __end_tp_report 13:03:04 INFO - PID 3544 | __start_cc_report 13:03:04 INFO - PID 3544 | _x_x_mozilla_cycle_collect,391 13:03:04 INFO - PID 3544 | __end_cc_report 13:03:04 INFO - PID 3544 | __startTimestamp1502136184682__endTimestamp 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | ------- Summary: start ------- 13:03:04 INFO - PID 3544 | Number of tests: 6 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | [#0] dojo.html Cycles:165 Average:6165.10 Median:6435.36 stddev:860.52 (13.4%) stddev-sans-first:830.10 13:03:04 INFO - PID 3544 | Values: 3153.8 3184.5 3186.7 3187.5 3222.1 6160.5 6278.8 6311.8 6320.8 6353.9 6130.1 6254.5 6268.2 6287.5 6289.3 5708.0 5715.8 5732.1 5755.8 5818.4 5729.6 5759.0 5771.7 5779.5 5797.9 241.7 5649.6 5755.5 5792.9 5806.1 5650.2 5671.3 5677.1 5728.8 5762.5 5629.1 5645.7 5690.3 5702.7 5719.1 6108.5 6182.6 6220.6 6254.0 6266.6 6678.6 6692.9 6782.5 6787.2 6798.2 6676.4 6728.7 6774.7 6866.3 6867.5 6227.3 6236.8 6256.6 6265.2 6267.0 6887.7 6910.5 6913.3 6919.6 6928.7 6573.9 6603.5 6603.7 6608.3 6609.1 6670.9 6680.7 6681.4 6712.2 6712.7 6622.0 6651.5 6725.3 6743.5 6749.4 6562.3 6692.1 6696.6 6701.3 6813.2 5455.6 5456.9 5481.6 5486.0 5494.3 4680.5 4720.2 4723.5 4764.4 4771.2 5834.4 5897.0 5933.0 5937.4 5938.8 6746.6 6781.6 6850.5 6863.5 6867.9 5795.7 5840.5 5851.4 5877.9 5933.4 5986.5 5993.7 6001.5 6004.7 6009.5 6465.7 6499.5 6590.8 6591.4 6594.8 6741.1 6750.2 6816.5 6835.8 6857.6 6362.2 6488.3 6500.6 6508.1 6592.1 6632.4 6637.2 6681.4 6686.3 6709.9 6766.7 6773.4 6774.4 6806.2 6870.9 6364.5 6522.9 6546.3 6646.0 6648.4 6501.2 6538.0 6622.5 6624.2 6644.7 6272.8 6424.2 6435.4 6534.2 6556.6 6375.0 6462.8 6536.0 6536.1 6537.8 6312.2 6352.2 6504.3 6515.4 6522.1 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | [#1] ext.html Cycles:180 Average:38006.15 Median:36114.14 stddev:53183.34 (147.3%) stddev-sans-first:53259.17 13:03:04 INFO - PID 3544 | Values: 804.1 851.2 876.1 879.4 1144.1 31391.7 31809.2 31867.0 42859.8 43690.6 43483.6 44244.6 44267.1 44270.8 44498.3 7771.3 7772.4 7932.3 7989.5 7999.7 7770.6 7856.5 7868.8 7870.3 7872.7 7816.2 7866.6 7877.7 7878.5 7888.8 7726.7 7752.4 7755.7 7767.2 7807.5 7650.8 7713.2 7732.7 7773.7 7820.4 39474.4 40146.2 40308.2 40308.6 40315.4 3488.7 3524.1 3525.3 3527.8 3531.8 30965.5 31071.0 31164.7 31242.4 31272.5 4865.1 4989.9 5032.3 5041.8 5052.6 188759.0 188881.0 188925.0 189199.1 189366.0 47926.8 48388.0 48528.8 48536.3 48609.5 49884.0 50599.7 50668.5 50791.5 51031.0 14544.9 14868.7 16138.3 16466.4 16476.6 13442.5 13653.5 13673.7 13686.3 13687.6 14399.9 14404.9 14460.4 14557.2 14724.3 5852.4 5860.4 5875.4 5974.4 6004.2 958.0 977.3 983.7 989.2 998.5 22811.3 22973.5 22975.0 22990.2 23168.8 1065.0 1086.6 1090.2 1091.7 1108.6 11998.3 12027.3 12102.6 12118.5 12133.5 226215.0 227272.0 227410.0 227749.0 228382.0 54851.0 55034.7 55064.4 55125.0 55315.0 1388.5 1426.7 1432.9 1447.5 1455.0 22447.6 22875.5 22933.5 22961.0 23359.0 37390.6 37439.6 37507.6 37527.8 37559.8 195450.0 197164.0 198236.0 198568.0 198829.0 34100.0 35781.6 36446.6 36466.5 36631.6 47948.8 48713.5 48836.3 48870.0 48884.5 35156.8 35260.3 35277.0 35562.8 35636.3 34180.3 34458.6 34532.3 34865.3 34872.8 37282.0 37746.8 37991.6 38036.4 38108.2 33457.3 33687.0 33760.0 34070.7 34166.1 24671.5 24723.6 24776.4 24992.6 25523.7 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | [#2] jquery.html Cycles:180 Average:37883.75 Median:23116.27 stddev:91849.06 (397.3%) stddev-sans-first:92063.98 13:03:04 INFO - PID 3544 | Values: 566.5 574.0 576.4 586.9 593.6 22215.7 23057.7 23174.9 23194.9 23206.8 26775.9 27245.5 27407.5 27461.6 27504.0 6459.9 6624.2 6631.1 6633.8 6640.9 6027.9 6295.3 6558.5 6561.1 6576.2 6542.2 6546.1 6546.1 6552.6 6553.3 6490.8 6500.9 6526.3 6536.6 6547.9 6040.4 6079.0 6083.8 6094.1 6097.6 28918.0 29457.9 29858.3 30006.4 30504.8 1886.2 1908.5 1911.1 1922.8 1923.9 19631.1 20385.5 20398.5 20436.4 20464.4 2369.6 2382.7 2419.0 2427.1 2478.0 134833.3 138701.3 138807.0 141027.3 141812.6 14139.0 15361.7 15552.0 15584.3 16092.4 22805.8 24083.3 24206.5 24331.6 24577.0 10717.9 10722.7 10748.7 10913.4 11082.7 10111.4 10134.4 10136.2 10139.7 10154.9 9572.0 9672.6 9811.8 9834.2 9842.6 2801.4 2805.2 2805.7 2831.2 2943.1 945.3 965.8 974.6 975.4 980.1 20330.8 20499.7 20705.7 24981.0 26020.7 1036.2 1036.4 1058.3 1062.8 1063.7 11226.2 11284.3 11345.8 11557.7 11563.5 525465.0 548486.0 550862.0 554428.0 555422.0 132030.3 132359.0 133577.3 138409.3 139112.0 1239.5 1328.3 1330.7 1335.4 1339.1 21383.3 21594.2 21997.5 22028.6 22174.2 56920.4 57657.7 60253.7 60451.0 63502.4 71946.0 72949.3 73440.0 73837.3 73959.3 20360.5 20654.5 20802.2 20971.9 21098.6 23831.6 24073.5 24118.3 24154.9 24220.4 18747.3 18838.3 19028.8 19120.8 19278.6 16779.4 16963.2 17372.1 17670.0 17801.7 18460.6 19144.7 19288.8 19294.2 19508.4 20090.0 20709.7 21232.0 21249.5 21486.5 18870.7 19156.3 19197.1 19290.3 19501.9 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | [#3] mootools.html Cycles:180 Average:8811.92 Median:2609.23 stddev:6018.32 (230.7%) stddev-sans-first:6009.16 13:03:04 INFO - PID 3544 | Values: 1361.1 1412.2 1414.8 1419.1 1421.6 13574.7 14171.9 14184.9 14202.3 14208.1 13956.4 14340.6 14719.5 14804.8 14829.1 2666.1 2744.2 2744.9 2749.7 2756.2 2601.9 2624.9 2678.7 2693.4 2727.2 2632.7 2662.3 2663.4 2665.5 2667.1 2560.1 2603.0 2604.7 2610.6 2622.4 2568.4 2571.9 2607.8 2616.1 2617.1 13721.5 14043.3 14056.3 14058.1 14064.2 7378.7 7645.8 7655.2 7658.8 7665.3 4923.1 4952.3 5037.0 5076.8 5077.3 1745.2 1756.9 1768.1 1786.9 1810.9 23377.6 23555.5 23624.2 23646.9 23651.9 6012.3 6137.8 6318.3 6323.0 6389.3 15519.4 16083.7 16115.1 16206.5 16483.2 7261.6 7566.3 7569.2 7570.4 7573.0 6843.9 7003.4 7009.1 7139.6 7194.4 5115.4 5282.6 5298.6 5355.8 5370.6 1498.7 1501.1 1502.4 1505.8 1520.4 855.8 869.3 885.7 890.9 893.9 7248.6 7285.6 8707.0 9062.0 9104.7 959.5 962.7 982.8 989.3 996.4 4878.1 5278.4 5647.2 5669.1 5740.3 18827.6 19222.0 19691.6 19755.5 19808.7 19013.9 19042.0 19103.9 19117.3 19305.2 9946.2 10622.5 10711.4 10783.7 10933.0 7832.8 8270.2 8355.4 8498.2 8756.3 16804.2 17238.8 17441.1 17554.1 17606.9 17459.4 17528.5 17699.8 18118.8 18214.1 11426.3 11502.5 11735.9 11736.3 11747.6 12798.6 12914.8 13106.1 13159.5 13189.7 10514.8 10668.7 10668.8 10829.1 10943.3 10340.8 10455.7 10598.3 10780.5 10835.5 8941.2 9479.7 9540.6 9576.2 9577.7 7220.3 7317.5 7326.5 7421.6 7425.6 7255.1 7371.7 7374.8 7424.3 7480.0 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | [#4] prototype.html Cycles:180 Average:5387.37 Median:6020.51 stddev:1520.49 (25.3%) stddev-sans-first:1479.49 13:03:04 INFO - PID 3544 | Values: 480.9 484.8 487.3 496.1 496.5 6079.2 6160.0 6166.1 6173.9 6223.5 5987.6 6014.8 6027.0 6030.4 6032.9 4877.9 4887.6 4888.7 4896.8 4910.4 4762.8 4848.1 4882.5 4883.5 4885.6 4844.7 4853.2 4867.8 4872.2 4880.6 4835.4 4841.4 4843.5 4853.4 4874.0 4313.5 4342.9 4349.9 4357.5 4363.2 5844.7 5919.9 5996.6 6010.8 6026.2 5501.7 5514.0 5543.7 5558.6 5569.0 6315.3 6378.5 6415.3 6416.4 6425.0 4702.1 4737.3 4748.3 4751.3 4759.2 6454.9 6458.5 6567.6 6694.5 6824.1 4658.2 4760.4 4795.3 4800.6 4823.6 4851.8 4874.9 4887.1 4887.8 4940.9 5480.3 5508.3 5521.4 5535.6 5553.9 6450.6 6486.9 6510.6 6518.4 6555.3 1708.3 1721.8 1722.4 1728.4 1729.1 1131.4 1174.9 1178.9 1188.1 1193.8 5673.7 5701.9 5712.4 5750.1 5770.7 6431.6 6544.4 6632.7 6634.8 6677.8 5618.5 5638.9 5660.1 5683.3 5720.5 3432.5 3520.5 3529.2 3543.4 3548.2 6337.7 6348.5 6354.9 6376.5 6382.5 6811.1 6812.7 6828.6 6856.2 6860.5 6316.8 6374.7 6389.2 6411.6 6443.8 6620.9 6622.3 6631.8 6673.0 6693.2 6517.6 6531.3 6547.5 6560.2 6570.1 6356.4 6359.4 6374.8 6396.2 6424.3 4796.2 4829.6 4836.0 4853.2 4873.0 6275.6 6413.9 6550.0 6613.3 6663.1 6295.3 6308.0 6309.8 6326.2 6365.9 6259.5 6300.3 6338.8 6392.3 6422.4 6186.2 6289.1 6348.5 6349.7 6375.0 6421.6 6435.9 6452.3 6502.7 6503.1 6234.0 6234.7 6259.1 6260.7 6271.3 13:03:04 INFO - PID 3544 | 13:03:04 INFO - PID 3544 | [#5] yui.html Cycles:180 Average:23032.19 Median:21117.52 stddev:30703.02 (145.4%) stddev-sans-first:30744.10 13:03:04 INFO - PID 3544 | Values: 881.8 906.5 910.5 912.0 922.7 18645.6 19515.8 19750.9 19765.5 22305.6 21120.9 21917.5 22048.4 22069.3 22172.7 1025.5 1060.3 1061.9 1063.6 1067.4 1020.1 1049.4 1050.0 1051.0 1051.8 1105.5 1119.2 1120.2 1120.4 1121.1 1088.6 1095.8 1098.8 1100.9 1101.0 808.0 809.1 809.9 811.0 811.2 16083.8 16385.3 16746.8 17084.0 17311.2 21205.7 21322.6 21339.4 21784.9 21796.9 15830.0 15914.8 16132.6 16140.8 16159.4 3619.1 3627.3 3672.3 3683.3 3685.0 122210.0 127365.0 128560.0 129633.4 130841.3 17067.4 17427.6 17471.5 17474.3 17488.2 29609.9 31785.2 31972.7 32140.0 32233.7 7530.3 7785.9 7787.5 8078.3 8187.0 3767.4 3942.1 3946.8 3988.0 4015.0 5322.0 5490.7 5504.1 5515.3 5518.6 853.5 875.8 879.6 881.1 892.3 661.3 674.5 678.2 680.5 688.1 11488.8 11729.2 11958.5 12662.3 12814.6 664.1 666.8 672.2 685.3 690.6 5395.9 5435.5 5516.2 6002.2 6421.9 98440.5 98735.0 102906.0 104070.5 104304.0 89291.0 90237.5 91851.0 93914.5 94364.0 78522.2 81686.6 83000.6 83045.0 83254.2 12726.3 12935.5 12997.3 13003.9 13128.7 36187.8 36739.6 36901.6 37089.8 39104.2 47746.8 48031.8 67078.0 68172.3 71171.3 17704.9 17712.2 17713.6 17952.2 17968.9 16603.9 19045.9 19060.0 21114.2 21830.3 19553.0 19856.8 20227.5 20371.6 20548.4 18948.1 19412.6 19477.1 19528.0 20095.8 16913.0 17204.1 17356.4 17490.4 19945.9 12897.3 13576.0 14006.5 14008.6 14422.3 14384.2 14550.6 14723.8 14797.3 14934.4 13:03:04 INFO - PID 3544 | -------- Summary: end -------- 13:03:04 INFO - PID 3544 | 13:03:05 INFO - TEST-INFO | 3544: exit 0 13:03:05 INFO - TEST-OK | dromaeo_css | took 1112969ms 13:03:05 INFO - TEST-START | kraken 13:03:05 INFO - Initialising browser for kraken test... 13:03:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36751/getInfo.html -profile /tmp/tmpW_9tOP/profile 13:03:05 INFO - TEST-INFO | started process 3917 (/builds/slave/test/build/application/firefox/firefox http://localhost:36751/getInfo.html) 13:03:10 INFO - TEST-INFO | 3917: exit 0 13:03:10 INFO - Browser initialized. 13:03:10 INFO - Running cycle 1/1 for kraken test... 13:03:10 INFO - TEST-INFO | started process 4139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_9tOP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:11 INFO - PID 4139 | 13:03:11 INFO - PID 4139 | (/builds/slave/test/build/application/firefox/firefox:4193): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:03:11 INFO - PID 4139 | 13:03:22 INFO - PID 4139 | RSS: Main: 174190592 13:03:22 INFO - PID 4139 | 13:03:25 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-beat-detection) 13:03:25 INFO - PID 4139 | RSS: Main: 178589696 13:03:25 INFO - PID 4139 | 13:03:28 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-dft) 13:03:29 INFO - PID 4139 | RSS: Main: 178741248 13:03:29 INFO - PID 4139 | 13:03:32 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-fft) 13:03:33 INFO - PID 4139 | RSS: Main: 173531136 13:03:33 INFO - PID 4139 | 13:03:35 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36751/tests/kraken/driver.html?testName=audio-oscillator) 13:03:35 INFO - PID 4139 | RSS: Main: 174145536 13:03:35 INFO - PID 4139 | 13:03:38 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:38 INFO - PID 4139 | RSS: Main: 174706688 13:03:38 INFO - PID 4139 | 13:03:41 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36751/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:42 INFO - PID 4139 | RSS: Main: 177168384 13:03:42 INFO - PID 4139 | 13:03:46 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36751/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:46 INFO - PID 4139 | RSS: Main: 176914432 13:03:46 INFO - PID 4139 | 13:03:49 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36751/tests/kraken/driver.html?testName=json-parse-financial) 13:03:50 INFO - PID 4139 | RSS: Main: 177426432 13:03:50 INFO - PID 4139 | 13:03:51 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:52 INFO - PID 4139 | RSS: Main: 177336320 13:03:52 INFO - PID 4139 | 13:03:54 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:55 INFO - PID 4139 | RSS: Main: 174206976 13:03:55 INFO - PID 4139 | 13:03:57 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:57 INFO - PID 4139 | RSS: Main: 174440448 13:03:57 INFO - PID 4139 | 13:04:00 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:04:01 INFO - PID 4139 | RSS: Main: 174944256 13:04:01 INFO - PID 4139 | 13:04:04 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:04:05 INFO - PID 4139 | RSS: Main: 174960640 13:04:05 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | Cycle 1(1): loaded http://localhost:36751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36751/tests/kraken/driver.html?testName=ai-astar) 13:04:07 INFO - PID 4139 | RSS: Main: 176721920 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | __start_tp_report 13:04:07 INFO - PID 4139 | _x_x_mozilla_page_load 13:04:07 INFO - PID 4139 | _x_x_mozilla_page_load_details 13:04:07 INFO - PID 4139 | |i|pagename|runs| 13:04:07 INFO - PID 4139 | |0;ai-astar;103;109;102;108;108;108;107;98;109;107 13:04:07 INFO - PID 4139 | |1;audio-beat-detection;147;120;153;173;121;155;145;123;186;121 13:04:07 INFO - PID 4139 | |2;audio-dft;167;162;163;163;164;166;167;168;163;165 13:04:07 INFO - PID 4139 | |3;audio-fft;75;77;74;174;82;75;76;85;101;77 13:04:07 INFO - PID 4139 | |4;audio-oscillator;78;78;136;79;80;80;131;79;79;139 13:04:07 INFO - PID 4139 | |5;imaging-gaussian-blur;114;115;117;114;114;114;113;114;116;116 13:04:07 INFO - PID 4139 | |6;imaging-darkroom;150;154;152;152;150;153;153;151;150;151 13:04:07 INFO - PID 4139 | |7;imaging-desaturate;94;93;95;95;99;94;93;99;98;95 13:04:07 INFO - PID 4139 | |8;json-parse-financial;57;61;55;60;64;55;54;55;56;54 13:04:07 INFO - PID 4139 | |9;json-stringify-tinderbox;55;55;54;54;54;54;54;56;54;55 13:04:07 INFO - PID 4139 | |10;stanford-crypto-aes;88;78;78;89;77;88;86;79;77;80 13:04:07 INFO - PID 4139 | |11;stanford-crypto-ccm;138;134;133;135;127;130;132;124;130;157 13:04:07 INFO - PID 4139 | |12;stanford-crypto-pbkdf2;176;170;173;171;179;172;173;189;174;185 13:04:07 INFO - PID 4139 | |13;stanford-crypto-sha256-iterative;74;68;66;73;71;70;66;66;66;65 13:04:07 INFO - PID 4139 | __end_tp_report 13:04:07 INFO - PID 4139 | __start_cc_report 13:04:07 INFO - PID 4139 | _x_x_mozilla_cycle_collect,948 13:04:07 INFO - PID 4139 | __end_cc_report 13:04:07 INFO - PID 4139 | __startTimestamp1502136247297__endTimestamp 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | ------- Summary: start ------- 13:04:07 INFO - PID 4139 | Number of tests: 14 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#0] ai-astar Cycles:10 Average:105.90 Median:108.00 stddev:3.67 (3.4%) stddev-sans-first:3.73 13:04:07 INFO - PID 4139 | Values: 103.0 109.0 102.0 108.0 108.0 108.0 107.0 98.0 109.0 107.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:150.00 stddev:23.31 (15.5%) stddev-sans-first:24.71 13:04:07 INFO - PID 4139 | Values: 147.0 120.0 153.0 173.0 121.0 155.0 145.0 123.0 186.0 121.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.50 stddev:2.10 (1.3%) stddev-sans-first:2.07 13:04:07 INFO - PID 4139 | Values: 167.0 162.0 163.0 163.0 164.0 166.0 167.0 168.0 163.0 165.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#3] audio-fft Cycles:10 Average:89.60 Median:76.50 stddev:30.74 (40.2%) stddev-sans-first:32.15 13:04:07 INFO - PID 4139 | Values: 75.0 77.0 74.0 174.0 82.0 75.0 76.0 85.0 101.0 77.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:79.00 stddev:27.29 (34.5%) stddev-sans-first:28.16 13:04:07 INFO - PID 4139 | Values: 78.0 78.0 136.0 79.0 80.0 80.0 131.0 79.0 79.0 139.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.30 13:04:07 INFO - PID 4139 | Values: 114.0 115.0 117.0 114.0 114.0 114.0 113.0 114.0 116.0 116.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 13:04:07 INFO - PID 4139 | Values: 150.0 154.0 152.0 152.0 150.0 153.0 153.0 151.0 150.0 151.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.32 (2.4%) stddev-sans-first:2.40 13:04:07 INFO - PID 4139 | Values: 94.0 93.0 95.0 95.0 99.0 94.0 93.0 99.0 98.0 95.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.41 (6.0%) stddev-sans-first:3.62 13:04:07 INFO - PID 4139 | Values: 57.0 61.0 55.0 60.0 64.0 55.0 54.0 55.0 56.0 54.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 13:04:07 INFO - PID 4139 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 54.0 56.0 54.0 55.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:5.08 (6.1%) stddev-sans-first:4.90 13:04:07 INFO - PID 4139 | Values: 88.0 78.0 78.0 89.0 77.0 88.0 86.0 79.0 77.0 80.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.50 stddev:9.02 (6.8%) stddev-sans-first:9.45 13:04:07 INFO - PID 4139 | Values: 138.0 134.0 133.0 135.0 127.0 130.0 132.0 124.0 130.0 157.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:175.00 stddev:6.30 (3.6%) stddev-sans-first:6.69 13:04:07 INFO - PID 4139 | Values: 176.0 170.0 173.0 171.0 179.0 172.0 173.0 189.0 174.0 185.0 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:3.27 (4.7%) stddev-sans-first:2.80 13:04:07 INFO - PID 4139 | Values: 74.0 68.0 66.0 73.0 71.0 70.0 66.0 66.0 66.0 65.0 13:04:07 INFO - PID 4139 | -------- Summary: end -------- 13:04:07 INFO - PID 4139 | 13:04:07 INFO - PID 4139 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:04:07 INFO - TEST-INFO | 4139: exit 0 13:04:08 INFO - TEST-OK | kraken | took 62648ms 13:04:08 INFO - SUITE-END | took 1175s 13:04:08 INFO - Completed test suite (00:19:36) 13:04:08 INFO - javascript benchmark 13:04:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8547.6995141829, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.7634677399187, 3184.47456169732, 3186.681331866815, 3187.521871719242, 3222.130024893279, 6160.476359509442, 6278.843028924279, 6311.842203944903, 6320.778772742955, 6353.936460635392, 6130.0804879268135, 6254.499640028798, 6268.185135932323, 6287.497000239981, 6289.276733175675, 5707.971460142693, 5715.77136914524, 5732.140178973145, 5755.827325180251, 5818.4181581841685, 5729.598928075036, 5759.0, 5771.740271687784, 5779.450952159538, 5797.855053623651, 241.68788953336772, 5649.632773869726, 5755.510781583571, 5792.884142317151, 5806.071028635398, 5650.208970744099, 5671.291088613923, 5677.148427735831, 5728.77084916607, 5762.4525670061275, 5629.099344104964, 5645.745941432645, 5690.345610254791, 5702.686352250625, 5719.14212868069, 6108.450239478424, 6182.598131121463, 6220.564560480768, 6254.030625253093, 6266.561340706153, 6678.632675202862, 6692.866142677168, 6782.5252232343755, 6787.185537735454, 6798.184217893835, 6676.365745254193, 6728.730850765964, 6774.661266936682, 6866.313368663144, 6867.519273650846, 6227.283862355842, 6236.844078898019, 6256.624602523818, 6265.185525881606, 6266.968665156645, 6887.655617219119, 6910.516263861582, 6913.308669133046, 6919.550229235084, 6928.7228510859, 6573.868522629521, 6603.504737144734, 6603.70283337251, 6608.2730899601, 6609.107770450928, 6670.899936500957, 6680.732770689118, 6681.432078273401, 6712.228093769279, 6712.731490740413, 6622.006698995189, 6651.467882569383, 6725.327467253333, 6743.527953043338, 6749.358810912955, 6562.278149403562, 6692.063111164441, 6696.59820410777, 6701.262861085277, 6813.216480104752, 5455.645383050089, 5456.91814622781, 5481.616286859881, 5486.039943010037, 5494.340679118532, 4680.461746899082, 4720.244760838249, 4723.527647235249, 4764.356811830427, 4771.23660214364, 5834.387389324144, 5897.0, 5932.970335148297, 5937.406259374028, 5938.792142275, 6746.561473504206, 6781.593104413652, 6850.520463567503, 6863.450923926074, 6867.896981545281, 5795.652260864277, 5840.503557197686, 5851.444112809277, 5877.853053673607, 5933.436323549256, 5986.491148252448, 5993.670348130808, 6001.489873360726, 6004.729787159588, 6009.519238460913, 6465.741370345228, 6499.512536559682, 6590.7693230736695, 6591.373819487237, 6594.835129121714, 6741.056252124608, 6750.1562304711915, 6816.488763342769, 6835.760748373783, 6857.588544687334, 6362.204724409449, 6488.2538508072175, 6500.609963402211, 6508.121403610641, 6592.110065141144, 6632.436242919406, 6637.1703537057865, 6681.398674119158, 6686.3313668632745, 6709.865802684017, 6766.695498702668, 6773.390394864486, 6774.356436138559, 6806.217285012287, 6870.896936545856, 6364.490840732823, 6522.934770652422, 6546.345365463416, 6646.0, 6648.368405001517, 6501.1548498694865, 6538.0, 6622.503312251504, 6624.205095388585, 6644.667766611554, 6272.7804526843165, 6424.196975378078, 6435.356464353527, 6534.150560427114, 6556.639384833689, 6375.043743438521, 6462.806115816533, 6536.0, 6536.117624120873, 6537.771178008747, 6312.210973628296, 6352.237731472253, 6504.284528701934, 6515.446187073962, 6522.119513865568], "value": 6104.999575105456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.1194891593702, 851.2423942691004, 876.110747591195, 879.4195830751703, 1144.1361771862244, 31391.68608313916, 31809.204769880736, 31866.99999999997, 42859.78570107153, 43690.56309436905, 43483.56516434842, 44244.55755442445, 44267.11465770683, 44270.7786461068, 44498.33252501207, 7771.300582947533, 7772.378209743235, 7932.3257523110315, 7989.520628762264, 7999.720009799658, 7770.57261850598, 7856.450048496579, 7868.763937081897, 7870.2916737493615, 7872.724454644089, 7816.218378162195, 7866.567338796364, 7877.724279650213, 7878.527288362688, 7888.842223155562, 7726.690932362699, 7752.418568607349, 7755.72854950074, 7767.18444563324, 7807.492512986666, 7650.770476885702, 7713.190115037896, 7732.690692372298, 7773.727919522789, 7820.374370050382, 39474.407883881766, 40146.197076058605, 40308.193836123115, 40308.59691403078, 40315.395269070985, 3488.6860182583437, 3524.1189702574356, 3525.312564050011, 3527.805970671612, 3531.841067151984, 30965.535516967262, 31071.0, 31164.688353116406, 31242.37515249682, 31272.530912036338, 4865.124277630025, 4989.925151122736, 5032.2703208035, 5041.798328066873, 5052.646314757969, 188759.0, 188881.0, 188925.0, 189199.05400473048, 189366.0, 47926.760366197945, 48388.0, 48528.7573562137, 48536.27195591998, 48609.5139048612, 49884.0, 50599.74700126476, 50668.49331506711, 50791.492085079415, 51031.0, 14544.85455145435, 14868.70262594742, 16138.273777680033, 16466.42367517131, 16476.588085297724, 13442.529511467248, 13653.522126725517, 13673.726525469436, 13686.31568421575, 13687.589372318846, 14399.856001440061, 14404.85595144056, 14460.421583136556, 14557.199354035629, 14724.263786810616, 5852.414758524199, 5860.355360910296, 5875.353711091777, 5974.402559744078, 6004.219451471368, 957.9952100239454, 977.2768151567931, 983.6606370802061, 989.2333441582831, 998.5306905754284, 22811.31566053021, 22973.540529189322, 22975.0, 22990.195343162908, 23168.768312317, 1064.9520771565299, 1086.6359769477156, 1090.2477290669572, 1091.7106966653844, 1108.6175269531998, 11998.280103193836, 12027.27836329823, 12102.636920892388, 12118.515259389702, 12133.453994570265, 226215.0, 227272.0, 227410.0, 227749.0, 228382.0, 54851.0, 55034.72482637561, 55064.44935550593, 55125.0, 55315.0, 1388.4931999819994, 1426.7360538300447, 1432.8925330600246, 1447.507847331891, 1454.9636259093395, 22447.551048978603, 22875.542489150455, 22933.54132917366, 22961.0, 23359.0, 37390.62609373871, 37439.62560374361, 37507.624923750416, 37527.81236093911, 37559.812200939916, 195450.0, 197164.0, 198236.0, 198568.0, 198829.0, 34100.0, 35781.64218357783, 36446.635533645385, 36466.453003205505, 36631.633683662825, 47948.760256199894, 48713.5128648709, 48836.2674559889, 48870.02259954852, 48884.51115488942, 35156.82421587978, 35260.294794104484, 35277.0, 35562.82218588891, 35636.28727425385, 34180.31639367149, 34458.62165513451, 34532.30935381329, 34865.30269394648, 34872.82563587166, 37282.0, 37746.81126594349, 37991.62008379881, 38036.42945355877, 38108.23783524369, 33457.33085338231, 33687.0, 33760.0, 34070.65929340675, 34166.14584635404, 24671.50656986886, 24723.62914556247, 24776.380590485383, 24992.62511062299, 25523.74476255288], "value": 17436.175971665394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4703502225419, 573.9971300143499, 576.3919065386016, 586.9295684517857, 593.5518683394038, 22215.666764998517, 23057.654135187942, 23174.88412557937, 23194.88402557989, 23206.767932320672, 26775.86612066937, 27245.45509089817, 27407.451850962967, 27461.588076178872, 27504.0, 6459.903101453482, 6624.171978502687, 6631.137952066225, 6633.800985970404, 6640.900386494206, 6027.939720602782, 6295.338989406115, 6558.508111891627, 6561.114249576318, 6576.210854697443, 6542.247641521215, 6546.050822630739, 6546.116274302955, 6552.639604821733, 6553.3446655334565, 6490.837729056764, 6500.902486462707, 6526.28210896801, 6536.575122617039, 6547.934520654804, 6040.395960403925, 6079.0, 6083.7870674526175, 6094.146819445281, 6097.57316987811, 28918.0, 29457.852710736523, 29858.253543661584, 30006.399872002658, 30504.8474757627, 1886.1889387563342, 1908.5324095596668, 1911.1017821623955, 1922.7884932657396, 1923.8653294269407, 19631.116599753044, 20385.4903627409, 20398.490037749027, 20436.38690839277, 20464.38606841797, 2369.597168481362, 2382.6545150953016, 2418.9758102418928, 2427.053449154831, 2477.95044099117, 134833.3258333702, 138701.30649346788, 138807.0, 141027.29486352604, 141812.58187418096, 14139.0, 15361.692766144615, 15552.0, 15584.298706558233, 16092.436764713178, 22805.771942280695, 24083.277501674977, 24206.51586968251, 24331.635025474632, 24577.0, 10717.89282107169, 10722.73193170177, 10748.677539673823, 10913.39976301311, 11082.667519974413, 10111.393316400892, 10134.391936483835, 10136.18910487174, 10139.695809125738, 10154.898451015542, 9572.0, 9672.614584895231, 9811.803763924681, 9834.213262938947, 9842.60629574809, 2801.411703542279, 2805.228562145426, 2805.7054009329136, 2831.150654803551, 2943.1464875186384, 945.3146468810195, 965.8068386322623, 974.6101559376306, 975.439297124595, 980.1374790184734, 20330.79669203289, 20499.69250461244, 20705.68941465879, 24981.00075996976, 26020.73979260183, 1036.2435422141878, 1036.3988886445843, 1058.3279617442824, 1062.7661914378825, 1063.728749168957, 11226.21416500837, 11284.266522676, 11345.773084538263, 11557.653270401901, 11563.537458501734, 525465.0, 548486.0, 550862.0, 554428.0, 555422.0, 132030.33984830015, 132359.0, 133577.3321133388, 138409.3079534616, 139111.99999999796, 1239.4918083585867, 1328.2960031183488, 1330.7072444062292, 1335.3923964596086, 1339.1161833190047, 21383.25158619503, 21594.244201452875, 21997.450063748533, 22028.559428811655, 22174.223902163347, 56920.430795691515, 57657.711711441174, 60253.69873150606, 60451.0, 63502.36497634964, 71946.0, 72949.27050729425, 73440.0, 73837.26162738304, 73959.26040739524, 20360.490987725425, 20654.483637909172, 20802.167913283298, 20971.8951405242, 21098.57802843904, 23831.64252536248, 24073.51852962966, 24118.276451706475, 24154.913028914092, 24220.39449013789, 18747.250109995446, 18838.3406580769, 19028.809711903257, 19120.80879191246, 19278.614427711087, 16779.412720554723, 16963.151842407584, 17372.13139343053, 17670.0, 17801.73297400566, 18460.630787384445, 19144.71282930785, 19288.8071119287, 19294.22823087061, 19508.414747557596, 20090.0, 20709.689354659993, 21232.0, 21249.468763280423, 21486.462838429165, 18870.71693924565, 19156.32952846644, 19197.136128873954, 19290.324838630582, 19501.902490487457], "value": 12691.042489971325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.088070992435, 1412.2091628687929, 1414.8302203735552, 1419.0775995602853, 1421.6303761022139, 13574.660633484167, 14171.858281417195, 14184.929075354608, 14202.289885505736, 14208.147511149313, 13956.44174233032, 14340.569782906503, 14719.484818031371, 14804.777928331083, 14829.110253384804, 2666.0668765931914, 2744.2316151477517, 2744.945101097977, 2749.6562929633797, 2756.186924857172, 2601.908933187339, 2624.868756562174, 2678.6919504256966, 2693.4478431921507, 2727.1818454463682, 2632.697239817426, 2662.254568720761, 2663.4273631169294, 2665.4802313548867, 2667.1198504493473, 2560.0655760647323, 2603.0498867913266, 2604.6874375075017, 2610.6475625790467, 2622.357522407003, 2568.4221050263727, 2571.9228423147338, 2607.8044146689076, 2616.123598594454, 2617.149426436416, 13721.519746808814, 14043.297835108204, 14056.297185140702, 14058.086224395483, 14064.156150630995, 7378.704851805921, 7645.770626881147, 7655.157932627407, 7658.8468230635635, 7665.271799179125, 4923.138450771136, 4952.281919121743, 5036.974815125937, 5076.847694569132, 5077.339945807058, 1745.1797655102082, 1756.9033703146322, 1768.0982698823564, 1786.8749187556875, 1810.8822926509736, 23377.649335259986, 23555.528889422116, 23624.17315393953, 23646.881765591235, 23651.881740591187, 6012.338642749294, 6137.7851775187655, 6318.304986451487, 6323.0, 6389.297177310492, 15519.379224831106, 16083.678326433639, 16115.113668748332, 16206.513804585882, 16483.175841207893, 7261.636918154177, 7566.3190312871, 7569.243075692497, 7570.432217583703, 7572.962135189288, 6843.863122737517, 7003.439724822002, 7009.0537777399395, 7139.643017849191, 7194.38847697941, 5115.38615366151, 5282.630215884851, 5298.6290959633225, 5355.785768569213, 5370.62405631602, 1498.715244103617, 1501.0693370110382, 1502.4290769507518, 1505.8343582205948, 1520.4222395489644, 855.781775647206, 869.3219288954625, 885.7431344909904, 890.9198172164537, 893.946363218209, 7248.601326926964, 7285.562866228043, 8706.956465217634, 9062.0, 9104.681336153202, 959.4818797849223, 962.711186644018, 982.8476586129161, 989.2728844299434, 996.367306760198, 4878.0975519529, 5278.419373868871, 5647.1529270609735, 5669.092945128842, 5740.253767010346, 18827.623447530972, 19222.0, 19691.60616787685, 19755.50611234702, 19808.70286945697, 19013.90493047526, 19042.0, 19103.904480477508, 19117.330893418664, 19305.227790888206, 9946.154576861049, 10622.468876556295, 10711.357318560911, 10783.730406739895, 10933.0, 7832.84334313322, 8270.19224525878, 8355.373346998878, 8498.150184981452, 8756.25571826402, 16804.24380902838, 17238.827611723722, 17441.127943603024, 17554.122293885, 17606.911965440602, 17459.38892138769, 17528.474145775646, 17699.849509781823, 18118.818811811714, 18214.089295535436, 11426.314421134759, 11502.53989840397, 11735.941320293345, 11736.295822250693, 11747.588834391097, 12798.61604151877, 12914.806277906027, 13106.082574220094, 13159.47362105505, 13189.670258243237, 10514.789704206027, 10668.679939601825, 10668.83996740034, 10829.133669306595, 10943.28868623537, 10340.844887326846, 10455.738606534898, 10598.31110977784, 10780.514876830404, 10835.458227088771, 8941.150590693873, 9479.668211612561, 9540.570674319533, 9576.180525700094, 9577.664781732607, 7220.3140701633265, 7317.487775855639, 7326.450516211199, 7421.628918554159, 7425.591592462466, 7255.09311336083, 7371.741989030358, 7374.778756637309, 7424.331810137113, 7479.962600186965], "value": 6427.0186402587915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.9086273608013, 484.80607756897234, 487.2690963554668, 496.0871995528227, 496.5456607204406, 6079.2097027386435, 6159.969200154004, 6166.132748272053, 6173.876522469548, 6223.471004964584, 5987.610805297652, 6014.827108713803, 6027.0, 6030.427109424598, 6032.909506357408, 4877.8780530486665, 4887.608991280698, 4888.706677599338, 4896.804127834882, 4910.435299940516, 4762.809487620491, 4848.127337079324, 4882.487338829425, 4883.462819089915, 4885.557221389306, 4844.66087373884, 4853.199222128344, 4867.829625963092, 4872.171730805754, 4880.609551235911, 4835.443923948756, 4841.443234028096, 4843.4813896773485, 4853.417589889201, 4873.951260487385, 4313.525512193656, 4342.869713908588, 4349.913001739979, 4357.520672725997, 4363.192809330284, 5844.707764611752, 5919.881602367972, 5996.640201587918, 6010.78962236324, 6026.186464827236, 5501.697406642633, 5514.0, 5543.695096769676, 5558.610897237195, 5568.972155139239, 6315.336889626615, 6378.489720822323, 6415.326390728999, 6416.422521973045, 6425.0, 4702.130105930414, 4737.341930324394, 4748.311494833264, 4751.287306903958, 4759.190937540627, 6454.903176452357, 6458.451031662267, 6567.57863614113, 6694.49791265657, 6824.1128653275255, 4658.1848176568965, 4760.357351757538, 4795.304680821261, 4800.591949684246, 4823.649378174046, 4851.805927762921, 4874.8781280467565, 4887.120318342732, 4887.780049897763, 4940.876478088005, 5480.342358916955, 5508.3114610673665, 5521.3926468089285, 5535.58483113768, 5553.861153471114, 6450.645214513153, 6486.902696459557, 6510.641914694643, 6518.380753828379, 6555.345704549728, 1708.2654458582929, 1721.7933847938077, 1722.3627257914652, 1728.395061728385, 1729.0749449044952, 1131.3947038334452, 1174.9177557571059, 1178.8585369755513, 1188.120790614956, 1193.76721539299, 5673.659580425187, 5701.885962280731, 5712.371639119693, 5750.079987202028, 5770.653760774367, 6431.5819471734185, 6544.411003009752, 6632.701528431232, 6634.834129146713, 6677.799666010027, 5618.494335509824, 5638.915416268759, 5660.094384898479, 5683.346415162227, 5720.456556627114, 3432.4508078707286, 3520.4543295789194, 3529.1882866940746, 3543.3976224041976, 3548.2016546277396, 6337.65142917144, 6348.523860710373, 6354.936450635527, 6376.489880809524, 6382.521310901701, 6811.148606424197, 6812.727490900407, 6828.5902845829405, 6856.211535673461, 6860.5197636164985, 6316.778912738124, 6374.74501019954, 6389.201349831271, 6411.6153030818305, 6443.838904027437, 6620.867582648224, 6622.251765517256, 6631.834204144935, 6672.999050142517, 6693.230278518033, 6517.641529715911, 6531.314212007861, 6547.541672082908, 6560.245571759118, 6570.145881035435, 6356.364363563792, 6359.395857393541, 6374.776882809079, 6396.200474940632, 6424.261209960914, 4796.160671882337, 4829.589484893823, 4835.95164048369, 4853.223484242504, 4872.951270487391, 6275.560710750204, 6413.8717225656155, 6550.0, 6613.305602911625, 6663.13379260693, 6295.338989406229, 6308.0, 6309.779157729457, 6326.177596912372, 6365.936340636535, 6259.530535209787, 6300.338464461165, 6338.778142764981, 6392.328805475358, 6422.389872962061, 6186.19579454668, 6289.119523266655, 6348.508100596264, 6349.714262858275, 6375.0, 6421.5825971311715, 6435.903461447989, 6452.290248072803, 6502.73989040452, 6503.106117777733, 6234.0, 6234.688265586793, 6259.12372267892, 6260.686965651608, 6271.3415091414745], "value": 4936.2824248004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.8236352729456, 906.5150144672601, 910.5265262063731, 911.9544022798858, 922.6816748221863, 18645.62708745826, 19515.804841951576, 19750.90124549377, 19765.50586235343, 22305.55388892221, 21120.894395528, 21917.452063698416, 22048.44878878025, 22069.337919862388, 22172.667409988862, 1025.4718819807786, 1060.2631171335925, 1061.8885017073212, 1063.643679367413, 1067.3862529045791, 1020.1226944827442, 1049.3546468921597, 1050.049705016957, 1050.994745026274, 1051.7686109055996, 1105.4748994227757, 1119.1941801902617, 1120.1822669451306, 1120.383788916097, 1121.1031175059961, 1088.5917780832187, 1095.769888323453, 1098.7967226063163, 1100.9174311926558, 1100.9889901100967, 807.9636416361219, 809.0897740042452, 809.8663720486113, 810.9594520274022, 811.2495941254375, 16083.758743618739, 16385.262663180187, 16746.832531674772, 17084.0, 17311.220995055253, 21205.681914771292, 21322.573548528944, 21339.35981920545, 21784.891075544678, 21796.891015544978, 15830.0, 15914.840851591453, 16132.59668508285, 16140.838591614169, 16159.353625854952, 3619.1314084619503, 3627.2745450909924, 3672.2839046385966, 3683.336999340118, 3685.0, 122210.0, 127365.0, 128560.0, 129633.35183324023, 130841.34579327042, 17067.40264090751, 17427.56431089233, 17471.475855724348, 17474.301027958994, 17488.213030413663, 29609.851950740107, 31785.205369865474, 31972.68027319697, 32140.0, 32233.67766322307, 7530.322270995636, 7785.922140778633, 7787.454878158588, 8078.313343365762, 8186.959065204635, 3767.3595488766973, 3942.0539070623418, 3946.7631942083567, 3988.0, 4014.959850401517, 5321.9622173676535, 5490.670559766427, 5504.119340905436, 5515.310586176728, 5518.558515318845, 853.5007020892847, 875.8248350329832, 879.5909901895521, 881.0792721605937, 892.3307519360479, 661.256086902235, 674.4570620650326, 678.176016140382, 680.4658343200663, 688.1054628982403, 11488.77022459546, 11729.237599556001, 11958.521659133712, 12662.303573303372, 12814.615561533168, 664.139938779282, 666.8399584099781, 672.1732269308679, 685.3420716112588, 690.5614934516618, 5395.919061214085, 5435.456454354533, 5516.200150978086, 6002.189704389939, 6421.903671444932, 98440.50779746055, 98735.0, 102906.0, 104070.47964760127, 104304.0, 89291.0, 90237.54881225553, 91851.0, 93914.53042734879, 94364.0, 78522.21477785263, 81686.59156704179, 83000.58499707463, 83044.99999999879, 83254.16745832586, 12726.300053497147, 12935.547255846, 12997.285149316878, 13003.869961300266, 13128.737425251633, 36187.81906090453, 36739.63260367362, 36901.63098368982, 37089.814550927076, 39104.2179156421, 47746.76126619345, 48031.75984120057, 67078.0, 68172.31827681858, 71171.28828711646, 17704.91147544254, 17712.2029508675, 17713.645727085128, 17952.192151353483, 17968.91015544914, 16603.88613873307, 19045.90477047606, 19060.0, 21114.15543378309, 21830.345089647337, 19553.0, 19856.801431986074, 20227.494312642302, 20371.59256814885, 20548.38354849357, 18948.147333370307, 19412.611747764684, 19477.123529440927, 19528.0, 20095.799042009392, 16913.0, 17204.13979301055, 17356.39252626152, 17490.387836425663, 19945.900270499136, 12897.290649014394, 13576.0, 14006.509772157926, 14008.649783755487, 14422.278886055445, 14384.208868512333, 14550.5634830951, 14723.779143312644, 14797.260136992893, 14934.402623894923], "value": 9099.615714594216, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 102.0, 108.0, 108.0, 108.0, 107.0, 98.0, 109.0, 107.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 153.0, 173.0, 121.0, 155.0, 145.0, 123.0, 186.0, 121.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 163.0, 163.0, 164.0, 166.0, 167.0, 168.0, 163.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 174.0, 82.0, 75.0, 76.0, 85.0, 101.0, 77.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 136.0, 79.0, 80.0, 80.0, 131.0, 79.0, 79.0, 139.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 117.0, 114.0, 114.0, 114.0, 113.0, 114.0, 116.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 152.0, 152.0, 150.0, 153.0, 153.0, 151.0, 150.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 95.0, 99.0, 94.0, 93.0, 99.0, 98.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 55.0, 60.0, 64.0, 55.0, 54.0, 55.0, 56.0, 54.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 56.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 78.0, 78.0, 89.0, 77.0, 88.0, 86.0, 79.0, 77.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 133.0, 135.0, 127.0, 130.0, 132.0, 124.0, 130.0, 157.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 173.0, 171.0, 179.0, 172.0, 173.0, 189.0, 174.0, 185.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 66.0, 73.0, 71.0, 70.0, 66.0, 66.0, 66.0, 65.0], "value": 68.5, "unit": "score"}]}]} 13:04:08 INFO - Return code: 0 13:04:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:04:08 INFO - # TBPL SUCCESS # 13:04:08 INFO - Running post-action listener: _package_coverage_data 13:04:08 INFO - Running post-action listener: _resource_record_post_action 13:04:08 INFO - [mozharness: 2017-08-07 20:04:08.562652Z] Finished run-tests step (success) 13:04:08 INFO - Running post-run listener: _resource_record_post_run 13:04:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 6270976; Write bytes: 440004608; Read time: 2624; Write time: 394224 13:04:08 INFO - TinderboxPrint: CPU usage
13.2% 13:04:08 INFO - TinderboxPrint: I/O read bytes / time
6,270,976 / 2,624 13:04:08 INFO - TinderboxPrint: I/O write bytes / time
440,004,608 / 394,224 13:04:08 INFO - TinderboxPrint: CPU idle
8,271.3 (86.8%) 13:04:08 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 13:04:08 INFO - TinderboxPrint: Swap in / out
0 / 0 13:04:08 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 222380032; Read time: 64; Write time: 267908 13:04:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:04:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4050944; Write bytes: 169836544; Read time: 2192; Write time: 43400 13:04:09 INFO - Running post-run listener: _upload_blobber_files 13:04:09 INFO - Blob upload gear active. 13:04:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:04: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 13:04: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'] 13:04: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 13:04:09 INFO - (blobuploader) - INFO - Open directory for files ... 13:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:10 INFO - (blobuploader) - INFO - Done attempting. 13:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:04:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:17 INFO - (blobuploader) - INFO - Done attempting. 13:04:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:04:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:04:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:18 INFO - (blobuploader) - INFO - Done attempting. 13:04:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:04:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:04:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:19 INFO - (blobuploader) - INFO - Done attempting. 13:04:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:04:19 INFO - Return code: 0 13:04:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:04:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:04:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed7acf9df749a017d6d5746f8dcef45249250def7832f400dc6a65a7df4ada2fdee1060705207fdbe71cfbfa74b9b475a635acf8877966a203ad0ccf8ef6ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98bb5e1053bf404ec973a7e448db4c870a75db0db9b53335b7b4660539d1808dc051e56c9358a2eed13585a45c8ac96beb748c00e8285306f599db48eb34bf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f075d9bc73cbfcfb22f74a40cbba2204742287852eebac19fd9b89303e8556e77c4c058d68ca5424c07742b6c07e83b726a8b51da43e25e2cb061344f90b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f33c0ffda795fa4d56dec07888f18db0757317bdbe8683a92b958b565a9ef49bd82be37f958bce64b539144ed2d16299dd26a1d842fd80035c47878fdb73e3"} 13:04:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:04:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:04:19 INFO - Contents: 13:04:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed7acf9df749a017d6d5746f8dcef45249250def7832f400dc6a65a7df4ada2fdee1060705207fdbe71cfbfa74b9b475a635acf8877966a203ad0ccf8ef6ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98bb5e1053bf404ec973a7e448db4c870a75db0db9b53335b7b4660539d1808dc051e56c9358a2eed13585a45c8ac96beb748c00e8285306f599db48eb34bf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f075d9bc73cbfcfb22f74a40cbba2204742287852eebac19fd9b89303e8556e77c4c058d68ca5424c07742b6c07e83b726a8b51da43e25e2cb061344f90b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f33c0ffda795fa4d56dec07888f18db0757317bdbe8683a92b958b565a9ef49bd82be37f958bce64b539144ed2d16299dd26a1d842fd80035c47878fdb73e3"} 13:04:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:04:19 INFO - Copying logs to upload dir... 13:04:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:04:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.989982 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-07 13:04:19.111550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 13:04:19.115573) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291 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/8ed7acf9df749a017d6d5746f8dcef45249250def7832f400dc6a65a7df4ada2fdee1060705207fdbe71cfbfa74b9b475a635acf8877966a203ad0ccf8ef6ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98bb5e1053bf404ec973a7e448db4c870a75db0db9b53335b7b4660539d1808dc051e56c9358a2eed13585a45c8ac96beb748c00e8285306f599db48eb34bf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f075d9bc73cbfcfb22f74a40cbba2204742287852eebac19fd9b89303e8556e77c4c058d68ca5424c07742b6c07e83b726a8b51da43e25e2cb061344f90b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f33c0ffda795fa4d56dec07888f18db0757317bdbe8683a92b958b565a9ef49bd82be37f958bce64b539144ed2d16299dd26a1d842fd80035c47878fdb73e3"} build_url:https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/eQ_3dHouQGmbtpzvbd4Udw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed7acf9df749a017d6d5746f8dcef45249250def7832f400dc6a65a7df4ada2fdee1060705207fdbe71cfbfa74b9b475a635acf8877966a203ad0ccf8ef6ca3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f98bb5e1053bf404ec973a7e448db4c870a75db0db9b53335b7b4660539d1808dc051e56c9358a2eed13585a45c8ac96beb748c00e8285306f599db48eb34bf", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31f075d9bc73cbfcfb22f74a40cbba2204742287852eebac19fd9b89303e8556e77c4c058d68ca5424c07742b6c07e83b726a8b51da43e25e2cb061344f90b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f33c0ffda795fa4d56dec07888f18db0757317bdbe8683a92b958b565a9ef49bd82be37f958bce64b539144ed2d16299dd26a1d842fd80035c47878fdb73e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 13:04:19.140709) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 13:04:19.141071) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502134471.585224-856269291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 13:04:19.222866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 13:04:19.223187) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 13:04:19.223475) ========= ========= Total master_lag: 0.20 =========