builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-088 starttime: 1502794178.33 results: success (0) revision: 564e82f0f289af976da01c2d50507017bbc152b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.333208) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.336300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.336617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.367165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.367458) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 03:49:38-- 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% 46.2M=0s 2017-08-15 03:49:38 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.519533) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.519851) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014121 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.570225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:38.573600) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 564e82f0f289af976da01c2d50507017bbc152b5 --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 564e82f0f289af976da01c2d50507017bbc152b5 --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=9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 03:49:38,793 truncating revision to first 12 chars 2017-08-15 03:49:38,793 Setting DEBUG logging. 2017-08-15 03:49:38,793 attempt 1/10 2017-08-15 03:49:38,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/564e82f0f289?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 03:49:39,234 unpacking tar archive at: mozilla-central-564e82f0f289/testing/mozharness/ program finished with exit code 0 elapsedTime=0.750972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:39.339222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:39.342582) ========= script_repo_revision: 564e82f0f289af976da01c2d50507017bbc152b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:39.342958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:39.343229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 03:49:39.355576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-15 03:49:39.355868) ========= /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=9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:39 INFO - MultiFileLogger online at 20170815 03:49:39 in /builds/slave/test 03:49:39 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 03:49:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:39 INFO - {'append_to_log': False, 03:49:39 INFO - 'base_work_dir': '/builds/slave/test', 03:49:39 INFO - 'blob_upload_branch': 'Firefox', 03:49:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:39 INFO - 'branch': 'Firefox', 03:49:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:39 INFO - 'code_coverage': False, 03:49:39 INFO - 'config_files': ('talos/linux_config.py',), 03:49:39 INFO - 'default_actions': ('clobber', 03:49:39 INFO - 'read-buildbot-config', 03:49:39 INFO - 'download-and-extract', 03:49:39 INFO - 'populate-webroot', 03:49:39 INFO - 'create-virtualenv', 03:49:39 INFO - 'install', 03:49:39 INFO - 'setup-mitmproxy', 03:49:39 INFO - 'run-tests'), 03:49:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:39 INFO - 'disable_ccov_upload': False, 03:49:39 INFO - 'download_minidump_stackwalk': True, 03:49:39 INFO - 'download_symbols': 'ondemand', 03:49:39 INFO - 'enable_stylo': False, 03:49:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:39 INFO - 'gecko_profile': False, 03:49:39 INFO - 'gecko_profile_interval': 0, 03:49:39 INFO - 'installer_path': 'installer.exe', 03:49:39 INFO - 'log_level': 'info', 03:49:39 INFO - 'log_name': 'talos', 03:49:39 INFO - 'log_to_console': True, 03:49:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:39 INFO - 'opt_config_files': (), 03:49:39 INFO - 'pip_index': False, 03:49:39 INFO - 'suite': 'dromaeojs-e10s', 03:49:39 INFO - 'system_bits': '32', 03:49:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:39 INFO - 'title': 'talos-linux64-ix-088', 03:49:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:39 INFO - 'use_talos_json': True, 03:49:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:39 INFO - 'work_dir': 'build'} 03:49:39 INFO - [mozharness: 2017-08-15 10:49:39.683123Z] Running clobber step. 03:49:39 INFO - Running pre-action listener: _resource_record_pre_action 03:49:39 INFO - Running main action method: clobber 03:49:39 INFO - rmtree: /builds/slave/test/build 03:49:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:40 INFO - Running post-action listener: _resource_record_post_action 03:49:40 INFO - [mozharness: 2017-08-15 10:49:40.694338Z] Finished clobber step (success) 03:49:40 INFO - [mozharness: 2017-08-15 10:49:40.694441Z] Running read-buildbot-config step. 03:49:40 INFO - Running pre-action listener: _resource_record_pre_action 03:49:40 INFO - Running main action method: read_buildbot_config 03:49:40 INFO - Using buildbot properties: 03:49:40 INFO - { 03:49:40 INFO - "project": "", 03:49:40 INFO - "product": "firefox", 03:49:40 INFO - "who": "cbook@mozilla.com", 03:49:40 INFO - "installer_path": "public/build/target.tar.bz2", 03:49:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:49:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:49:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:49:40 INFO - "stage_platform": "linux64-pgo", 03:49:40 INFO - "basedir": "/builds/slave/test", 03:49:40 INFO - "buildnumber": 114, 03:49:40 INFO - "platform": "ubuntu64_hw", 03:49:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:49:40 INFO - "slavebuilddir": "test", 03:49:40 INFO - "taskId": "XTXcZv5nSh-NXjFUl1dqPg", 03:49:40 INFO - "branch": "mozilla-central", 03:49:40 INFO - "script_repo_revision": "production", 03:49:40 INFO - "revision": "564e82f0f289af976da01c2d50507017bbc152b5", 03:49:40 INFO - "slavename": "talos-linux64-ix-088", 03:49:40 INFO - "repo_path": "mozilla-central" 03:49:40 INFO - } 03:49:40 INFO - Finding installer, test and symbols from parent task. 03:49:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XTXcZv5nSh-NXjFUl1dqPg'}, attempt #1 03:49:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XTXcZv5nSh-NXjFUl1dqPg'}, attempt #1 03:49:41 INFO - Task dependencies: dPeEm1b8QimBX70wkiHc0w 03:49:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w'}, attempt #1 03:49:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2 03:49:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.test_packages.json 03:49:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.crashreporter-symbols.zip 03:49:42 INFO - Running post-action listener: _resource_record_post_action 03:49:42 INFO - [mozharness: 2017-08-15 10:49:42.034515Z] Finished read-buildbot-config step (success) 03:49:42 INFO - [mozharness: 2017-08-15 10:49:42.034737Z] Running download-and-extract step. 03:49:42 INFO - Running pre-action listener: _resource_record_pre_action 03:49:42 INFO - Running main action method: download_and_extract 03:49:42 INFO - mkdir: /builds/slave/test/build/tests 03:49:42 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')]} 03:49:42 INFO - trying https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.test_packages.json 03:49:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:49:42 INFO - Downloaded 989 bytes. 03:49:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:49:42 INFO - Using the following test package requirements: 03:49:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:49:42 INFO - u'common': [u'target.common.tests.zip'], 03:49:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:49:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:49:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:49:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:49:42 INFO - u'mozbase': [u'target.common.tests.zip'], 03:49:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:49:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:49:42 INFO - u'web-platform': [u'target.common.tests.zip', 03:49:42 INFO - u'target.web-platform.tests.tar.gz'], 03:49:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:49:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:49:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.common.tests.zip 03:49:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:49:42 INFO - Fetch https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.common.tests.zip into memory 03:49:45 INFO - Content-Length response header: 54619566 03:49:45 INFO - Bytes received: 54619566 03:49:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:49:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.common.tests.zip 03:49:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:49:55 INFO - Fetch https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.common.tests.zip into memory 03:49:57 INFO - Content-Length response header: 54619566 03:49:57 INFO - Bytes received: 54619566 03:50:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.talos.tests.zip 03:50:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:50:09 INFO - Fetch https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.talos.tests.zip into memory 03:50:09 INFO - Content-Length response header: 14496050 03:50:09 INFO - Bytes received: 14496050 03:50: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')]} 03:50:10 INFO - trying https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2 03:50:10 INFO - Downloading https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:50:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:50:11 INFO - Downloaded 62605756 bytes. 03:50:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2 03:50:11 INFO - mkdir: /builds/slave/test/properties 03:50:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:11 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:11 INFO - Contents: 03:50:11 INFO - build_url:https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2 03:50:11 INFO - Running post-action listener: _resource_record_post_action 03:50:11 INFO - Running post-action listener: set_extra_try_arguments 03:50:11 INFO - [mozharness: 2017-08-15 10:50:11.702789Z] Finished download-and-extract step (success) 03:50:11 INFO - [mozharness: 2017-08-15 10:50:11.702903Z] Running populate-webroot step. 03:50:11 INFO - Running pre-action listener: _resource_record_pre_action 03:50:11 INFO - Running main action method: populate_webroot 03:50:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:50:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:50:11 INFO - 'tests': ['damp', 'tps']}, 03:50:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:50:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:50:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:50:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:11 INFO - 'ts_paint', 03:50:11 INFO - 'tpaint', 03:50:11 INFO - 'sessionrestore', 03:50:11 INFO - 'sessionrestore_many_windows', 03:50:11 INFO - 'sessionrestore_no_auto_restore', 03:50:11 INFO - 'tabpaint']}, 03:50:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:50:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:50:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:11 INFO - 'tsvgr_opacity', 03:50:11 INFO - 'tart', 03:50:11 INFO - 'tscrollx', 03:50:11 INFO - 'tsvg_static']}, 03:50:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:50:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:11 INFO - 'talos_options': ['--mitmproxy', 03:50:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:11 INFO - '--firstNonBlankPaint'], 03:50:11 INFO - 'tests': ['tp6_google', 03:50:11 INFO - 'tp6_youtube', 03:50:11 INFO - 'tp6_amazon', 03:50:11 INFO - 'tp6_facebook']}, 03:50:11 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:11 INFO - 'talos_options': ['--stylo', 03:50:11 INFO - '--mitmproxy', 03:50:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:11 INFO - '--firstNonBlankPaint'], 03:50:11 INFO - 'tests': ['tp6_google', 03:50:11 INFO - 'tp6_youtube', 03:50:11 INFO - 'tp6_amazon', 03:50:11 INFO - 'tp6_facebook']}, 03:50:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:11 INFO - 'talos_options': ['--stylo', 03:50:11 INFO - '--stylo-threads=1', 03:50:11 INFO - '--mitmproxy', 03:50:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:11 INFO - '--firstNonBlankPaint'], 03:50:11 INFO - 'tests': ['tp6_google', 03:50:11 INFO - 'tp6_youtube', 03:50:11 INFO - 'tp6_amazon', 03:50:11 INFO - 'tp6_facebook']}, 03:50:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:50:11 INFO - 'talos_options': ['--xperf_path', 03:50:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:11 INFO - 'tests': ['tp5n']}}} 03:50:11 INFO - Running post-action listener: _resource_record_post_action 03:50:11 INFO - [mozharness: 2017-08-15 10:50:11.712477Z] Finished populate-webroot step (success) 03:50:11 INFO - [mozharness: 2017-08-15 10:50:11.712567Z] Running create-virtualenv step. 03:50:11 INFO - Running pre-action listener: _resource_record_pre_action 03:50:11 INFO - Running main action method: create_virtualenv 03:50:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:11 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 03:50:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:50:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:11 INFO - Using real prefix '/usr' 03:50:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:14 INFO - Installing pip.................done. 03:50:14 INFO - Return code: 0 03:50:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:50:14 INFO - Reading from file tmpfile_stdout 03:50:14 INFO - Output received: 03:50:14 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) 03:50:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:50:14 INFO - Using env: {'DISPLAY': ':0', 03:50:14 INFO - 'HOME': '/home/cltbld', 03:50:14 INFO - 'LANG': 'en_US.UTF-8', 03:50:14 INFO - 'LANGUAGE': 'en_US:en', 03:50:14 INFO - 'LOGNAME': 'cltbld', 03:50:14 INFO - 'MAIL': '/var/mail/cltbld', 03:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:14 INFO - 'MOZ_NO_REMOTE': '1', 03:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:14 INFO - 'NO_EM_RESTART': '1', 03:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:14 INFO - 'PWD': '/builds/slave/test', 03:50:14 INFO - 'SHELL': '/bin/bash', 03:50:14 INFO - 'SHLVL': '1', 03:50:14 INFO - 'TERM': 'linux', 03:50:14 INFO - 'TMOUT': '86400', 03:50:14 INFO - 'USER': 'cltbld', 03:50:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:14 INFO - '_': '/tools/buildbot/bin/python'} 03:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:14 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 03:50:14 INFO - Cleaning up... 03:50:14 INFO - Return code: 0 03:50:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:50:14 INFO - Using env: {'DISPLAY': ':0', 03:50:14 INFO - 'HOME': '/home/cltbld', 03:50:14 INFO - 'LANG': 'en_US.UTF-8', 03:50:14 INFO - 'LANGUAGE': 'en_US:en', 03:50:14 INFO - 'LOGNAME': 'cltbld', 03:50:14 INFO - 'MAIL': '/var/mail/cltbld', 03:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:14 INFO - 'MOZ_NO_REMOTE': '1', 03:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:14 INFO - 'NO_EM_RESTART': '1', 03:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:14 INFO - 'PWD': '/builds/slave/test', 03:50:14 INFO - 'SHELL': '/bin/bash', 03:50:14 INFO - 'SHLVL': '1', 03:50:14 INFO - 'TERM': 'linux', 03:50:14 INFO - 'TMOUT': '86400', 03:50:14 INFO - 'USER': 'cltbld', 03:50:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:14 INFO - '_': '/tools/buildbot/bin/python'} 03:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:14 INFO - Downloading/unpacking psutil>=3.1.1 03:50:14 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 03:50:14 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 03:50:14 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 03:50:14 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 03:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:16 INFO - Installing collected packages: psutil 03:50:16 INFO - Running setup.py install for psutil 03:50:16 INFO - building 'psutil._psutil_linux' extension 03:50:16 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 03:50:16 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 03:50:16 INFO - building 'psutil._psutil_posix' extension 03:50:16 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 03:50:16 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 03:50:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:16 INFO - Successfully installed psutil 03:50:16 INFO - Cleaning up... 03:50:16 INFO - Return code: 0 03:50:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:50:16 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')]} 03:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:16 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')]} 03:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:16 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:16 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 03:50:16 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 03:50:16 INFO - Using env: {'DISPLAY': ':0', 03:50:16 INFO - 'HOME': '/home/cltbld', 03:50:16 INFO - 'LANG': 'en_US.UTF-8', 03:50:16 INFO - 'LANGUAGE': 'en_US:en', 03:50:16 INFO - 'LOGNAME': 'cltbld', 03:50:16 INFO - 'MAIL': '/var/mail/cltbld', 03:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:16 INFO - 'MOZ_NO_REMOTE': '1', 03:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:16 INFO - 'NO_EM_RESTART': '1', 03:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:16 INFO - 'PWD': '/builds/slave/test', 03:50:16 INFO - 'SHELL': '/bin/bash', 03:50:16 INFO - 'SHLVL': '1', 03:50:16 INFO - 'TERM': 'linux', 03:50:16 INFO - 'TMOUT': '86400', 03:50:16 INFO - 'USER': 'cltbld', 03:50:16 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:16 INFO - '_': '/tools/buildbot/bin/python'} 03:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:50:16 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 03:50:16 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 03:50:16 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 03:50:16 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 03:50:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:50:18 INFO - Installing collected packages: mozsystemmonitor 03:50:18 INFO - Running setup.py install for mozsystemmonitor 03:50:18 INFO - Successfully installed mozsystemmonitor 03:50:18 INFO - Cleaning up... 03:50:18 INFO - Return code: 0 03:50:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:50:18 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')]} 03:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:18 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')]} 03:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:18 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:18 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 03:50:18 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 03:50:18 INFO - Using env: {'DISPLAY': ':0', 03:50:18 INFO - 'HOME': '/home/cltbld', 03:50:18 INFO - 'LANG': 'en_US.UTF-8', 03:50:18 INFO - 'LANGUAGE': 'en_US:en', 03:50:18 INFO - 'LOGNAME': 'cltbld', 03:50:18 INFO - 'MAIL': '/var/mail/cltbld', 03:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:18 INFO - 'MOZ_NO_REMOTE': '1', 03:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:18 INFO - 'NO_EM_RESTART': '1', 03:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:18 INFO - 'PWD': '/builds/slave/test', 03:50:18 INFO - 'SHELL': '/bin/bash', 03:50:18 INFO - 'SHLVL': '1', 03:50:18 INFO - 'TERM': 'linux', 03:50:18 INFO - 'TMOUT': '86400', 03:50:18 INFO - 'USER': 'cltbld', 03:50:18 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:18 INFO - '_': '/tools/buildbot/bin/python'} 03:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:18 INFO - Downloading/unpacking jsonschema==2.5.1 03:50:18 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 03:50:18 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 03:50:18 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 03:50:18 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 03:50:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:50:19 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 03:50:19 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 03:50:19 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 03:50:19 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 03:50:19 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:19 INFO - warning: no files found matching '*.txt' 03:50:19 INFO - no previously-included directories found matching 'build' 03:50:19 INFO - no previously-included directories found matching 'dist' 03:50:19 INFO - no previously-included directories found matching '.git*' 03:50:19 INFO - Installing collected packages: jsonschema, functools32 03:50:19 INFO - Running setup.py install for functools32 03:50:19 INFO - warning: no files found matching '*.txt' 03:50:19 INFO - no previously-included directories found matching 'build' 03:50:19 INFO - no previously-included directories found matching 'dist' 03:50:19 INFO - no previously-included directories found matching '.git*' 03:50:19 INFO - Successfully installed jsonschema functools32 03:50:19 INFO - Cleaning up... 03:50:19 INFO - Return code: 0 03:50:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:50:19 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')]} 03:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:19 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')]} 03:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:19 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:19 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 03:50:19 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 03:50:19 INFO - Using env: {'DISPLAY': ':0', 03:50:19 INFO - 'HOME': '/home/cltbld', 03:50:19 INFO - 'LANG': 'en_US.UTF-8', 03:50:19 INFO - 'LANGUAGE': 'en_US:en', 03:50:19 INFO - 'LOGNAME': 'cltbld', 03:50:19 INFO - 'MAIL': '/var/mail/cltbld', 03:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:19 INFO - 'MOZ_NO_REMOTE': '1', 03:50:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:19 INFO - 'NO_EM_RESTART': '1', 03:50:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:19 INFO - 'PWD': '/builds/slave/test', 03:50:19 INFO - 'SHELL': '/bin/bash', 03:50:19 INFO - 'SHLVL': '1', 03:50:19 INFO - 'TERM': 'linux', 03:50:19 INFO - 'TMOUT': '86400', 03:50:19 INFO - 'USER': 'cltbld', 03:50:19 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:19 INFO - '_': '/tools/buildbot/bin/python'} 03:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:50:20 INFO - Cleaning up... 03:50:20 INFO - Return code: 0 03:50:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50:20 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')]} 03:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:20 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')]} 03:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:20 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:20 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 03:50:20 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 03:50:20 INFO - Using env: {'DISPLAY': ':0', 03:50:20 INFO - 'HOME': '/home/cltbld', 03:50:20 INFO - 'LANG': 'en_US.UTF-8', 03:50:20 INFO - 'LANGUAGE': 'en_US:en', 03:50:20 INFO - 'LOGNAME': 'cltbld', 03:50:20 INFO - 'MAIL': '/var/mail/cltbld', 03:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:20 INFO - 'MOZ_NO_REMOTE': '1', 03:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:20 INFO - 'NO_EM_RESTART': '1', 03:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:20 INFO - 'PWD': '/builds/slave/test', 03:50:20 INFO - 'SHELL': '/bin/bash', 03:50:20 INFO - 'SHLVL': '1', 03:50:20 INFO - 'TERM': 'linux', 03:50:20 INFO - 'TMOUT': '86400', 03:50:20 INFO - 'USER': 'cltbld', 03:50:20 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:20 INFO - '_': '/tools/buildbot/bin/python'} 03:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:20 INFO - Downloading/unpacking blobuploader==1.2.4 03:50:20 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 03:50:20 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 03:50:20 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 03:50:20 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 03:50:21 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:50:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 INFO - Downloading docopt-0.6.1.tar.gz 03:50:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:21 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:21 INFO - Running setup.py install for blobuploader 03:50:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:50:22 INFO - Running setup.py install for requests 03:50:22 INFO - Running setup.py install for docopt 03:50:22 INFO - Successfully installed blobuploader requests docopt 03:50:22 INFO - Cleaning up... 03:50:22 INFO - Return code: 0 03:50:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:22 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')]} 03:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:22 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')]} 03:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:22 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:22 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 03:50:22 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 03:50:22 INFO - Using env: {'DISPLAY': ':0', 03:50:22 INFO - 'HOME': '/home/cltbld', 03:50:22 INFO - 'LANG': 'en_US.UTF-8', 03:50:22 INFO - 'LANGUAGE': 'en_US:en', 03:50:22 INFO - 'LOGNAME': 'cltbld', 03:50:22 INFO - 'MAIL': '/var/mail/cltbld', 03:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:22 INFO - 'MOZ_NO_REMOTE': '1', 03:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:22 INFO - 'NO_EM_RESTART': '1', 03:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:22 INFO - 'PWD': '/builds/slave/test', 03:50:22 INFO - 'SHELL': '/bin/bash', 03:50:22 INFO - 'SHLVL': '1', 03:50:22 INFO - 'TERM': 'linux', 03:50:22 INFO - 'TMOUT': '86400', 03:50:22 INFO - 'USER': 'cltbld', 03:50:22 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:22 INFO - '_': '/tools/buildbot/bin/python'} 03:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:22 INFO - Running setup.py (path:/tmp/pip-epk_es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:22 INFO - Running setup.py (path:/tmp/pip-G51J9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:22 INFO - Running setup.py (path:/tmp/pip-DIznpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:23 INFO - Running setup.py (path:/tmp/pip-NDmtn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:23 INFO - Running setup.py (path:/tmp/pip-lxqeZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:23 INFO - Running setup.py (path:/tmp/pip-Gcj9ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:23 INFO - Running setup.py (path:/tmp/pip-r1RaBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:23 INFO - Running setup.py (path:/tmp/pip-bnO6FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:23 INFO - Running setup.py (path:/tmp/pip-CHj7i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:23 INFO - Running setup.py (path:/tmp/pip-oHhdKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:23 INFO - Running setup.py (path:/tmp/pip-Y_g8G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:23 INFO - Running setup.py (path:/tmp/pip-H8xgG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:23 INFO - Running setup.py (path:/tmp/pip-R5CVPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:23 INFO - Running setup.py (path:/tmp/pip-1pMUc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:23 INFO - Running setup.py (path:/tmp/pip-pxgW20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:23 INFO - Running setup.py (path:/tmp/pip-UyQRQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:23 INFO - Running setup.py (path:/tmp/pip-gCo3fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:24 INFO - Running setup.py install for manifestparser 03:50:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Running setup.py install for mozcrash 03:50:24 INFO - Running setup.py install for mozdebug 03:50:24 INFO - Running setup.py install for mozdevice 03:50:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Running setup.py install for mozfile 03:50:24 INFO - Running setup.py install for mozhttpd 03:50:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Running setup.py install for mozinfo 03:50:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Running setup.py install for mozInstall 03:50:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:24 INFO - Running setup.py install for mozleak 03:50:24 INFO - Running setup.py install for mozlog 03:50:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Running setup.py install for moznetwork 03:50:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Running setup.py install for mozprocess 03:50:25 INFO - Running setup.py install for mozprofile 03:50:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Running setup.py install for mozrunner 03:50:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Running setup.py install for mozscreenshot 03:50:25 INFO - Running setup.py install for moztest 03:50:25 INFO - Running setup.py install for mozversion 03:50:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:25 INFO - Cleaning up... 03:50:25 INFO - Return code: 0 03:50:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:25 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')]} 03:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:25 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')]} 03:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:25 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:25 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 03:50:25 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 03:50:25 INFO - Using env: {'DISPLAY': ':0', 03:50:25 INFO - 'HOME': '/home/cltbld', 03:50:25 INFO - 'LANG': 'en_US.UTF-8', 03:50:25 INFO - 'LANGUAGE': 'en_US:en', 03:50:25 INFO - 'LOGNAME': 'cltbld', 03:50:25 INFO - 'MAIL': '/var/mail/cltbld', 03:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:25 INFO - 'MOZ_NO_REMOTE': '1', 03:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:25 INFO - 'NO_EM_RESTART': '1', 03:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:25 INFO - 'PWD': '/builds/slave/test', 03:50:25 INFO - 'SHELL': '/bin/bash', 03:50:25 INFO - 'SHLVL': '1', 03:50:25 INFO - 'TERM': 'linux', 03:50:25 INFO - 'TMOUT': '86400', 03:50:25 INFO - 'USER': 'cltbld', 03:50:25 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:25 INFO - '_': '/tools/buildbot/bin/python'} 03:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:25 INFO - Running setup.py (path:/tmp/pip-yaHp1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:26 INFO - Running setup.py (path:/tmp/pip-qxgwtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:26 INFO - Running setup.py (path:/tmp/pip-2uAdGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:26 INFO - Running setup.py (path:/tmp/pip-wkncdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:26 INFO - Running setup.py (path:/tmp/pip-q3HOfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:26 INFO - Running setup.py (path:/tmp/pip-RFsTjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:26 INFO - Running setup.py (path:/tmp/pip-iZQlQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:26 INFO - Running setup.py (path:/tmp/pip-76d6NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:26 INFO - Running setup.py (path:/tmp/pip-zyEfo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:26 INFO - Running setup.py (path:/tmp/pip-cGGnNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:26 INFO - Running setup.py (path:/tmp/pip-Vl3IRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:26 INFO - Running setup.py (path:/tmp/pip-sw1vST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:26 INFO - Running setup.py (path:/tmp/pip-HwajWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:26 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)) 03:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:26 INFO - Running setup.py (path:/tmp/pip-M_zG3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:27 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)) 03:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:27 INFO - Running setup.py (path:/tmp/pip-y8osXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:27 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)) 03:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:27 INFO - Running setup.py (path:/tmp/pip-9d4Cxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:27 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)) 03:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:27 INFO - Running setup.py (path:/tmp/pip-azcf45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:27 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)) 03:50:27 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)) 03:50:27 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)) 03:50:27 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)) 03:50:27 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)) 03:50:27 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)) 03:50:27 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)) 03:50:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:27 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 03:50:27 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 03:50:27 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 03:50:27 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 03:50:28 INFO - Downloading blessings-1.6.tar.gz 03:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:28 INFO - Installing collected packages: blessings 03:50:28 INFO - Running setup.py install for blessings 03:50:28 INFO - Successfully installed blessings 03:50:28 INFO - Cleaning up... 03:50:28 INFO - Return code: 0 03:50:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:28 INFO - Reading from file tmpfile_stdout 03:50:28 INFO - Current package versions: 03:50:28 INFO - argparse == 1.2.1 03:50:28 INFO - blessings == 1.6 03:50:28 INFO - blobuploader == 1.2.4 03:50:28 INFO - docopt == 0.6.1 03:50:28 INFO - functools32 == 3.2.3-2 03:50:28 INFO - jsonschema == 2.5.1 03:50:28 INFO - manifestparser == 1.1 03:50:28 INFO - mozInstall == 1.13 03:50:28 INFO - mozcrash == 1.0 03:50:28 INFO - mozdebug == 0.1 03:50:28 INFO - mozdevice == 0.51 03:50:28 INFO - mozfile == 1.2 03:50:28 INFO - mozhttpd == 0.7 03:50:28 INFO - mozinfo == 0.10 03:50:28 INFO - mozleak == 0.1 03:50:28 INFO - mozlog == 3.5 03:50:28 INFO - moznetwork == 0.27 03:50:28 INFO - mozprocess == 0.25 03:50:28 INFO - mozprofile == 0.28 03:50:28 INFO - mozrunner == 6.13 03:50:28 INFO - mozscreenshot == 0.1 03:50:28 INFO - mozsystemmonitor == 0.3 03:50:28 INFO - moztest == 0.8 03:50:28 INFO - mozversion == 1.4 03:50:28 INFO - psutil == 3.1.1 03:50:28 INFO - requests == 1.2.3 03:50:28 INFO - wsgiref == 0.1.2 03:50:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:28 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:28 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 03:50:28 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 03:50:28 INFO - Using env: {'DISPLAY': ':0', 03:50:28 INFO - 'HOME': '/home/cltbld', 03:50:28 INFO - 'LANG': 'en_US.UTF-8', 03:50:28 INFO - 'LANGUAGE': 'en_US:en', 03:50:28 INFO - 'LOGNAME': 'cltbld', 03:50:28 INFO - 'MAIL': '/var/mail/cltbld', 03:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:28 INFO - 'MOZ_NO_REMOTE': '1', 03:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:28 INFO - 'NO_EM_RESTART': '1', 03:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:28 INFO - 'PWD': '/builds/slave/test', 03:50:28 INFO - 'SHELL': '/bin/bash', 03:50:28 INFO - 'SHLVL': '1', 03:50:28 INFO - 'TERM': 'linux', 03:50:28 INFO - 'TMOUT': '86400', 03:50:28 INFO - 'USER': 'cltbld', 03:50:28 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:28 INFO - '_': '/tools/buildbot/bin/python'} 03:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 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)) 03:50:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:50:29 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 03:50:29 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 03:50:29 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 03:50:29 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 03:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:50:30 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)) 03:50:30 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)) 03:50:30 INFO - Installing collected packages: simplejson 03:50:30 INFO - Running setup.py install for simplejson 03:50:30 INFO - building 'simplejson._speedups' extension 03:50:30 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 03:50:31 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 03:50:31 INFO - Successfully installed simplejson 03:50:31 INFO - Cleaning up... 03:50:31 INFO - Return code: 0 03:50:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50: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')]} 03:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:31 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 0x18c21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c2fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', '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 03:50:31 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 03:50:31 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 03:50:31 INFO - Using env: {'DISPLAY': ':0', 03:50:31 INFO - 'HOME': '/home/cltbld', 03:50:31 INFO - 'LANG': 'en_US.UTF-8', 03:50:31 INFO - 'LANGUAGE': 'en_US:en', 03:50:31 INFO - 'LOGNAME': 'cltbld', 03:50:31 INFO - 'MAIL': '/var/mail/cltbld', 03:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:31 INFO - 'MOZ_NO_REMOTE': '1', 03:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:31 INFO - 'NO_EM_RESTART': '1', 03:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:31 INFO - 'PWD': '/builds/slave/test', 03:50:31 INFO - 'SHELL': '/bin/bash', 03:50:31 INFO - 'SHLVL': '1', 03:50:31 INFO - 'TERM': 'linux', 03:50:31 INFO - 'TMOUT': '86400', 03:50:31 INFO - 'USER': 'cltbld', 03:50:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:31 INFO - '_': '/tools/buildbot/bin/python'} 03:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:31 INFO - Cleaning up... 03:50:31 INFO - Return code: 0 03:50:31 INFO - Running post-action listener: _resource_record_post_action 03:50:31 INFO - Running post-action listener: _start_resource_monitoring 03:50:31 INFO - Starting resource monitoring. 03:50:31 INFO - [mozharness: 2017-08-15 10:50:31.695690Z] Finished create-virtualenv step (success) 03:50:31 INFO - [mozharness: 2017-08-15 10:50:31.696159Z] Running install step. 03:50:31 INFO - Running pre-action listener: _resource_record_pre_action 03:50:31 INFO - Running main action method: install 03:50:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:31 INFO - Reading from file tmpfile_stdout 03:50:31 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:32 INFO - Reading from file tmpfile_stdout 03:50:32 INFO - Output received: 03:50:32 INFO - Usage: mozinstall [options] installer 03:50:32 INFO - Options: 03:50:32 INFO - -h, --help show this help message and exit 03:50:32 INFO - -d DEST, --destination=DEST 03:50:32 INFO - Directory to install application into. [default: 03:50:32 INFO - "/builds/slave/test"] 03:50:32 INFO - --app=APP Application being installed. [default: firefox] 03:50:32 INFO - mkdir: /builds/slave/test/build/application 03:50:32 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'] 03:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:50:49 INFO - Reading from file tmpfile_stdout 03:50:49 INFO - Output received: 03:50:49 INFO - /builds/slave/test/build/application/firefox/firefox 03:50:49 INFO - Running post-action listener: _resource_record_post_action 03:50:49 INFO - [mozharness: 2017-08-15 10:50:49.819223Z] Finished install step (success) 03:50:49 INFO - [mozharness: 2017-08-15 10:50:49.819506Z] Running setup-mitmproxy step. 03:50:49 INFO - Running pre-action listener: _resource_record_pre_action 03:50:49 INFO - Running main action method: setup_mitmproxy 03:50:49 INFO - Skipping: mitmproxy is not required 03:50:49 INFO - Running post-action listener: _resource_record_post_action 03:50:49 INFO - [mozharness: 2017-08-15 10:50:49.820653Z] Finished setup-mitmproxy step (success) 03:50:49 INFO - [mozharness: 2017-08-15 10:50:49.820875Z] Running run-tests step. 03:50:49 INFO - Running pre-action listener: _resource_record_pre_action 03:50:49 INFO - Running pre-action listener: _set_gcov_prefix 03:50:49 INFO - Running main action method: run_tests 03:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:50:49 INFO - Python 2.7.3 03:50:49 INFO - Return code: 0 03:50:49 INFO - grabbing minidump binary from tooltool 03:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:49 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 0x1c32f00>, '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 0x1c2dba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:50:49 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 03:50:49 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 03:50:49 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 03:50:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:50:49 INFO - Return code: 0 03:50:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:50:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:50:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:50:49 INFO - ENV: RUST_BACKTRACE is now full 03:50:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:50:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:50:49 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/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 03:50:49 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/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 03:50:49 INFO - Using env: {'DISPLAY': ':0', 03:50:49 INFO - 'HOME': '/home/cltbld', 03:50:49 INFO - 'LANG': 'en_US.UTF-8', 03:50:49 INFO - 'LANGUAGE': 'en_US:en', 03:50:49 INFO - 'LOGNAME': 'cltbld', 03:50:49 INFO - 'MAIL': '/var/mail/cltbld', 03:50:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:50:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:49 INFO - 'MOZ_NO_REMOTE': '1', 03:50:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:49 INFO - 'NO_EM_RESTART': '1', 03:50:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:49 INFO - 'PWD': '/builds/slave/test', 03:50:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:50:49 INFO - 'RUST_BACKTRACE': 'full', 03:50:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:50:49 INFO - 'SHELL': '/bin/bash', 03:50:49 INFO - 'SHLVL': '1', 03:50:49 INFO - 'TERM': 'linux', 03:50:49 INFO - 'TMOUT': '86400', 03:50:49 INFO - 'USER': 'cltbld', 03:50:49 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398', 03:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:49 INFO - '_': '/tools/buildbot/bin/python'} 03:50:49 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/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 03:50:50 INFO - mozversion application_buildid: 20170815094231 03:50:50 INFO - mozversion application_changeset: 564e82f0f289af976da01c2d50507017bbc152b5 03:50:50 INFO - mozversion application_display_name: Nightly 03:50:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:50:50 INFO - mozversion application_name: Firefox 03:50:50 INFO - mozversion application_remotingname: firefox 03:50:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:50:50 INFO - mozversion application_vendor: Mozilla 03:50:50 INFO - mozversion application_version: 57.0a1 03:50:50 INFO - mozversion platform_buildid: 20170815094231 03:50:50 INFO - mozversion platform_changeset: 564e82f0f289af976da01c2d50507017bbc152b5 03:50:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:50:50 INFO - mozversion platform_version: 57.0a1 03:50:50 INFO - using testdate: 1502794250 03:50:50 INFO - actual date: 1502794250 03:50:50 INFO - starting webserver on 'localhost:60812' 03:50:50 INFO - SUITE-START | Running 2 tests 03:50:50 INFO - TEST-START | dromaeo_css 03:50:50 INFO - Initialising browser for dromaeo_css test... 03:50:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60812/getInfo.html -profile /tmp/tmp4tuuku/profile 03:50:50 INFO - TEST-INFO | started process 10432 (/builds/slave/test/build/application/firefox/firefox http://localhost:60812/getInfo.html) 03:50:55 INFO - TEST-INFO | 10432: exit 0 03:50:55 INFO - Browser initialized. 03:50:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:50:55 INFO - TEST-INFO | started process 10643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4tuuku/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:56 INFO - PID 10643 | 03:50:56 INFO - PID 10643 | (/builds/slave/test/build/application/firefox/firefox:10692): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:50:56 INFO - PID 10643 | 03:51:07 INFO - PID 10643 | RSS: Main: 157380608 03:51:07 INFO - PID 10643 | 03:54:05 INFO - PID 10643 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60812/tests/dromaeo/cssquery-ext.html) 03:54:06 INFO - PID 10643 | RSS: Main: 165826560 03:54:06 INFO - PID 10643 | 03:57:07 INFO - PID 10643 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-ext.html (next: http://localhost:60812/tests/dromaeo/cssquery-jquery.html) 03:57:08 INFO - PID 10643 | RSS: Main: 162512896 03:57:08 INFO - PID 10643 | 04:00:10 INFO - PID 10643 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60812/tests/dromaeo/cssquery-mootools.html) 04:00:10 INFO - PID 10643 | RSS: Main: 165081088 04:00:10 INFO - PID 10643 | 04:03:12 INFO - PID 10643 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60812/tests/dromaeo/cssquery-prototype.html) 04:03:12 INFO - PID 10643 | RSS: Main: 163737600 04:03:12 INFO - PID 10643 | 04:06:16 INFO - PID 10643 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60812/tests/dromaeo/cssquery-yui.html) 04:06:16 INFO - PID 10643 | RSS: Main: 166998016 04:06:16 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | Cycle 1(1): loaded http://localhost:60812/tests/dromaeo/cssquery-yui.html (next: http://localhost:60812/tests/dromaeo/cssquery-dojo.html) 04:09:18 INFO - PID 10643 | RSS: Main: 167596032 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | __start_tp_report 04:09:18 INFO - PID 10643 | _x_x_mozilla_page_load 04:09:18 INFO - PID 10643 | _x_x_mozilla_page_load_details 04:09:18 INFO - PID 10643 | |i|pagename|runs| 04:09:18 INFO - PID 10643 | |0;dojo.html;3477.704395126414;3483.4426491761305;3494.790312581247;3556.022093924171;3562.1272788166903;6160.137580738695;6203.2245969253845;6263.311035786066;6270.435660790528;6355.8093257202245;6231.8753624927585;6290.150829637997;6319.462845658113;6339.936600633992;6382.840428989278;5357.1696387060065;5447.754851031693;5575.219469274295;5575.832725018236;5594.832155035356;5464.672119672832;5487.341519017704;5587.8603034924245;5590.217369568264;5591.133374326986;5542.39033706294;5542.8337149885165;5601.019821531236;5616.213730077792;5631.774729010835;5495.972520137414;5519.2824932758485;5575.498205161514;5580.414056524088;5595.804146854841;5392.1911713242935;5483.369412517572;5496.725163741797;5498.945010549884;5505.697186654733;6152.907706384408;6180.3201647818705;6190.442860142609;6220.875582488325;6233.594816336924;6770.052192693027;6822.795316140474;6841.042254084432;6843.555168914005;6847.828804279883;6857.005734168568;6875.965620171867;6880.380765731108;6933.0293758873795;6936.410405115521;6211.968940155315;6286;6293.992961126198;6387.457066149336;6405.5836370636225;6945.3766263466805;6989.266127056586;6997.860042799217;7001.36987671112;7017.4035207006955;6678.131842860397;6755.594664320157;6761.357671021246;6768.018637297663;6779.525433219627;6793.184817821893;6820.215675197416;6838.521303508806;6878.793636190922;6900.689468973908;6659.53383263167;6733.764318248838;6741.460683145435;6835.692393842289;6841.213260475109;6723.932760672428;6747.426468750113;6747.561408508432;6751.966240168866;6754.493412993947;4924.63065270099;4997.3253610762085;5007.4241462231585;5011.599072074226;5017.598592112695;4404.581564751344;4416.514183439819;4428.557144285545;4434.800433980478;4456.442944631921;6383.616982981036;6462.870742585122;6472.838179045468;6479.643619600967;6532.314107018789;6771.62756048422;6793.388595026471;6807.897881531781;6874.587524748531;6893.75871844483;6505.7397704092255;6527.249366322839;6556.3443655634055;6573.1783527059115;6576.80269591913;5607.158926161027;5640.182173584807;5696.088625819932;5700.087985922315;5700.9429905701245;7057.50597458173;7177.7487787927175;7178.5692858428665;7214.098237720285;7321.890171647429;6908.827279317856;6925.411340036153;6942.028116063856;6945.305469453015;6946.062281592122;7123.893141602776;7206.603636800026;7291.453141014339;7296.489245752747;7316.304951029643;6587.505937054644;6700.2964688708935;6715.5299129060495;6718.227403848425;6806.489513286622;6837.145356830396;6849.931500684929;6873;6893.724251029903;6966.059581956573;6552.246491653521;6670.533062685566;6714.697838597177;6716.6977486012265;6740.66296685154;6653.2016158059405;6667.733290668319;6714.160729908762;6732.697028633625;6743.696533656095;6521.5108866834225;6634.535582509178;6648.20221573395;6687.063811066358;6701.463882889455;6680.498962577729;6720.0591917132615;6748.021536877027;6785.660716964033;6791.558548694319;6426;6493;6554.606723596599;6564.868702626016;6580.21037475506 04:09:18 INFO - PID 10643 | |1;ext.html;854.1981739763625;887.7096116514324;913.0595486648753;933.8599210118481;939.431643855467;41536.16927661445;42644;42660.573394266044;42678.99999999996;42695.57304426955;38510.807445962804;38610.42084368737;38787.61212387875;38822.223555528944;38950;6819.352161544658;6935.757248496304;6936.202336731265;6939;6939.791806245821;6808.6255255960905;6920.238773734885;6922.7923162305215;6926.203486599055;6926.37662610365;6907.792766216997;6928.792136235921;7244.311790379906;7314.049173607424;7331.120265568113;7289.708411663553;7358;7360.558366498028;7363.410927125817;7363.595002274873;7424.703011879518;7503.512271702377;7504.549727016342;7506.28690274423;7512.624368781594;39178.21643567113;39214.41178382326;39421.40867886984;39455;39537.40693889594;3553.538040054802;3561.4479755637917;3571.624979377154;3593.1735700788704;3596.5504311961004;31162;31251.218719531968;31280.21799455032;31299.53050704241;31313.686863131305;5102.923456148161;5109.284700141983;5114.05390002847;5151.716655583941;5173.430922598511;209984;211688;211747;213095;213203;51886;52064.479355205964;52173;52183.73908130435;52270.29567338958;54423.727881361134;54522.454775452534;54634.45365546294;54812.45187548153;54835.45164548383;16672.916635416987;16821.579460513585;17020.72344574162;17042.74435883463;17056.403025894033;13506.257155856325;13554.796678049837;13577.932110339385;13590.116642418212;13600.25198614066;15047.398104075713;15169.317380717894;15171.772423413657;15177.772333415007;15426.228688565527;5889.116632505158;5923.940760592425;5980.342162362137;6077.392260773887;6104.145419641254;1075.370908018802;1082.8592283003159;1102.9393383363831;1106.4025426269884;1121.2319561100671;24706.752932470805;24751.3812154694;24880.5023899521;24906.626400603644;25149.497010059695;1209.5041033176356;1216.9330686812134;1218.469965564982;1227.3924407418385;1230.3786587773118;13142;13297.800532992012;13347.46610135603;13544.932275338757;13545.525906593419;286550;288182;290318;291004;292380;50919.23621145686;51789.741051295256;55443;55979.720101400046;56783;1510.0486693383318;1521.7032678627784;1527.0303357368152;1541.8689411399932;1550.4573399310152;28302.574732162597;29313.413731725672;29358.559621605265;29493.410131797675;29705.405891882474;40863.38704919369;40863.7956810214;40893.59106408898;40950;40950.79524602477;159265;159368;160112;160157;160182.19908900847;35409.46885796663;38761.6123838758;39272.607273928035;39361.21277574375;39399.606003939596;47471.76264118657;49162.262566060825;49275.75362123166;49306;49601.50398495969;36044.81977590095;36195;36423;36629.26741465209;36861;35093.82453087718;35110.12224694403;35114.47328290129;35185;35372.46941295934;41375;41377;41879.371809423494;42048.15903681848;42093.57906421019;34631;43491.34762978495;43795.12409751723;43975.78012109919;44078.55921440873;32196.517052243766;32613.836930815192;32700;32742.34515309728;33366 04:09:18 INFO - PID 10643 | |2;jquery.html;566.5043087298612;567.909134538474;575.4475703324808;585.1924344404723;585.6339787632729;17088.743668844963;17636.911815440923;17644.735328970077;17720.911395443003;23572.76427235727;25768.355791105187;27610.723892761067;27625;27691.58462623057;27719.307017324525;6296.874062518736;6442.16251887254;6442.871142577145;6450.483961283109;6461.19235095613;6054.6367217966845;6263.217097862767;6266.060090986343;6310.40051195138;6318.652474113922;6283.340249273829;6295.653739044351;6298.2442106947;6301.40136687014;6303.905441418382;6280.403361680633;6287.96856015717;6289.213848268966;6289.779857704958;6294.244690637152;5783.826485205451;5807.157962095514;5830.970845145789;5847.26909136358;5847.883042339172;30321.393572128432;31553.368932621448;31597.21006974821;31822;32199;2260.6495993121093;2302;2304.6543018547186;2309.7228332600193;2313.086330899302;19950.304224140964;20588.38234852942;20593.279235226695;20603.89698051515;20613.690794638092;2405.783479486837;2432.97567024331;2495.214007587604;2495.9126430574843;2512.5854234051358;162600.18699906426;167558.99999999878;168405;169244;169625.15187424107;15613.765793513106;15815.841841581438;15997.200139992954;16001.439949601709;16064.116473594064;24263.514729705308;24304.635430468556;24320.756792432203;24334;24343;10659.093977011886;10896;11067.778644427066;11089.168312376603;11110.277831940897;10118.089371956412;10207.693769186937;10254.38473691566;10273.383596984206;10359.533820978075;8531.573421328909;9876.703698889045;9902.80194396108;9996;10046.397216167054;2651.2443953473166;2659.6727863119772;2717.388587567821;2763.2401089700493;2800.145955483597;1021.3463383434607;1074.6292529077455;1075.8171110911164;1076.839476137539;1078.385320367383;21663.35009949704;21761.673574896387;21830.89084554567;21909.68541887492;22742.09031638716;1074.6883403812963;1128.2384390536356;1146.5814977533141;1149.2357582207737;1152.6023521885104;11702.590409335802;11996.940015300042;12079;12100.515979360727;12106.455209515592;594425;597136;607321;610966;611599;139031;140177;142023;142709.28645356707;143188.28405857904;1299.155548893208;1339.5445548513553;1370.766969615168;1382.2812137688345;1387.195426652539;19124.808751912304;19236.71144932855;19313.4205973821;19433.611327773648;19775.70336444926;63002.68498657477;63583.36416635959;66799;68436;69447;82964.58517707374;83293.58353208438;83436;83637.58181209055;83706;13134.60596182116;13210;14924.7761283583;15385.461508847584;15522.922385388001;25311.114111006027;25537.48925021452;25848.741512584635;25968.8701556491;26002.479950400506;20403.69394459114;20592.382228533166;20597.69103463479;20753.688694669894;20755.48111297169;17298.308067677655;17792;17880.195391207686;17931.193096310435;18210.544736381697;21100.788992109883;21109;21255.78744212538;21318.253861114787;21603;15168.772468412762;15206.771898421754;15230.923845380703;15309.775217982757;15312.157831319384;20607.690884637042;20804.68792968137;20873.68689469629;21004.159833607097;21091.683624745947 04:09:18 INFO - PID 10643 | |3;mootools.html;1464.831544372397;1507.9095254284744;1521.6119889428194;1527.8166620005602;1534.9869086402975;15814.367425302988;16495.917520412397;16502.75245871313;16509.587260318498;16518.25667844947;15676;16968.066756328397;16970.915145424256;16978;16986;2537.8477291362483;2594.922152335433;2596.948061038778;2598.674675915278;2599.5970624553224;2465.0879174705383;2468.3582268610203;2487.7263501014872;2501.8123640726926;2586.056089527328;2506.9122580709677;2523.73500782418;2524.5203411351877;2530.304166354249;2533.3919859233742;2463.6304554316816;2476.5170791695627;2480.119557557059;2482.863442510661;2487.8880450379775;2441.572724773175;2441.829071964963;2450.705915290159;2450.9632355514505;2452.889619967106;15899.60250993723;16272.43046493367;16311.592210194722;16314.755278670711;16327.428540001161;8245.257926786559;8562.914370856337;8570.571471426403;8573.699920502815;8574.828503429959;5044.520770526794;5190.92213616796;5264.9736751315995;5324.361076670824;5328.307320048408;1880.501667058217;1886.6415381077552;1897.383350411122;1927.315802889968;1936.1480948382666;28761.13716588506;28829.135125946254;28981.275468113254;29016.70983290161;29057.70942290571;6399.8080057598345;6570.113034740344;6625.801225963229;6680.665966701646;6721.831954201184;19564.21743130259;19579.804201958083;19602.31391901305;19613.117409716597;19642.90178549098;8116.310113640407;8373.665053397917;8376;8376.664933402595;8381.622826972678;7627;7673.846523069507;7748.147703752583;7797.961010195027;7814.21857814214;5214.426413094557;5411.485908838654;5413.188021796684;5415.241866138744;5486.149646804752;1400.0969374753226;1442.819647544057;1480.6890552983994;1555.6422022934562;1561.7657351397154;967.7435479597913;977.2848650618262;984.478226539935;1009.5053423822421;1011.5549158370294;9301.162895339452;9716.271279654055;9776.804463910825;9816.214702823758;9827.918928917956;1014.3508154780947;1045.628801775374;1070.8768491623564;1073.4310815267763;1108.3626914524182;5175.896482070338;5629.296337957755;6139.754409823647;6561.934380656227;6753.08833307507;22617.20839770633;23176.65235021476;23326.300210993697;23601.7639823603;23686.407839803796;22718.545629087657;22999.655005174936;23014.309570712907;23029.07883684634;23258.3022509325;11068.28056176346;11910.702232444259;12139.575114871113;12159.723229060997;12241.449134788956;9225.261979041527;9544.711463952277;9592.616295348107;9594.472304023346;9772.267079969173;20413.38759837207;20432.89783551073;20733.067011984196;20913.163473460892;21539.8923005384;21190.576188476454;21253.555841078472;21285.78714212838;21331.72009679424;21644.567108658055;12774.552890649155;13019.283939383045;13328;13330.400131994278;13343.466261349437;14763.261836908327;14787.334569944163;14828.481003164838;14847.628809279855;14917.627059323604;11186.440677966231;11203.775924481302;11268.83096753533;11337.489812958602;11486.885131148581;11536.134789890624;11548.191626586058;11584.826227606762;11645.301281923112;11869;9868.457234852152;10039.799204016024;10050.24623153281;10057;10057.145142662956;7976.361891048586;8035.919640803751;8106.108328084024;8134.186581341818;8140.796480088045;7752.18602046777;7914.525128492309;7920.128785833669;8011.399145064027;8023.398245131521 04:09:18 INFO - PID 10643 | |4;prototype.html;508.55385595286674;527.2355085126568;531.9862976239602;536.9731513424329;539.3096836049855;6116.235470566174;6118.235220597426;6180.969095154518;6190.8142755717345;6231.283402408724;5999.160117583542;6003.369646187142;6043.244594425697;6112.510999120071;6137.416945390192;4857.29569212464;4884.462709101996;4891.682040667345;4911.484294149116;4945.455999840033;4596;4775.331453596499;4821.4696383397795;4902.19113846215;4915.975420122894;4698.553637404441;4705.87059605362;4724.62203023759;4761.309610106532;4789.5210478952;4684.765761711901;4700.529947005306;4702.882427939312;4722.834700785474;4790.880227994293;4224.176285624305;4244.660427165819;4270.612051083411;4275.230458517465;4277.807498662568;5873.324567674729;5941.435563621449;5951.761929522814;5993.520518358521;6035.637861728311;5664.518515926151;5701.344345400291;5716.256886604757;5791.015527360359;5802;6462.386073323027;6467.385598368148;6529.5429319947625;6551.901721474182;6552.705128269239;4861.246506791453;4887.486813884527;4909.140900342426;4913.213885778258;4937.7777999990085;6596.208454985384;6635.203775546917;6668.266490686021;6674.83312917181;6806.5916045036965;5012.573931215815;5015.949840501548;5052.292679024939;5061.493850614983;5062.341895553554;5123.231515272664;5133.537981581676;5153.2270159476375;5155.458676838953;5163.922541161885;5731.197632331477;5733.964442622892;5740.971295143498;5746.770129194869;5759.22250496186;6420.678966051679;6452.903206451907;6518.804435866837;6527.902081468782;6631.469482441393;1750.0637159120065;1754.9824501755074;1759.4897479730735;1766.7968183658786;1768.7435321878513;1159.6115301373966;1211.5941159711595;1241.0443958152173;1243.7450322683828;1245.1470742541387;6098.603590766586;6331.715072821734;6358.554901156875;6375.74497020114;6395.488360931115;6547.9017814732815;6603.448189675422;6646.501512386591;6665.266820649725;6705.865882682417;6136.6624835633575;6269.498440124779;6279.434850863444;6294.181756371642;6333.556651034475;3481.4681540122265;3535.8939231823088;3544.2557063017057;3553.34263161316;3575.1955809943074;7083.193785584746;7086.858262834818;7135.785926422215;7154.177269613957;7156.177039640508;6760.695768690421;6762.69567869447;6828.2488926218075;6935.653217339112;6936.861262774716;7070.611116388648;7088.362047415861;7098.68055937484;7129.750458733919;7219.8917016244795;6592.868142637025;6637.568558043712;6663.666816659244;6672.566283191577;6776.45788336922;6613.966930165318;6654.269889828583;6657.800265992028;6663.13379260693;6735.932640673531;7064.894026589708;7148.463865210234;7149;7183.03029091066;7199.532030418006;4999.750012499433;5005.424376196638;5015.1975683890405;5054.1660625997765;5061.6962982221185;6494.188226471691;6681.933180668131;6712.429443497357;6845.110135682329;6845.828854278683;6305.936940630535;6529.412352888263;6576.500929646703;6587.341265873374;6592.307807680317;6493.155889734304;6509.549938532586;6514.967425162844;6554.279029306867;6569.37590928861;6419.390157934989;6514.218293804774;6566.507511936528;6571.934280657323;6597.109390232257;6553.344665533408;6585.473162147113;6592.340765923561;6596.241432235354;6608.966955165193;6388.648624325707;6401.743930242925;6405.722392055718;6414;6420.972644376878 04:09:18 INFO - PID 10643 | |5;yui.html;943.2926403210189;947.9383840050397;973.3964941736125;978;981.2591493422465;19728.408147755574;20519.487012824688;20522.999999999964;20539.28112516062;21758.456038599044;19544.120514576844;19607.451031365938;19650.606987860236;19667;19668.704969425435;999.6354975458502;1044.185535282481;1111.2776695148177;1112.6383925224295;1117.1788735279563;1094.3324572011068;1100.5707773968159;1100.9229353945227;1101.438266484091;1101.6529793115144;1085.782843431317;1124.4714983957526;1130.5195292000908;1131.360781158647;1132.162199972019;1115.81031224692;1117.1398023521842;1120.775844831033;1123.3652986062848;1123.859517560305;813.4996976859248;817.546261824687;823.045267489715;823.1192623892438;823.5429336718119;20383.592328153503;20598.897005515028;20600.175992960263;20618.072186751633;20988.16047358104;23133.190338338078;23196.072157113696;23340.2997910063;23540.176093836806;23724.64413033806;17172.65654686899;17344.306227750876;17363.13184340778;17516.73724894115;17591.824081759274;3757.1734218471893;3779.527559055118;3781.924361512782;3783.281176576442;3783.8675646352244;142527.28736356253;143300;144140;144334.27832860872;145312;15464.226788660748;15609.453669121527;15635.921820390826;15645.217739112999;15660.92169539145;29383.706162938524;29476.263093422836;29544.261393464905;30207.546886796717;30420.239494012385;7765;8830.337724670675;8845.159709827556;8940;9002.189802917768;3675.081229692577;3743.794091325003;4201.873943781691;4354.368616550582;4362.083962367875;5667.801626943037;5749.223854779635;5785.4214578541805;5788.0449725795615;5810.796622118206;1168.293182624517;1174.3834486894277;1201.8437603111715;1206.0592737664635;1208.6011616166643;700.2577268095835;712.5973824788978;713.1477883928656;723.088907975954;737.4505993035223;12954.02844786626;13232.272225027524;13423.731525369438;14463.349149288097;14595.051321664057;704.6864145455223;710.8898120791285;711.1146622455077;730.477708438469;731.6634348199781;5915.231019967377;7043.612601306875;7262.636868156571;7374.594397308199;7461.664225109883;122845;126497;126642.36678816547;129624;134113;113667;118055;118385;118860;120760;105366;105797;106755;106776;107352.99999999844;14607.92696036513;14683.632909177357;14844.777328339867;15171.089734615958;15173.924130379719;48020.27969580389;50152;51200.74399627978;51204.48795511997;51437.22844157415;85224;85646.14353856382;86045;87303;91528;19979.001049947154;20266.79733202649;20411.387658370273;20472.283470078477;20672.069756861278;24511.142110026063;24802.875985619958;24824.25527234186;24834.25497235086;24971.250862474153;20517;20759.169633214504;21146;21903.890480547496;22775;21383.46541336479;21467;21508.354749357546;22029.339119826433;22509.324720258417;20224.494387640425;20259.493512662302;21434.6784798225;21639.891800540896;22302.553948921257;14314.785278220626;14487.348069336695;14491.637709057359;14660.266986650839;14746.11523308605;16668.916520426134;17088.23102960345;17199.398021069203;17373.56566085858;17924.641507170043 04:09:18 INFO - PID 10643 | __end_tp_report 04:09:18 INFO - PID 10643 | __start_cc_report 04:09:18 INFO - PID 10643 | _x_x_mozilla_cycle_collect,338 04:09:18 INFO - PID 10643 | __end_cc_report 04:09:18 INFO - PID 10643 | __startTimestamp1502795358756__endTimestamp 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | ------- Summary: start ------- 04:09:18 INFO - PID 10643 | Number of tests: 6 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | [#0] dojo.html Cycles:165 Average:6280.45 Median:6587.51 stddev:819.87 (12.4%) stddev-sans-first:792.36 04:09:18 INFO - PID 10643 | Values: 3477.7 3483.4 3494.8 3556.0 3562.1 6160.1 6203.2 6263.3 6270.4 6355.8 6231.9 6290.2 6319.5 6339.9 6382.8 5357.2 5447.8 5575.2 5575.8 5594.8 5464.7 5487.3 5587.9 5590.2 5591.1 5542.4 5542.8 5601.0 5616.2 5631.8 5496.0 5519.3 5575.5 5580.4 5595.8 5392.2 5483.4 5496.7 5498.9 5505.7 6152.9 6180.3 6190.4 6220.9 6233.6 6770.1 6822.8 6841.0 6843.6 6847.8 6857.0 6876.0 6880.4 6933.0 6936.4 6212.0 6286.0 6294.0 6387.5 6405.6 6945.4 6989.3 6997.9 7001.4 7017.4 6678.1 6755.6 6761.4 6768.0 6779.5 6793.2 6820.2 6838.5 6878.8 6900.7 6659.5 6733.8 6741.5 6835.7 6841.2 6723.9 6747.4 6747.6 6752.0 6754.5 4924.6 4997.3 5007.4 5011.6 5017.6 4404.6 4416.5 4428.6 4434.8 4456.4 6383.6 6462.9 6472.8 6479.6 6532.3 6771.6 6793.4 6807.9 6874.6 6893.8 6505.7 6527.2 6556.3 6573.2 6576.8 5607.2 5640.2 5696.1 5700.1 5700.9 7057.5 7177.7 7178.6 7214.1 7321.9 6908.8 6925.4 6942.0 6945.3 6946.1 7123.9 7206.6 7291.5 7296.5 7316.3 6587.5 6700.3 6715.5 6718.2 6806.5 6837.1 6849.9 6873.0 6893.7 6966.1 6552.2 6670.5 6714.7 6716.7 6740.7 6653.2 6667.7 6714.2 6732.7 6743.7 6521.5 6634.5 6648.2 6687.1 6701.5 6680.5 6720.1 6748.0 6785.7 6791.6 6426.0 6493.0 6554.6 6564.9 6580.2 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | [#1] ext.html Cycles:180 Average:40528.02 Median:38804.92 stddev:59119.83 (152.4%) stddev-sans-first:59210.63 04:09:18 INFO - PID 10643 | Values: 854.2 887.7 913.1 933.9 939.4 41536.2 42644.0 42660.6 42679.0 42695.6 38510.8 38610.4 38787.6 38822.2 38950.0 6819.4 6935.8 6936.2 6939.0 6939.8 6808.6 6920.2 6922.8 6926.2 6926.4 6907.8 6928.8 7244.3 7314.0 7331.1 7289.7 7358.0 7360.6 7363.4 7363.6 7424.7 7503.5 7504.5 7506.3 7512.6 39178.2 39214.4 39421.4 39455.0 39537.4 3553.5 3561.4 3571.6 3593.2 3596.6 31162.0 31251.2 31280.2 31299.5 31313.7 5102.9 5109.3 5114.1 5151.7 5173.4 209984.0 211688.0 211747.0 213095.0 213203.0 51886.0 52064.5 52173.0 52183.7 52270.3 54423.7 54522.5 54634.5 54812.5 54835.5 16672.9 16821.6 17020.7 17042.7 17056.4 13506.3 13554.8 13577.9 13590.1 13600.3 15047.4 15169.3 15171.8 15177.8 15426.2 5889.1 5923.9 5980.3 6077.4 6104.1 1075.4 1082.9 1102.9 1106.4 1121.2 24706.8 24751.4 24880.5 24906.6 25149.5 1209.5 1216.9 1218.5 1227.4 1230.4 13142.0 13297.8 13347.5 13544.9 13545.5 286550.0 288182.0 290318.0 291004.0 292380.0 50919.2 51789.7 55443.0 55979.7 56783.0 1510.0 1521.7 1527.0 1541.9 1550.5 28302.6 29313.4 29358.6 29493.4 29705.4 40863.4 40863.8 40893.6 40950.0 40950.8 159265.0 159368.0 160112.0 160157.0 160182.2 35409.5 38761.6 39272.6 39361.2 39399.6 47471.8 49162.3 49275.8 49306.0 49601.5 36044.8 36195.0 36423.0 36629.3 36861.0 35093.8 35110.1 35114.5 35185.0 35372.5 41375.0 41377.0 41879.4 42048.2 42093.6 34631.0 43491.3 43795.1 43975.8 44078.6 32196.5 32613.8 32700.0 32742.3 33366.0 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | [#2] jquery.html Cycles:180 Average:40666.28 Median:21712.51 stddev:102036.32 (469.9%) stddev-sans-first:102278.14 04:09:18 INFO - PID 10643 | Values: 566.5 567.9 575.4 585.2 585.6 17088.7 17636.9 17644.7 17720.9 23572.8 25768.4 27610.7 27625.0 27691.6 27719.3 6296.9 6442.2 6442.9 6450.5 6461.2 6054.6 6263.2 6266.1 6310.4 6318.7 6283.3 6295.7 6298.2 6301.4 6303.9 6280.4 6288.0 6289.2 6289.8 6294.2 5783.8 5807.2 5831.0 5847.3 5847.9 30321.4 31553.4 31597.2 31822.0 32199.0 2260.6 2302.0 2304.7 2309.7 2313.1 19950.3 20588.4 20593.3 20603.9 20613.7 2405.8 2433.0 2495.2 2495.9 2512.6 162600.2 167559.0 168405.0 169244.0 169625.2 15613.8 15815.8 15997.2 16001.4 16064.1 24263.5 24304.6 24320.8 24334.0 24343.0 10659.1 10896.0 11067.8 11089.2 11110.3 10118.1 10207.7 10254.4 10273.4 10359.5 8531.6 9876.7 9902.8 9996.0 10046.4 2651.2 2659.7 2717.4 2763.2 2800.1 1021.3 1074.6 1075.8 1076.8 1078.4 21663.4 21761.7 21830.9 21909.7 22742.1 1074.7 1128.2 1146.6 1149.2 1152.6 11702.6 11996.9 12079.0 12100.5 12106.5 594425.0 597136.0 607321.0 610966.0 611599.0 139031.0 140177.0 142023.0 142709.3 143188.3 1299.2 1339.5 1370.8 1382.3 1387.2 19124.8 19236.7 19313.4 19433.6 19775.7 63002.7 63583.4 66799.0 68436.0 69447.0 82964.6 83293.6 83436.0 83637.6 83706.0 13134.6 13210.0 14924.8 15385.5 15522.9 25311.1 25537.5 25848.7 25968.9 26002.5 20403.7 20592.4 20597.7 20753.7 20755.5 17298.3 17792.0 17880.2 17931.2 18210.5 21100.8 21109.0 21255.8 21318.3 21603.0 15168.8 15206.8 15230.9 15309.8 15312.2 20607.7 20804.7 20873.7 21004.2 21091.7 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | [#3] mootools.html Cycles:180 Average:10046.56 Median:13063.99 stddev:7380.29 (56.5%) stddev-sans-first:7372.83 04:09:18 INFO - PID 10643 | Values: 1464.8 1507.9 1521.6 1527.8 1535.0 15814.4 16495.9 16502.8 16509.6 16518.3 15676.0 16968.1 16970.9 16978.0 16986.0 2537.8 2594.9 2596.9 2598.7 2599.6 2465.1 2468.4 2487.7 2501.8 2586.1 2506.9 2523.7 2524.5 2530.3 2533.4 2463.6 2476.5 2480.1 2482.9 2487.9 2441.6 2441.8 2450.7 2451.0 2452.9 15899.6 16272.4 16311.6 16314.8 16327.4 8245.3 8562.9 8570.6 8573.7 8574.8 5044.5 5190.9 5265.0 5324.4 5328.3 1880.5 1886.6 1897.4 1927.3 1936.1 28761.1 28829.1 28981.3 29016.7 29057.7 6399.8 6570.1 6625.8 6680.7 6721.8 19564.2 19579.8 19602.3 19613.1 19642.9 8116.3 8373.7 8376.0 8376.7 8381.6 7627.0 7673.8 7748.1 7798.0 7814.2 5214.4 5411.5 5413.2 5415.2 5486.1 1400.1 1442.8 1480.7 1555.6 1561.8 967.7 977.3 984.5 1009.5 1011.6 9301.2 9716.3 9776.8 9816.2 9827.9 1014.4 1045.6 1070.9 1073.4 1108.4 5175.9 5629.3 6139.8 6561.9 6753.1 22617.2 23176.7 23326.3 23601.8 23686.4 22718.5 22999.7 23014.3 23029.1 23258.3 11068.3 11910.7 12139.6 12159.7 12241.4 9225.3 9544.7 9592.6 9594.5 9772.3 20413.4 20432.9 20733.1 20913.2 21539.9 21190.6 21253.6 21285.8 21331.7 21644.6 12774.6 13019.3 13328.0 13330.4 13343.5 14763.3 14787.3 14828.5 14847.6 14917.6 11186.4 11203.8 11268.8 11337.5 11486.9 11536.1 11548.2 11584.8 11645.3 11869.0 9868.5 10039.8 10050.2 10057.0 10057.1 7976.4 8035.9 8106.1 8134.2 8140.8 7752.2 7914.5 7920.1 8011.4 8023.4 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | [#4] prototype.html Cycles:180 Average:5555.86 Median:6211.05 stddev:1599.29 (25.7%) stddev-sans-first:1558.27 04:09:18 INFO - PID 10643 | Values: 508.6 527.2 532.0 537.0 539.3 6116.2 6118.2 6181.0 6190.8 6231.3 5999.2 6003.4 6043.2 6112.5 6137.4 4857.3 4884.5 4891.7 4911.5 4945.5 4596.0 4775.3 4821.5 4902.2 4916.0 4698.6 4705.9 4724.6 4761.3 4789.5 4684.8 4700.5 4702.9 4722.8 4790.9 4224.2 4244.7 4270.6 4275.2 4277.8 5873.3 5941.4 5951.8 5993.5 6035.6 5664.5 5701.3 5716.3 5791.0 5802.0 6462.4 6467.4 6529.5 6551.9 6552.7 4861.2 4887.5 4909.1 4913.2 4937.8 6596.2 6635.2 6668.3 6674.8 6806.6 5012.6 5015.9 5052.3 5061.5 5062.3 5123.2 5133.5 5153.2 5155.5 5163.9 5731.2 5734.0 5741.0 5746.8 5759.2 6420.7 6452.9 6518.8 6527.9 6631.5 1750.1 1755.0 1759.5 1766.8 1768.7 1159.6 1211.6 1241.0 1243.7 1245.1 6098.6 6331.7 6358.6 6375.7 6395.5 6547.9 6603.4 6646.5 6665.3 6705.9 6136.7 6269.5 6279.4 6294.2 6333.6 3481.5 3535.9 3544.3 3553.3 3575.2 7083.2 7086.9 7135.8 7154.2 7156.2 6760.7 6762.7 6828.2 6935.7 6936.9 7070.6 7088.4 7098.7 7129.8 7219.9 6592.9 6637.6 6663.7 6672.6 6776.5 6614.0 6654.3 6657.8 6663.1 6735.9 7064.9 7148.5 7149.0 7183.0 7199.5 4999.8 5005.4 5015.2 5054.2 5061.7 6494.2 6681.9 6712.4 6845.1 6845.8 6305.9 6529.4 6576.5 6587.3 6592.3 6493.2 6509.5 6515.0 6554.3 6569.4 6419.4 6514.2 6566.5 6571.9 6597.1 6553.3 6585.5 6592.3 6596.2 6609.0 6388.6 6401.7 6405.7 6414.0 6421.0 04:09:18 INFO - PID 10643 | 04:09:18 INFO - PID 10643 | [#5] yui.html Cycles:180 Average:27469.77 Median:20569.09 stddev:38135.42 (185.4%) stddev-sans-first:38190.38 04:09:18 INFO - PID 10643 | Values: 943.3 947.9 973.4 978.0 981.3 19728.4 20519.5 20523.0 20539.3 21758.5 19544.1 19607.5 19650.6 19667.0 19668.7 999.6 1044.2 1111.3 1112.6 1117.2 1094.3 1100.6 1100.9 1101.4 1101.7 1085.8 1124.5 1130.5 1131.4 1132.2 1115.8 1117.1 1120.8 1123.4 1123.9 813.5 817.5 823.0 823.1 823.5 20383.6 20598.9 20600.2 20618.1 20988.2 23133.2 23196.1 23340.3 23540.2 23724.6 17172.7 17344.3 17363.1 17516.7 17591.8 3757.2 3779.5 3781.9 3783.3 3783.9 142527.3 143300.0 144140.0 144334.3 145312.0 15464.2 15609.5 15635.9 15645.2 15660.9 29383.7 29476.3 29544.3 30207.5 30420.2 7765.0 8830.3 8845.2 8940.0 9002.2 3675.1 3743.8 4201.9 4354.4 4362.1 5667.8 5749.2 5785.4 5788.0 5810.8 1168.3 1174.4 1201.8 1206.1 1208.6 700.3 712.6 713.1 723.1 737.5 12954.0 13232.3 13423.7 14463.3 14595.1 704.7 710.9 711.1 730.5 731.7 5915.2 7043.6 7262.6 7374.6 7461.7 122845.0 126497.0 126642.4 129624.0 134113.0 113667.0 118055.0 118385.0 118860.0 120760.0 105366.0 105797.0 106755.0 106776.0 107353.0 14607.9 14683.6 14844.8 15171.1 15173.9 48020.3 50152.0 51200.7 51204.5 51437.2 85224.0 85646.1 86045.0 87303.0 91528.0 19979.0 20266.8 20411.4 20472.3 20672.1 24511.1 24802.9 24824.3 24834.3 24971.3 20517.0 20759.2 21146.0 21903.9 22775.0 21383.5 21467.0 21508.4 22029.3 22509.3 20224.5 20259.5 21434.7 21639.9 22302.6 14314.8 14487.3 14491.6 14660.3 14746.1 16668.9 17088.2 17199.4 17373.6 17924.6 04:09:18 INFO - PID 10643 | -------- Summary: end -------- 04:09:18 INFO - PID 10643 | 04:09:19 INFO - TEST-INFO | 10643: exit 0 04:09:19 INFO - TEST-OK | dromaeo_css | took 1109156ms 04:09:19 INFO - TEST-START | kraken 04:09:19 INFO - Initialising browser for kraken test... 04:09:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60812/getInfo.html -profile /tmp/tmpjNKIS_/profile 04:09:19 INFO - TEST-INFO | started process 11013 (/builds/slave/test/build/application/firefox/firefox http://localhost:60812/getInfo.html) 04:09:24 INFO - TEST-INFO | 11013: exit 0 04:09:24 INFO - Browser initialized. 04:09:24 INFO - Running cycle 1/1 for kraken test... 04:09:24 INFO - TEST-INFO | started process 11228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjNKIS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:25 INFO - PID 11228 | 04:09:25 INFO - PID 11228 | (/builds/slave/test/build/application/firefox/firefox:11277): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:25 INFO - PID 11228 | 04:09:35 INFO - PID 11228 | RSS: Main: 157560832 04:09:35 INFO - PID 11228 | 04:09:38 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-beat-detection) 04:09:39 INFO - PID 11228 | RSS: Main: 164003840 04:09:39 INFO - PID 11228 | 04:09:41 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-dft) 04:09:42 INFO - PID 11228 | RSS: Main: 167538688 04:09:42 INFO - PID 11228 | 04:09:45 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-fft) 04:09:45 INFO - PID 11228 | RSS: Main: 161447936 04:09:45 INFO - PID 11228 | 04:09:48 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60812/tests/kraken/driver.html?testName=audio-oscillator) 04:09:48 INFO - PID 11228 | RSS: Main: 162406400 04:09:48 INFO - PID 11228 | 04:09:50 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60812/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:09:51 INFO - PID 11228 | RSS: Main: 161832960 04:09:51 INFO - PID 11228 | 04:09:54 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60812/tests/kraken/driver.html?testName=imaging-darkroom) 04:09:55 INFO - PID 11228 | RSS: Main: 162263040 04:09:55 INFO - PID 11228 | 04:09:58 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60812/tests/kraken/driver.html?testName=imaging-desaturate) 04:09:59 INFO - PID 11228 | RSS: Main: 165662720 04:09:59 INFO - PID 11228 | 04:10:01 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60812/tests/kraken/driver.html?testName=json-parse-financial) 04:10:02 INFO - PID 11228 | RSS: Main: 164286464 04:10:02 INFO - PID 11228 | 04:10:04 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60812/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:04 INFO - PID 11228 | RSS: Main: 164360192 04:10:04 INFO - PID 11228 | 04:10:06 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:07 INFO - PID 11228 | RSS: Main: 164356096 04:10:07 INFO - PID 11228 | 04:10:09 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:09 INFO - PID 11228 | RSS: Main: 164491264 04:10:09 INFO - PID 11228 | 04:10:12 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:12 INFO - PID 11228 | RSS: Main: 164540416 04:10:12 INFO - PID 11228 | 04:10:15 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:16 INFO - PID 11228 | RSS: Main: 164544512 04:10:16 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | Cycle 1(1): loaded http://localhost:60812/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60812/tests/kraken/driver.html?testName=ai-astar) 04:10:18 INFO - PID 11228 | RSS: Main: 166416384 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | __start_tp_report 04:10:18 INFO - PID 11228 | _x_x_mozilla_page_load 04:10:18 INFO - PID 11228 | _x_x_mozilla_page_load_details 04:10:18 INFO - PID 11228 | |i|pagename|runs| 04:10:18 INFO - PID 11228 | |0;ai-astar;97;107;100;105;106;109;108;100;106;109 04:10:18 INFO - PID 11228 | |1;audio-beat-detection;148;115;137;160;115;147;149;123;167;112 04:10:18 INFO - PID 11228 | |2;audio-dft;163;164;162;163;161;163;164;161;170;166 04:10:18 INFO - PID 11228 | |3;audio-fft;75;74;74;138;74;75;73;80;93;76 04:10:18 INFO - PID 11228 | |4;audio-oscillator;78;78;134;80;78;78;127;78;79;132 04:10:18 INFO - PID 11228 | |5;imaging-gaussian-blur;113;114;113;113;115;116;114;115;115;113 04:10:18 INFO - PID 11228 | |6;imaging-darkroom;150;150;150;151;150;151;150;150;151;150 04:10:18 INFO - PID 11228 | |7;imaging-desaturate;96;94;95;96;94;94;94;94;94;94 04:10:18 INFO - PID 11228 | |8;json-parse-financial;51;46;49;47;47;57;48;50;48;49 04:10:18 INFO - PID 11228 | |9;json-stringify-tinderbox;53;54;54;53;53;53;54;54;53;53 04:10:18 INFO - PID 11228 | |10;stanford-crypto-aes;73;74;75;75;74;81;73;75;82;76 04:10:18 INFO - PID 11228 | |11;stanford-crypto-ccm;123;125;119;116;116;122;115;130;125;156 04:10:18 INFO - PID 11228 | |12;stanford-crypto-pbkdf2;160;165;161;162;181;161;166;174;161;160 04:10:18 INFO - PID 11228 | |13;stanford-crypto-sha256-iterative;61;62;63;61;65;60;63;62;60;60 04:10:18 INFO - PID 11228 | __end_tp_report 04:10:18 INFO - PID 11228 | __start_cc_report 04:10:18 INFO - PID 11228 | _x_x_mozilla_cycle_collect,858 04:10:18 INFO - PID 11228 | __end_cc_report 04:10:18 INFO - PID 11228 | __startTimestamp1502795418312__endTimestamp 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | ------- Summary: start ------- 04:10:18 INFO - PID 11228 | Number of tests: 14 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#0] ai-astar Cycles:10 Average:104.70 Median:107.50 stddev:4.22 (3.9%) stddev-sans-first:3.43 04:10:18 INFO - PID 11228 | Values: 97.0 107.0 100.0 105.0 106.0 109.0 108.0 100.0 106.0 109.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:147.50 stddev:19.95 (13.5%) stddev-sans-first:20.78 04:10:18 INFO - PID 11228 | Values: 148.0 115.0 137.0 160.0 115.0 147.0 149.0 123.0 167.0 112.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.67 (1.6%) stddev-sans-first:2.82 04:10:18 INFO - PID 11228 | Values: 163.0 164.0 162.0 163.0 161.0 163.0 164.0 161.0 170.0 166.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:20.15 (26.9%) stddev-sans-first:21.15 04:10:18 INFO - PID 11228 | Values: 75.0 74.0 74.0 138.0 74.0 75.0 73.0 80.0 93.0 76.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.00 stddev:25.46 (32.6%) stddev-sans-first:26.32 04:10:18 INFO - PID 11228 | Values: 78.0 78.0 134.0 80.0 78.0 78.0 127.0 78.0 79.0 132.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.50 stddev:1.10 (1.0%) stddev-sans-first:1.09 04:10:18 INFO - PID 11228 | Values: 113.0 114.0 113.0 113.0 115.0 116.0 114.0 115.0 115.0 113.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:10:18 INFO - PID 11228 | Values: 150.0 150.0 150.0 151.0 150.0 151.0 150.0 150.0 151.0 150.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 04:10:18 INFO - PID 11228 | Values: 96.0 94.0 95.0 96.0 94.0 94.0 94.0 94.0 94.0 94.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:3.12 (6.4%) stddev-sans-first:3.24 04:10:18 INFO - PID 11228 | Values: 51.0 46.0 49.0 47.0 47.0 57.0 48.0 50.0 48.0 49.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 04:10:18 INFO - PID 11228 | Values: 53.0 54.0 54.0 53.0 53.0 53.0 54.0 54.0 53.0 53.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.00 stddev:3.16 (4.2%) stddev-sans-first:3.18 04:10:18 INFO - PID 11228 | Values: 73.0 74.0 75.0 75.0 74.0 81.0 73.0 75.0 82.0 76.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:124.00 stddev:12.00 (9.7%) stddev-sans-first:12.71 04:10:18 INFO - PID 11228 | Values: 123.0 125.0 119.0 116.0 116.0 122.0 115.0 130.0 125.0 156.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:163.50 stddev:7.03 (4.3%) stddev-sans-first:7.21 04:10:18 INFO - PID 11228 | Values: 160.0 165.0 161.0 162.0 181.0 161.0 166.0 174.0 161.0 160.0 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.64 (2.6%) stddev-sans-first:1.72 04:10:18 INFO - PID 11228 | Values: 61.0 62.0 63.0 61.0 65.0 60.0 63.0 62.0 60.0 60.0 04:10:18 INFO - PID 11228 | -------- Summary: end -------- 04:10:18 INFO - PID 11228 | 04:10:18 INFO - PID 11228 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:10:19 INFO - TEST-INFO | 11228: exit 0 04:10:19 INFO - TEST-OK | kraken | took 59839ms 04:10:19 INFO - SUITE-END | took 1168s 04:10:19 INFO - Completed test suite (00:19:29) 04:10:19 INFO - javascript benchmark 04:10:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8977.858565635031, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3477.704395126414, 3483.4426491761305, 3494.790312581247, 3556.022093924171, 3562.1272788166903, 6160.137580738695, 6203.2245969253845, 6263.311035786066, 6270.435660790528, 6355.8093257202245, 6231.8753624927585, 6290.150829637997, 6319.462845658113, 6339.936600633992, 6382.840428989278, 5357.1696387060065, 5447.754851031693, 5575.219469274295, 5575.832725018236, 5594.832155035356, 5464.672119672832, 5487.341519017704, 5587.8603034924245, 5590.217369568264, 5591.133374326986, 5542.39033706294, 5542.8337149885165, 5601.019821531236, 5616.213730077792, 5631.774729010835, 5495.972520137414, 5519.2824932758485, 5575.498205161514, 5580.414056524088, 5595.804146854841, 5392.1911713242935, 5483.369412517572, 5496.725163741797, 5498.945010549884, 5505.697186654733, 6152.907706384408, 6180.3201647818705, 6190.442860142609, 6220.875582488325, 6233.594816336924, 6770.052192693027, 6822.795316140474, 6841.042254084432, 6843.555168914005, 6847.828804279883, 6857.005734168568, 6875.965620171867, 6880.380765731108, 6933.0293758873795, 6936.410405115521, 6211.968940155315, 6286.0, 6293.992961126198, 6387.457066149336, 6405.5836370636225, 6945.3766263466805, 6989.266127056586, 6997.860042799217, 7001.36987671112, 7017.4035207006955, 6678.131842860397, 6755.594664320157, 6761.357671021246, 6768.018637297663, 6779.525433219627, 6793.184817821893, 6820.215675197416, 6838.521303508806, 6878.793636190922, 6900.689468973908, 6659.53383263167, 6733.764318248838, 6741.460683145435, 6835.692393842289, 6841.213260475109, 6723.932760672428, 6747.426468750113, 6747.561408508432, 6751.966240168866, 6754.493412993947, 4924.63065270099, 4997.3253610762085, 5007.4241462231585, 5011.599072074226, 5017.598592112695, 4404.581564751344, 4416.514183439819, 4428.557144285545, 4434.800433980478, 4456.442944631921, 6383.616982981036, 6462.870742585122, 6472.838179045468, 6479.643619600967, 6532.314107018789, 6771.62756048422, 6793.388595026471, 6807.897881531781, 6874.587524748531, 6893.75871844483, 6505.7397704092255, 6527.249366322839, 6556.3443655634055, 6573.1783527059115, 6576.80269591913, 5607.158926161027, 5640.182173584807, 5696.088625819932, 5700.087985922315, 5700.9429905701245, 7057.50597458173, 7177.7487787927175, 7178.5692858428665, 7214.098237720285, 7321.890171647429, 6908.827279317856, 6925.411340036153, 6942.028116063856, 6945.305469453015, 6946.062281592122, 7123.893141602776, 7206.603636800026, 7291.453141014339, 7296.489245752747, 7316.304951029643, 6587.505937054644, 6700.2964688708935, 6715.5299129060495, 6718.227403848425, 6806.489513286622, 6837.145356830396, 6849.931500684929, 6873.0, 6893.724251029903, 6966.059581956573, 6552.246491653521, 6670.533062685566, 6714.697838597177, 6716.6977486012265, 6740.66296685154, 6653.2016158059405, 6667.733290668319, 6714.160729908762, 6732.697028633625, 6743.696533656095, 6521.5108866834225, 6634.535582509178, 6648.20221573395, 6687.063811066358, 6701.463882889455, 6680.498962577729, 6720.0591917132615, 6748.021536877027, 6785.660716964033, 6791.558548694319, 6426.0, 6493.0, 6554.606723596599, 6564.868702626016, 6580.21037475506], "value": 6217.1192164177555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.1981739763625, 887.7096116514324, 913.0595486648753, 933.8599210118481, 939.431643855467, 41536.16927661445, 42644.0, 42660.573394266044, 42678.99999999996, 42695.57304426955, 38510.807445962804, 38610.42084368737, 38787.61212387875, 38822.223555528944, 38950.0, 6819.352161544658, 6935.757248496304, 6936.202336731265, 6939.0, 6939.791806245821, 6808.6255255960905, 6920.238773734885, 6922.7923162305215, 6926.203486599055, 6926.37662610365, 6907.792766216997, 6928.792136235921, 7244.311790379906, 7314.049173607424, 7331.120265568113, 7289.708411663553, 7358.0, 7360.558366498028, 7363.410927125817, 7363.595002274873, 7424.703011879518, 7503.512271702377, 7504.549727016342, 7506.28690274423, 7512.624368781594, 39178.21643567113, 39214.41178382326, 39421.40867886984, 39455.0, 39537.40693889594, 3553.538040054802, 3561.4479755637917, 3571.624979377154, 3593.1735700788704, 3596.5504311961004, 31162.0, 31251.218719531968, 31280.21799455032, 31299.53050704241, 31313.686863131305, 5102.923456148161, 5109.284700141983, 5114.05390002847, 5151.716655583941, 5173.430922598511, 209984.0, 211688.0, 211747.0, 213095.0, 213203.0, 51886.0, 52064.479355205964, 52173.0, 52183.73908130435, 52270.29567338958, 54423.727881361134, 54522.454775452534, 54634.45365546294, 54812.45187548153, 54835.45164548383, 16672.916635416987, 16821.579460513585, 17020.72344574162, 17042.74435883463, 17056.403025894033, 13506.257155856325, 13554.796678049837, 13577.932110339385, 13590.116642418212, 13600.25198614066, 15047.398104075713, 15169.317380717894, 15171.772423413657, 15177.772333415007, 15426.228688565527, 5889.116632505158, 5923.940760592425, 5980.342162362137, 6077.392260773887, 6104.145419641254, 1075.370908018802, 1082.8592283003159, 1102.9393383363831, 1106.4025426269884, 1121.2319561100671, 24706.752932470805, 24751.3812154694, 24880.5023899521, 24906.626400603644, 25149.497010059695, 1209.5041033176356, 1216.9330686812134, 1218.469965564982, 1227.3924407418385, 1230.3786587773118, 13142.0, 13297.800532992012, 13347.46610135603, 13544.932275338757, 13545.525906593419, 286550.0, 288182.0, 290318.0, 291004.0, 292380.0, 50919.23621145686, 51789.741051295256, 55443.0, 55979.720101400046, 56783.0, 1510.0486693383318, 1521.7032678627784, 1527.0303357368152, 1541.8689411399932, 1550.4573399310152, 28302.574732162597, 29313.413731725672, 29358.559621605265, 29493.410131797675, 29705.405891882474, 40863.38704919369, 40863.7956810214, 40893.59106408898, 40950.0, 40950.79524602477, 159265.0, 159368.0, 160112.0, 160157.0, 160182.19908900847, 35409.46885796663, 38761.6123838758, 39272.607273928035, 39361.21277574375, 39399.606003939596, 47471.76264118657, 49162.262566060825, 49275.75362123166, 49306.0, 49601.50398495969, 36044.81977590095, 36195.0, 36423.0, 36629.26741465209, 36861.0, 35093.82453087718, 35110.12224694403, 35114.47328290129, 35185.0, 35372.46941295934, 41375.0, 41377.0, 41879.371809423494, 42048.15903681848, 42093.57906421019, 34631.0, 43491.34762978495, 43795.12409751723, 43975.78012109919, 44078.55921440873, 32196.517052243766, 32613.836930815192, 32700.0, 32742.34515309728, 33366.0], "value": 18190.77823319167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.5043087298612, 567.909134538474, 575.4475703324808, 585.1924344404723, 585.6339787632729, 17088.743668844963, 17636.911815440923, 17644.735328970077, 17720.911395443003, 23572.76427235727, 25768.355791105187, 27610.723892761067, 27625.0, 27691.58462623057, 27719.307017324525, 6296.874062518736, 6442.16251887254, 6442.871142577145, 6450.483961283109, 6461.19235095613, 6054.6367217966845, 6263.217097862767, 6266.060090986343, 6310.40051195138, 6318.652474113922, 6283.340249273829, 6295.653739044351, 6298.2442106947, 6301.40136687014, 6303.905441418382, 6280.403361680633, 6287.96856015717, 6289.213848268966, 6289.779857704958, 6294.244690637152, 5783.826485205451, 5807.157962095514, 5830.970845145789, 5847.26909136358, 5847.883042339172, 30321.393572128432, 31553.368932621448, 31597.21006974821, 31822.0, 32199.0, 2260.6495993121093, 2302.0, 2304.6543018547186, 2309.7228332600193, 2313.086330899302, 19950.304224140964, 20588.38234852942, 20593.279235226695, 20603.89698051515, 20613.690794638092, 2405.783479486837, 2432.97567024331, 2495.214007587604, 2495.9126430574843, 2512.5854234051358, 162600.18699906426, 167558.99999999878, 168405.0, 169244.0, 169625.15187424107, 15613.765793513106, 15815.841841581438, 15997.200139992954, 16001.439949601709, 16064.116473594064, 24263.514729705308, 24304.635430468556, 24320.756792432203, 24334.0, 24343.0, 10659.093977011886, 10896.0, 11067.778644427066, 11089.168312376603, 11110.277831940897, 10118.089371956412, 10207.693769186937, 10254.38473691566, 10273.383596984206, 10359.533820978075, 8531.573421328909, 9876.703698889045, 9902.80194396108, 9996.0, 10046.397216167054, 2651.2443953473166, 2659.6727863119772, 2717.388587567821, 2763.2401089700493, 2800.145955483597, 1021.3463383434607, 1074.6292529077455, 1075.8171110911164, 1076.839476137539, 1078.385320367383, 21663.35009949704, 21761.673574896387, 21830.89084554567, 21909.68541887492, 22742.09031638716, 1074.6883403812963, 1128.2384390536356, 1146.5814977533141, 1149.2357582207737, 1152.6023521885104, 11702.590409335802, 11996.940015300042, 12079.0, 12100.515979360727, 12106.455209515592, 594425.0, 597136.0, 607321.0, 610966.0, 611599.0, 139031.0, 140177.0, 142023.0, 142709.28645356707, 143188.28405857904, 1299.155548893208, 1339.5445548513553, 1370.766969615168, 1382.2812137688345, 1387.195426652539, 19124.808751912304, 19236.71144932855, 19313.4205973821, 19433.611327773648, 19775.70336444926, 63002.68498657477, 63583.36416635959, 66799.0, 68436.0, 69447.0, 82964.58517707374, 83293.58353208438, 83436.0, 83637.58181209055, 83706.0, 13134.60596182116, 13210.0, 14924.7761283583, 15385.461508847584, 15522.922385388001, 25311.114111006027, 25537.48925021452, 25848.741512584635, 25968.8701556491, 26002.479950400506, 20403.69394459114, 20592.382228533166, 20597.69103463479, 20753.688694669894, 20755.48111297169, 17298.308067677655, 17792.0, 17880.195391207686, 17931.193096310435, 18210.544736381697, 21100.788992109883, 21109.0, 21255.78744212538, 21318.253861114787, 21603.0, 15168.772468412762, 15206.771898421754, 15230.923845380703, 15309.775217982757, 15312.157831319384, 20607.690884637042, 20804.68792968137, 20873.68689469629, 21004.159833607097, 21091.683624745947], "value": 12786.13775168273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.831544372397, 1507.9095254284744, 1521.6119889428194, 1527.8166620005602, 1534.9869086402975, 15814.367425302988, 16495.917520412397, 16502.75245871313, 16509.587260318498, 16518.25667844947, 15676.0, 16968.066756328397, 16970.915145424256, 16978.0, 16986.0, 2537.8477291362483, 2594.922152335433, 2596.948061038778, 2598.674675915278, 2599.5970624553224, 2465.0879174705383, 2468.3582268610203, 2487.7263501014872, 2501.8123640726926, 2586.056089527328, 2506.9122580709677, 2523.73500782418, 2524.5203411351877, 2530.304166354249, 2533.3919859233742, 2463.6304554316816, 2476.5170791695627, 2480.119557557059, 2482.863442510661, 2487.8880450379775, 2441.572724773175, 2441.829071964963, 2450.705915290159, 2450.9632355514505, 2452.889619967106, 15899.60250993723, 16272.43046493367, 16311.592210194722, 16314.755278670711, 16327.428540001161, 8245.257926786559, 8562.914370856337, 8570.571471426403, 8573.699920502815, 8574.828503429959, 5044.520770526794, 5190.92213616796, 5264.9736751315995, 5324.361076670824, 5328.307320048408, 1880.501667058217, 1886.6415381077552, 1897.383350411122, 1927.315802889968, 1936.1480948382666, 28761.13716588506, 28829.135125946254, 28981.275468113254, 29016.70983290161, 29057.70942290571, 6399.8080057598345, 6570.113034740344, 6625.801225963229, 6680.665966701646, 6721.831954201184, 19564.21743130259, 19579.804201958083, 19602.31391901305, 19613.117409716597, 19642.90178549098, 8116.310113640407, 8373.665053397917, 8376.0, 8376.664933402595, 8381.622826972678, 7627.0, 7673.846523069507, 7748.147703752583, 7797.961010195027, 7814.21857814214, 5214.426413094557, 5411.485908838654, 5413.188021796684, 5415.241866138744, 5486.149646804752, 1400.0969374753226, 1442.819647544057, 1480.6890552983994, 1555.6422022934562, 1561.7657351397154, 967.7435479597913, 977.2848650618262, 984.478226539935, 1009.5053423822421, 1011.5549158370294, 9301.162895339452, 9716.271279654055, 9776.804463910825, 9816.214702823758, 9827.918928917956, 1014.3508154780947, 1045.628801775374, 1070.8768491623564, 1073.4310815267763, 1108.3626914524182, 5175.896482070338, 5629.296337957755, 6139.754409823647, 6561.934380656227, 6753.08833307507, 22617.20839770633, 23176.65235021476, 23326.300210993697, 23601.7639823603, 23686.407839803796, 22718.545629087657, 22999.655005174936, 23014.309570712907, 23029.07883684634, 23258.3022509325, 11068.28056176346, 11910.702232444259, 12139.575114871113, 12159.723229060997, 12241.449134788956, 9225.261979041527, 9544.711463952277, 9592.616295348107, 9594.472304023346, 9772.267079969173, 20413.38759837207, 20432.89783551073, 20733.067011984196, 20913.163473460892, 21539.8923005384, 21190.576188476454, 21253.555841078472, 21285.78714212838, 21331.72009679424, 21644.567108658055, 12774.552890649155, 13019.283939383045, 13328.0, 13330.400131994278, 13343.466261349437, 14763.261836908327, 14787.334569944163, 14828.481003164838, 14847.628809279855, 14917.627059323604, 11186.440677966231, 11203.775924481302, 11268.83096753533, 11337.489812958602, 11486.885131148581, 11536.134789890624, 11548.191626586058, 11584.826227606762, 11645.301281923112, 11869.0, 9868.457234852152, 10039.799204016024, 10050.24623153281, 10057.0, 10057.145142662956, 7976.361891048586, 8035.919640803751, 8106.108328084024, 8134.186581341818, 8140.796480088045, 7752.18602046777, 7914.525128492309, 7920.128785833669, 8011.399145064027, 8023.398245131521], "value": 7023.501215454182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.55385595286674, 527.2355085126568, 531.9862976239602, 536.9731513424329, 539.3096836049855, 6116.235470566174, 6118.235220597426, 6180.969095154518, 6190.8142755717345, 6231.283402408724, 5999.160117583542, 6003.369646187142, 6043.244594425697, 6112.510999120071, 6137.416945390192, 4857.29569212464, 4884.462709101996, 4891.682040667345, 4911.484294149116, 4945.455999840033, 4596.0, 4775.331453596499, 4821.4696383397795, 4902.19113846215, 4915.975420122894, 4698.553637404441, 4705.87059605362, 4724.62203023759, 4761.309610106532, 4789.5210478952, 4684.765761711901, 4700.529947005306, 4702.882427939312, 4722.834700785474, 4790.880227994293, 4224.176285624305, 4244.660427165819, 4270.612051083411, 4275.230458517465, 4277.807498662568, 5873.324567674729, 5941.435563621449, 5951.761929522814, 5993.520518358521, 6035.637861728311, 5664.518515926151, 5701.344345400291, 5716.256886604757, 5791.015527360359, 5802.0, 6462.386073323027, 6467.385598368148, 6529.5429319947625, 6551.901721474182, 6552.705128269239, 4861.246506791453, 4887.486813884527, 4909.140900342426, 4913.213885778258, 4937.7777999990085, 6596.208454985384, 6635.203775546917, 6668.266490686021, 6674.83312917181, 6806.5916045036965, 5012.573931215815, 5015.949840501548, 5052.292679024939, 5061.493850614983, 5062.341895553554, 5123.231515272664, 5133.537981581676, 5153.2270159476375, 5155.458676838953, 5163.922541161885, 5731.197632331477, 5733.964442622892, 5740.971295143498, 5746.770129194869, 5759.22250496186, 6420.678966051679, 6452.903206451907, 6518.804435866837, 6527.902081468782, 6631.469482441393, 1750.0637159120065, 1754.9824501755074, 1759.4897479730735, 1766.7968183658786, 1768.7435321878513, 1159.6115301373966, 1211.5941159711595, 1241.0443958152173, 1243.7450322683828, 1245.1470742541387, 6098.603590766586, 6331.715072821734, 6358.554901156875, 6375.74497020114, 6395.488360931115, 6547.9017814732815, 6603.448189675422, 6646.501512386591, 6665.266820649725, 6705.865882682417, 6136.6624835633575, 6269.498440124779, 6279.434850863444, 6294.181756371642, 6333.556651034475, 3481.4681540122265, 3535.8939231823088, 3544.2557063017057, 3553.34263161316, 3575.1955809943074, 7083.193785584746, 7086.858262834818, 7135.785926422215, 7154.177269613957, 7156.177039640508, 6760.695768690421, 6762.69567869447, 6828.2488926218075, 6935.653217339112, 6936.861262774716, 7070.611116388648, 7088.362047415861, 7098.68055937484, 7129.750458733919, 7219.8917016244795, 6592.868142637025, 6637.568558043712, 6663.666816659244, 6672.566283191577, 6776.45788336922, 6613.966930165318, 6654.269889828583, 6657.800265992028, 6663.13379260693, 6735.932640673531, 7064.894026589708, 7148.463865210234, 7149.0, 7183.03029091066, 7199.532030418006, 4999.750012499433, 5005.424376196638, 5015.1975683890405, 5054.1660625997765, 5061.6962982221185, 6494.188226471691, 6681.933180668131, 6712.429443497357, 6845.110135682329, 6845.828854278683, 6305.936940630535, 6529.412352888263, 6576.500929646703, 6587.341265873374, 6592.307807680317, 6493.155889734304, 6509.549938532586, 6514.967425162844, 6554.279029306867, 6569.37590928861, 6419.390157934989, 6514.218293804774, 6566.507511936528, 6571.934280657323, 6597.109390232257, 6553.344665533408, 6585.473162147113, 6592.340765923561, 6596.241432235354, 6608.966955165193, 6388.648624325707, 6401.743930242925, 6405.722392055718, 6414.0, 6420.972644376878], "value": 5088.01349329635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.2926403210189, 947.9383840050397, 973.3964941736125, 978.0, 981.2591493422465, 19728.408147755574, 20519.487012824688, 20522.999999999964, 20539.28112516062, 21758.456038599044, 19544.120514576844, 19607.451031365938, 19650.606987860236, 19667.0, 19668.704969425435, 999.6354975458502, 1044.185535282481, 1111.2776695148177, 1112.6383925224295, 1117.1788735279563, 1094.3324572011068, 1100.5707773968159, 1100.9229353945227, 1101.438266484091, 1101.6529793115144, 1085.782843431317, 1124.4714983957526, 1130.5195292000908, 1131.360781158647, 1132.162199972019, 1115.81031224692, 1117.1398023521842, 1120.775844831033, 1123.3652986062848, 1123.859517560305, 813.4996976859248, 817.546261824687, 823.045267489715, 823.1192623892438, 823.5429336718119, 20383.592328153503, 20598.897005515028, 20600.175992960263, 20618.072186751633, 20988.16047358104, 23133.190338338078, 23196.072157113696, 23340.2997910063, 23540.176093836806, 23724.64413033806, 17172.65654686899, 17344.306227750876, 17363.13184340778, 17516.73724894115, 17591.824081759274, 3757.1734218471893, 3779.527559055118, 3781.924361512782, 3783.281176576442, 3783.8675646352244, 142527.28736356253, 143300.0, 144140.0, 144334.27832860872, 145312.0, 15464.226788660748, 15609.453669121527, 15635.921820390826, 15645.217739112999, 15660.92169539145, 29383.706162938524, 29476.263093422836, 29544.261393464905, 30207.546886796717, 30420.239494012385, 7765.0, 8830.337724670675, 8845.159709827556, 8940.0, 9002.189802917768, 3675.081229692577, 3743.794091325003, 4201.873943781691, 4354.368616550582, 4362.083962367875, 5667.801626943037, 5749.223854779635, 5785.4214578541805, 5788.0449725795615, 5810.796622118206, 1168.293182624517, 1174.3834486894277, 1201.8437603111715, 1206.0592737664635, 1208.6011616166643, 700.2577268095835, 712.5973824788978, 713.1477883928656, 723.088907975954, 737.4505993035223, 12954.02844786626, 13232.272225027524, 13423.731525369438, 14463.349149288097, 14595.051321664057, 704.6864145455223, 710.8898120791285, 711.1146622455077, 730.477708438469, 731.6634348199781, 5915.231019967377, 7043.612601306875, 7262.636868156571, 7374.594397308199, 7461.664225109883, 122845.0, 126497.0, 126642.36678816547, 129624.0, 134113.0, 113667.0, 118055.0, 118385.0, 118860.0, 120760.0, 105366.0, 105797.0, 106755.0, 106776.0, 107352.99999999844, 14607.92696036513, 14683.632909177357, 14844.777328339867, 15171.089734615958, 15173.924130379719, 48020.27969580389, 50152.0, 51200.74399627978, 51204.48795511997, 51437.22844157415, 85224.0, 85646.14353856382, 86045.0, 87303.0, 91528.0, 19979.001049947154, 20266.79733202649, 20411.387658370273, 20472.283470078477, 20672.069756861278, 24511.142110026063, 24802.875985619958, 24824.25527234186, 24834.25497235086, 24971.250862474153, 20517.0, 20759.169633214504, 21146.0, 21903.890480547496, 22775.0, 21383.46541336479, 21467.0, 21508.354749357546, 22029.339119826433, 22509.324720258417, 20224.494387640425, 20259.493512662302, 21434.6784798225, 21639.891800540896, 22302.553948921257, 14314.785278220626, 14487.348069336695, 14491.637709057359, 14660.266986650839, 14746.11523308605, 16668.916520426134, 17088.23102960345, 17199.398021069203, 17373.56566085858, 17924.641507170043], "value": 10132.749121083329, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 105.0, 106.0, 109.0, 108.0, 100.0, 106.0, 109.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 137.0, 160.0, 115.0, 147.0, 149.0, 123.0, 167.0, 112.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 163.0, 161.0, 163.0, 164.0, 161.0, 170.0, 166.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 138.0, 74.0, 75.0, 73.0, 80.0, 93.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 134.0, 80.0, 78.0, 78.0, 127.0, 78.0, 79.0, 132.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 115.0, 116.0, 114.0, 115.0, 115.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 150.0, 151.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 46.0, 49.0, 47.0, 47.0, 57.0, 48.0, 50.0, 48.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 75.0, 74.0, 81.0, 73.0, 75.0, 82.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 119.0, 116.0, 116.0, 122.0, 115.0, 130.0, 125.0, 156.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 161.0, 162.0, 181.0, 161.0, 166.0, 174.0, 161.0, 160.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 61.0, 65.0, 60.0, 63.0, 62.0, 60.0, 60.0], "value": 61.7, "unit": "score"}]}]} 04:10:19 INFO - Return code: 0 04:10:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:19 INFO - # TBPL SUCCESS # 04:10:19 INFO - Running post-action listener: _package_coverage_data 04:10:19 INFO - Running post-action listener: _resource_record_post_action 04:10:19 INFO - [mozharness: 2017-08-15 11:10:19.607719Z] Finished run-tests step (success) 04:10:19 INFO - Running post-run listener: _resource_record_post_run 04:10:19 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 507904; Write bytes: 428060672; Read time: 440; Write time: 296360 04:10:19 INFO - TinderboxPrint: CPU usage
13.0% 04:10:19 INFO - TinderboxPrint: I/O read bytes / time
507,904 / 440 04:10:19 INFO - TinderboxPrint: I/O write bytes / time
428,060,672 / 296,360 04:10:19 INFO - TinderboxPrint: CPU idle
8,230.1 (86.9%) 04:10:19 INFO - TinderboxPrint: CPU user
1,187.4 (12.5%) 04:10:19 INFO - TinderboxPrint: Swap in / out
0 / 0 04:10:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108060672; Read time: 32; Write time: 93348 04:10:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:10:19 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 499712; Write bytes: 320000000; Read time: 392; Write time: 203012 04:10:20 INFO - Running post-run listener: _upload_blobber_files 04:10:20 INFO - Blob upload gear active. 04:10:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:20 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 04:10:20 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'] 04:10:20 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 04:10:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:21 INFO - (blobuploader) - INFO - Done attempting. 04:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:10:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:27 INFO - (blobuploader) - INFO - Done attempting. 04:10:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:10:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:28 INFO - (blobuploader) - INFO - Done attempting. 04:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:28 INFO - (blobuploader) - INFO - Done attempting. 04:10:28 INFO - (blobuploader) - INFO - Iteration through files over. 04:10:28 INFO - Return code: 0 04:10:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:10:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:10:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70db7d7ffb1cbf8daeef50901b5e9738e8b319b740512f41eda798fcccadd2e5cb54c13a8ca8632f0243fa0056e032aacfce82649a8a5ceade89ad4856d6cc5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2611805ae767dadf65d20210645c10f86163b720da6810642ba81e8c52a3034f591edaa8608844411728f882d789c4a43ee4d6f5a17c91f2015b7f87354f06f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f6b1a1d3ade360ebe22e6e58711e16077e06bf99ee451205fa293635ec0e05a0221acad4e9e8166ff6df2ae07d5c1d717b4dddd26a72e3839a6f76ba7c1f551", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb25b1cf1f80f930a4303fc2e2c07ec5502d787c83cbf4a5edc91ac8180109eb733c8ad0c5d342162f90b6ec0b2d09af87e4a076d0bbda299c026c27904ec8a6"} 04:10:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:10:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:10:28 INFO - Contents: 04:10:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70db7d7ffb1cbf8daeef50901b5e9738e8b319b740512f41eda798fcccadd2e5cb54c13a8ca8632f0243fa0056e032aacfce82649a8a5ceade89ad4856d6cc5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2611805ae767dadf65d20210645c10f86163b720da6810642ba81e8c52a3034f591edaa8608844411728f882d789c4a43ee4d6f5a17c91f2015b7f87354f06f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f6b1a1d3ade360ebe22e6e58711e16077e06bf99ee451205fa293635ec0e05a0221acad4e9e8166ff6df2ae07d5c1d717b4dddd26a72e3839a6f76ba7c1f551", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb25b1cf1f80f930a4303fc2e2c07ec5502d787c83cbf4a5edc91ac8180109eb733c8ad0c5d342162f90b6ec0b2d09af87e4a076d0bbda299c026c27904ec8a6"} 04:10:28 INFO - Running post-run listener: copy_logs_to_upload_dir 04:10:28 INFO - Copying logs to upload dir... 04:10:28 INFO - mkdir: /builds/slave/test/build/upload/logs 04:10:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.436406 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-15 04:10:28.834404) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 04:10:28.841819) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398 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/70db7d7ffb1cbf8daeef50901b5e9738e8b319b740512f41eda798fcccadd2e5cb54c13a8ca8632f0243fa0056e032aacfce82649a8a5ceade89ad4856d6cc5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2611805ae767dadf65d20210645c10f86163b720da6810642ba81e8c52a3034f591edaa8608844411728f882d789c4a43ee4d6f5a17c91f2015b7f87354f06f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f6b1a1d3ade360ebe22e6e58711e16077e06bf99ee451205fa293635ec0e05a0221acad4e9e8166ff6df2ae07d5c1d717b4dddd26a72e3839a6f76ba7c1f551", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb25b1cf1f80f930a4303fc2e2c07ec5502d787c83cbf4a5edc91ac8180109eb733c8ad0c5d342162f90b6ec0b2d09af87e4a076d0bbda299c026c27904ec8a6"} build_url:https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/dPeEm1b8QimBX70wkiHc0w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70db7d7ffb1cbf8daeef50901b5e9738e8b319b740512f41eda798fcccadd2e5cb54c13a8ca8632f0243fa0056e032aacfce82649a8a5ceade89ad4856d6cc5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2611805ae767dadf65d20210645c10f86163b720da6810642ba81e8c52a3034f591edaa8608844411728f882d789c4a43ee4d6f5a17c91f2015b7f87354f06f3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f6b1a1d3ade360ebe22e6e58711e16077e06bf99ee451205fa293635ec0e05a0221acad4e9e8166ff6df2ae07d5c1d717b4dddd26a72e3839a6f76ba7c1f551", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb25b1cf1f80f930a4303fc2e2c07ec5502d787c83cbf4a5edc91ac8180109eb733c8ad0c5d342162f90b6ec0b2d09af87e4a076d0bbda299c026c27904ec8a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 04:10:28.871251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 04:10:28.871608) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502794148.145446-1824141398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004794 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 04:10:28.951273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 04:10:28.954665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 04:10:28.955009) ========= ========= Total master_lag: 0.20 =========