builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1501756452.64 results: success (0) revision: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.639488) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.639870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.640138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.664897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.665165) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 03:34:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.5M=0s 2017-08-03 03:34:13 (86.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.831058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.831376) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020599 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.884383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-03 03:34:12.884673) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 681a2489f6a92a09f87336c4ebfcd55030ffcda1 --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 681a2489f6a92a09f87336c4ebfcd55030ffcda1 --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=3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 03:34:13,144 truncating revision to first 12 chars 2017-08-03 03:34:13,144 Setting DEBUG logging. 2017-08-03 03:34:13,144 attempt 1/10 2017-08-03 03:34:13,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/681a2489f6a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 03:34:14,020 unpacking tar archive at: mozilla-central-681a2489f6a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-03 03:34:14.132230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:14.132532) ========= script_repo_revision: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:14.133164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:14.133429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:14.141596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-03 03:34:14.141883) ========= /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=3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:14 INFO - MultiFileLogger online at 20170803 03:34:14 in /builds/slave/test 03:34:14 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:34:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:14 INFO - {'append_to_log': False, 03:34:14 INFO - 'base_work_dir': '/builds/slave/test', 03:34:14 INFO - 'blob_upload_branch': 'Firefox', 03:34:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:14 INFO - 'branch': 'Firefox', 03:34:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:14 INFO - 'code_coverage': False, 03:34:14 INFO - 'config_files': ('talos/linux_config.py',), 03:34:14 INFO - 'default_actions': ('clobber', 03:34:14 INFO - 'read-buildbot-config', 03:34:14 INFO - 'download-and-extract', 03:34:14 INFO - 'populate-webroot', 03:34:14 INFO - 'create-virtualenv', 03:34:14 INFO - 'install', 03:34:14 INFO - 'setup-mitmproxy', 03:34:14 INFO - 'run-tests'), 03:34:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:14 INFO - 'disable_ccov_upload': False, 03:34:14 INFO - 'download_minidump_stackwalk': True, 03:34:14 INFO - 'download_symbols': 'ondemand', 03:34:14 INFO - 'enable_stylo': False, 03:34:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:14 INFO - 'gecko_profile': False, 03:34:14 INFO - 'gecko_profile_interval': 0, 03:34:14 INFO - 'installer_path': 'installer.exe', 03:34:14 INFO - 'log_level': 'info', 03:34:14 INFO - 'log_name': 'talos', 03:34:14 INFO - 'log_to_console': True, 03:34:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:14 INFO - 'opt_config_files': (), 03:34:14 INFO - 'pip_index': False, 03:34:14 INFO - 'suite': 'dromaeojs-e10s', 03:34:14 INFO - 'system_bits': '32', 03:34:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:14 INFO - 'title': 'talos-linux64-ix-083', 03:34:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:14 INFO - 'use_talos_json': True, 03:34:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:14 INFO - 'work_dir': 'build'} 03:34:14 INFO - [mozharness: 2017-08-03 10:34:14.504114Z] Running clobber step. 03:34:14 INFO - Running pre-action listener: _resource_record_pre_action 03:34:14 INFO - Running main action method: clobber 03:34:14 INFO - rmtree: /builds/slave/test/build 03:34:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:15 INFO - Running post-action listener: _resource_record_post_action 03:34:15 INFO - [mozharness: 2017-08-03 10:34:15.528346Z] Finished clobber step (success) 03:34:15 INFO - [mozharness: 2017-08-03 10:34:15.528448Z] Running read-buildbot-config step. 03:34:15 INFO - Running pre-action listener: _resource_record_pre_action 03:34:15 INFO - Running main action method: read_buildbot_config 03:34:15 INFO - Using buildbot properties: 03:34:15 INFO - { 03:34:15 INFO - "project": "", 03:34:15 INFO - "product": "firefox", 03:34:15 INFO - "who": "archaeopteryx@coole-files.de", 03:34:15 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:34:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:15 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:34:15 INFO - "stage_platform": "linux64-stylo", 03:34:15 INFO - "basedir": "/builds/slave/test", 03:34:15 INFO - "buildnumber": 253, 03:34:15 INFO - "platform": "ubuntu64_hw_stylo", 03:34:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:34:15 INFO - "slavebuilddir": "test", 03:34:15 INFO - "taskId": "LnT-rPfWRlyG7F4usdi9CQ", 03:34:15 INFO - "branch": "mozilla-central", 03:34:15 INFO - "script_repo_revision": "production", 03:34:15 INFO - "revision": "681a2489f6a92a09f87336c4ebfcd55030ffcda1", 03:34:15 INFO - "slavename": "talos-linux64-ix-083", 03:34:15 INFO - "repo_path": "mozilla-central" 03:34:15 INFO - } 03:34:15 INFO - Finding installer, test and symbols from parent task. 03:34:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnT-rPfWRlyG7F4usdi9CQ'}, attempt #1 03:34:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnT-rPfWRlyG7F4usdi9CQ'}, attempt #1 03:34:16 INFO - Task dependencies: ZeSY-_-GThiB0d3w2ugulQ 03:34:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ'}, attempt #1 03:34:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 03:34:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.test_packages.json 03:34:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.crashreporter-symbols.zip 03:34:16 INFO - Running post-action listener: _resource_record_post_action 03:34:16 INFO - [mozharness: 2017-08-03 10:34:16.913472Z] Finished read-buildbot-config step (success) 03:34:16 INFO - [mozharness: 2017-08-03 10:34:16.913696Z] Running download-and-extract step. 03:34:16 INFO - Running pre-action listener: _resource_record_pre_action 03:34:16 INFO - Running main action method: download_and_extract 03:34:16 INFO - mkdir: /builds/slave/test/build/tests 03:34: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:34:16 INFO - trying https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.test_packages.json 03:34:16 INFO - Downloading https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:34:17 INFO - Downloaded 989 bytes. 03:34:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:17 INFO - Using the following test package requirements: 03:34:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:17 INFO - u'common': [u'target.common.tests.zip'], 03:34:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:17 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:17 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:17 INFO - u'target.web-platform.tests.tar.gz'], 03:34:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.common.tests.zip 03:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.common.tests.zip into memory 03:34:18 INFO - Content-Length response header: 54278247 03:34:18 INFO - Bytes received: 54278247 03:34:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:34:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.common.tests.zip 03:34:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:34:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.common.tests.zip into memory 03:34:30 INFO - Content-Length response header: 54278247 03:34:30 INFO - Bytes received: 54278247 03:34:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.talos.tests.zip 03:34:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:34:42 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.talos.tests.zip into memory 03:34:43 INFO - Content-Length response header: 14496464 03:34:43 INFO - Bytes received: 14496464 03:34:43 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:34:43 INFO - trying https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 03:34:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:34:46 INFO - Downloaded 62237698 bytes. 03:34:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 03:34:46 INFO - mkdir: /builds/slave/test/properties 03:34:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:46 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:46 INFO - Contents: 03:34:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 03:34:46 INFO - Running post-action listener: _resource_record_post_action 03:34:46 INFO - Running post-action listener: set_extra_try_arguments 03:34:46 INFO - [mozharness: 2017-08-03 10:34:46.374383Z] Finished download-and-extract step (success) 03:34:46 INFO - [mozharness: 2017-08-03 10:34:46.374613Z] Running populate-webroot step. 03:34:46 INFO - Running pre-action listener: _resource_record_pre_action 03:34:46 INFO - Running main action method: populate_webroot 03:34:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:46 INFO - 'tests': ['damp', 'tps']}, 03:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:46 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:46 INFO - 'ts_paint', 03:34:46 INFO - 'tpaint', 03:34:46 INFO - 'sessionrestore', 03:34:46 INFO - 'sessionrestore_many_windows', 03:34:46 INFO - 'sessionrestore_no_auto_restore', 03:34:46 INFO - 'tabpaint']}, 03:34:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:46 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:46 INFO - 'talos_options': ['--mitmproxy', 03:34:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:46 INFO - '--firstNonBlankPaint'], 03:34:46 INFO - 'tests': ['quantum_pageload_google', 03:34:46 INFO - 'quantum_pageload_youtube', 03:34:46 INFO - 'quantum_pageload_amazon', 03:34:46 INFO - 'quantum_pageload_facebook']}, 03:34:46 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:46 INFO - 'talos_options': ['--stylo', 03:34:46 INFO - '--mitmproxy', 03:34:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:46 INFO - '--firstNonBlankPaint'], 03:34:46 INFO - 'tests': ['quantum_pageload_google', 03:34:46 INFO - 'quantum_pageload_youtube', 03:34:46 INFO - 'quantum_pageload_amazon', 03:34:46 INFO - 'quantum_pageload_facebook']}, 03:34:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:46 INFO - 'tsvgr_opacity', 03:34:46 INFO - 'tart', 03:34:46 INFO - 'tscrollx', 03:34:46 INFO - 'cart', 03:34:46 INFO - 'tsvg_static']}, 03:34:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:46 INFO - 'talos_options': ['--stylo', 03:34:46 INFO - '--stylo-threads=1', 03:34:46 INFO - '--mitmproxy', 03:34:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:46 INFO - '--firstNonBlankPaint'], 03:34:46 INFO - 'tests': ['tp6_google', 03:34:46 INFO - 'tp6_youtube', 03:34:46 INFO - 'tp6_amazon', 03:34:46 INFO - 'tp6_facebook']}, 03:34:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:46 INFO - 'talos_options': ['--xperf_path', 03:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:46 INFO - 'tests': ['tp5n']}}} 03:34:46 INFO - Running post-action listener: _resource_record_post_action 03:34:46 INFO - [mozharness: 2017-08-03 10:34:46.390020Z] Finished populate-webroot step (success) 03:34:46 INFO - [mozharness: 2017-08-03 10:34:46.390111Z] Running create-virtualenv step. 03:34:46 INFO - Running pre-action listener: _resource_record_pre_action 03:34:46 INFO - Running main action method: create_virtualenv 03:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:46 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:34:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:46 INFO - Using real prefix '/usr' 03:34:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:48 INFO - Installing pip.................done. 03:34:48 INFO - Return code: 0 03:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:49 INFO - Reading from file tmpfile_stdout 03:34:49 INFO - Output received: 03:34:49 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:34:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34: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:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:49 INFO - Using env: {'DISPLAY': ':0', 03:34:49 INFO - 'HOME': '/home/cltbld', 03:34:49 INFO - 'LANG': 'en_US.UTF-8', 03:34:49 INFO - 'LANGUAGE': 'en_US:en', 03:34:49 INFO - 'LOGNAME': 'cltbld', 03:34:49 INFO - 'MAIL': '/var/mail/cltbld', 03:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:49 INFO - 'MOZ_NO_REMOTE': '1', 03:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:49 INFO - 'NO_EM_RESTART': '1', 03:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:49 INFO - 'PWD': '/builds/slave/test', 03:34:49 INFO - 'SHELL': '/bin/bash', 03:34:49 INFO - 'SHLVL': '1', 03:34:49 INFO - 'TERM': 'linux', 03:34:49 INFO - 'TMOUT': '86400', 03:34:49 INFO - 'USER': 'cltbld', 03:34:49 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:49 INFO - '_': '/tools/buildbot/bin/python'} 03:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:49 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:34:49 INFO - Cleaning up... 03:34:49 INFO - Return code: 0 03:34:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34: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:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:49 INFO - Using env: {'DISPLAY': ':0', 03:34:49 INFO - 'HOME': '/home/cltbld', 03:34:49 INFO - 'LANG': 'en_US.UTF-8', 03:34:49 INFO - 'LANGUAGE': 'en_US:en', 03:34:49 INFO - 'LOGNAME': 'cltbld', 03:34:49 INFO - 'MAIL': '/var/mail/cltbld', 03:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:49 INFO - 'MOZ_NO_REMOTE': '1', 03:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:49 INFO - 'NO_EM_RESTART': '1', 03:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:49 INFO - 'PWD': '/builds/slave/test', 03:34:49 INFO - 'SHELL': '/bin/bash', 03:34:49 INFO - 'SHLVL': '1', 03:34:49 INFO - 'TERM': 'linux', 03:34:49 INFO - 'TMOUT': '86400', 03:34:49 INFO - 'USER': 'cltbld', 03:34:49 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:49 INFO - '_': '/tools/buildbot/bin/python'} 03:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:49 INFO - Downloading/unpacking psutil>=3.1.1 03:34:49 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:34:49 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:34:49 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:34:49 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:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:50 INFO - Installing collected packages: psutil 03:34:50 INFO - Running setup.py install for psutil 03:34:50 INFO - building 'psutil._psutil_linux' extension 03:34:50 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:34:51 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:34:51 INFO - building 'psutil._psutil_posix' extension 03:34:51 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:34:51 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:34:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:51 INFO - Successfully installed psutil 03:34:51 INFO - Cleaning up... 03:34:51 INFO - Return code: 0 03:34:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:51 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:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:51 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:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:51 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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:51 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:34:51 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:34:51 INFO - Using env: {'DISPLAY': ':0', 03:34:51 INFO - 'HOME': '/home/cltbld', 03:34:51 INFO - 'LANG': 'en_US.UTF-8', 03:34:51 INFO - 'LANGUAGE': 'en_US:en', 03:34:51 INFO - 'LOGNAME': 'cltbld', 03:34:51 INFO - 'MAIL': '/var/mail/cltbld', 03:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:51 INFO - 'MOZ_NO_REMOTE': '1', 03:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:51 INFO - 'NO_EM_RESTART': '1', 03:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:51 INFO - 'PWD': '/builds/slave/test', 03:34:51 INFO - 'SHELL': '/bin/bash', 03:34:51 INFO - 'SHLVL': '1', 03:34:51 INFO - 'TERM': 'linux', 03:34:51 INFO - 'TMOUT': '86400', 03:34:51 INFO - 'USER': 'cltbld', 03:34:51 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:51 INFO - '_': '/tools/buildbot/bin/python'} 03:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:51 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:34:51 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:34:51 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:34:51 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:34:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:52 INFO - Installing collected packages: mozsystemmonitor 03:34:52 INFO - Running setup.py install for mozsystemmonitor 03:34:52 INFO - Successfully installed mozsystemmonitor 03:34:52 INFO - Cleaning up... 03:34:52 INFO - Return code: 0 03:34:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:52 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:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:52 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:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:52 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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:52 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:34:52 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:34:52 INFO - Using env: {'DISPLAY': ':0', 03:34:52 INFO - 'HOME': '/home/cltbld', 03:34:52 INFO - 'LANG': 'en_US.UTF-8', 03:34:52 INFO - 'LANGUAGE': 'en_US:en', 03:34:52 INFO - 'LOGNAME': 'cltbld', 03:34:52 INFO - 'MAIL': '/var/mail/cltbld', 03:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:52 INFO - 'MOZ_NO_REMOTE': '1', 03:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:52 INFO - 'NO_EM_RESTART': '1', 03:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:52 INFO - 'PWD': '/builds/slave/test', 03:34:52 INFO - 'SHELL': '/bin/bash', 03:34:52 INFO - 'SHLVL': '1', 03:34:52 INFO - 'TERM': 'linux', 03:34:52 INFO - 'TMOUT': '86400', 03:34:52 INFO - 'USER': 'cltbld', 03:34:52 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:52 INFO - '_': '/tools/buildbot/bin/python'} 03:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:53 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:34:53 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:34:53 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:34:53 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:34:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:54 INFO - warning: no files found matching '*.txt' 03:34:54 INFO - no previously-included directories found matching 'build' 03:34:54 INFO - no previously-included directories found matching 'dist' 03:34:54 INFO - no previously-included directories found matching '.git*' 03:34:54 INFO - Installing collected packages: jsonschema, functools32 03:34:54 INFO - Running setup.py install for functools32 03:34:54 INFO - warning: no files found matching '*.txt' 03:34:54 INFO - no previously-included directories found matching 'build' 03:34:54 INFO - no previously-included directories found matching 'dist' 03:34:54 INFO - no previously-included directories found matching '.git*' 03:34:54 INFO - Successfully installed jsonschema functools32 03:34:54 INFO - Cleaning up... 03:34:54 INFO - Return code: 0 03:34:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:34:54 INFO - Using env: {'DISPLAY': ':0', 03:34:54 INFO - 'HOME': '/home/cltbld', 03:34:54 INFO - 'LANG': 'en_US.UTF-8', 03:34:54 INFO - 'LANGUAGE': 'en_US:en', 03:34:54 INFO - 'LOGNAME': 'cltbld', 03:34:54 INFO - 'MAIL': '/var/mail/cltbld', 03:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:54 INFO - 'MOZ_NO_REMOTE': '1', 03:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:54 INFO - 'NO_EM_RESTART': '1', 03:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:54 INFO - 'PWD': '/builds/slave/test', 03:34:54 INFO - 'SHELL': '/bin/bash', 03:34:54 INFO - 'SHLVL': '1', 03:34:54 INFO - 'TERM': 'linux', 03:34:54 INFO - 'TMOUT': '86400', 03:34:54 INFO - 'USER': 'cltbld', 03:34:54 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:54 INFO - '_': '/tools/buildbot/bin/python'} 03:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:54 INFO - Cleaning up... 03:34:54 INFO - Return code: 0 03:34:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:54 INFO - Using env: {'DISPLAY': ':0', 03:34:54 INFO - 'HOME': '/home/cltbld', 03:34:54 INFO - 'LANG': 'en_US.UTF-8', 03:34:54 INFO - 'LANGUAGE': 'en_US:en', 03:34:54 INFO - 'LOGNAME': 'cltbld', 03:34:54 INFO - 'MAIL': '/var/mail/cltbld', 03:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:54 INFO - 'MOZ_NO_REMOTE': '1', 03:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:54 INFO - 'NO_EM_RESTART': '1', 03:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:54 INFO - 'PWD': '/builds/slave/test', 03:34:54 INFO - 'SHELL': '/bin/bash', 03:34:54 INFO - 'SHLVL': '1', 03:34:54 INFO - 'TERM': 'linux', 03:34:54 INFO - 'TMOUT': '86400', 03:34:54 INFO - 'USER': 'cltbld', 03:34:54 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:54 INFO - '_': '/tools/buildbot/bin/python'} 03:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:56 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:34:56 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:34:56 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:34:56 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:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:56 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:34:56 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:34:56 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:34:56 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:34:56 INFO - Downloading docopt-0.6.1.tar.gz 03:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:56 INFO - Running setup.py install for blobuploader 03:34:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:56 INFO - Running setup.py install for requests 03:34:57 INFO - Running setup.py install for docopt 03:34:57 INFO - Successfully installed blobuploader requests docopt 03:34:57 INFO - Cleaning up... 03:34:57 INFO - Return code: 0 03:34:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:57 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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:34:57 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:34:57 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:34:57 INFO - Using env: {'DISPLAY': ':0', 03:34:57 INFO - 'HOME': '/home/cltbld', 03:34:57 INFO - 'LANG': 'en_US.UTF-8', 03:34:57 INFO - 'LANGUAGE': 'en_US:en', 03:34:57 INFO - 'LOGNAME': 'cltbld', 03:34:57 INFO - 'MAIL': '/var/mail/cltbld', 03:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:57 INFO - 'MOZ_NO_REMOTE': '1', 03:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:57 INFO - 'NO_EM_RESTART': '1', 03:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:57 INFO - 'PWD': '/builds/slave/test', 03:34:57 INFO - 'SHELL': '/bin/bash', 03:34:57 INFO - 'SHLVL': '1', 03:34:57 INFO - 'TERM': 'linux', 03:34:57 INFO - 'TMOUT': '86400', 03:34:57 INFO - 'USER': 'cltbld', 03:34:57 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:57 INFO - '_': '/tools/buildbot/bin/python'} 03:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:57 INFO - Running setup.py (path:/tmp/pip-svzkbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:57 INFO - Running setup.py (path:/tmp/pip-M8hlz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:57 INFO - Running setup.py (path:/tmp/pip-xjuIGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:57 INFO - Running setup.py (path:/tmp/pip-BZvPuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:57 INFO - Running setup.py (path:/tmp/pip-cCKVMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:57 INFO - Running setup.py (path:/tmp/pip-dMf9vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:57 INFO - Running setup.py (path:/tmp/pip-IZwufn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:57 INFO - Running setup.py (path:/tmp/pip-1I3FL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:57 INFO - Running setup.py (path:/tmp/pip-n1RNMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:58 INFO - Running setup.py (path:/tmp/pip-ni63Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:58 INFO - Running setup.py (path:/tmp/pip-FhBRNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:58 INFO - Running setup.py (path:/tmp/pip-9p11Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:58 INFO - Running setup.py (path:/tmp/pip-o6crGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:58 INFO - Running setup.py (path:/tmp/pip-fR6F18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:58 INFO - Running setup.py (path:/tmp/pip-66tanR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:58 INFO - Running setup.py (path:/tmp/pip-38IZaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:58 INFO - Running setup.py (path:/tmp/pip-H_yuY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:58 INFO - Running setup.py install for manifestparser 03:34:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:58 INFO - Running setup.py install for mozcrash 03:34:58 INFO - Running setup.py install for mozdebug 03:34:58 INFO - Running setup.py install for mozdevice 03:34:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for mozfile 03:34:59 INFO - Running setup.py install for mozhttpd 03:34:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for mozinfo 03:34:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for mozInstall 03:34:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for mozleak 03:34:59 INFO - Running setup.py install for mozlog 03:34:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for moznetwork 03:34:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for mozprocess 03:34:59 INFO - Running setup.py install for mozprofile 03:34:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:59 INFO - Running setup.py install for mozrunner 03:35:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:00 INFO - Running setup.py install for mozscreenshot 03:35:00 INFO - Running setup.py install for moztest 03:35:00 INFO - Running setup.py install for mozversion 03:35:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:00 INFO - Cleaning up... 03:35:00 INFO - Return code: 0 03:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:00 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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:35:00 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:35:00 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:35:00 INFO - Using env: {'DISPLAY': ':0', 03:35:00 INFO - 'HOME': '/home/cltbld', 03:35:00 INFO - 'LANG': 'en_US.UTF-8', 03:35:00 INFO - 'LANGUAGE': 'en_US:en', 03:35:00 INFO - 'LOGNAME': 'cltbld', 03:35:00 INFO - 'MAIL': '/var/mail/cltbld', 03:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:00 INFO - 'MOZ_NO_REMOTE': '1', 03:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:00 INFO - 'NO_EM_RESTART': '1', 03:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:00 INFO - 'PWD': '/builds/slave/test', 03:35:00 INFO - 'SHELL': '/bin/bash', 03:35:00 INFO - 'SHLVL': '1', 03:35:00 INFO - 'TERM': 'linux', 03:35:00 INFO - 'TMOUT': '86400', 03:35:00 INFO - 'USER': 'cltbld', 03:35:00 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:00 INFO - '_': '/tools/buildbot/bin/python'} 03:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:00 INFO - Running setup.py (path:/tmp/pip-wvk04R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:00 INFO - Running setup.py (path:/tmp/pip-_X9T9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:00 INFO - Running setup.py (path:/tmp/pip-UHsMAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:00 INFO - Running setup.py (path:/tmp/pip-rXFChI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:00 INFO - Running setup.py (path:/tmp/pip-QwsFbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:00 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:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:00 INFO - Running setup.py (path:/tmp/pip-vzjd1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:01 INFO - Running setup.py (path:/tmp/pip-ApHLBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:01 INFO - Running setup.py (path:/tmp/pip-CZugnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:01 INFO - Running setup.py (path:/tmp/pip-P3W2CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:01 INFO - Running setup.py (path:/tmp/pip-qy0Nud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:01 INFO - Running setup.py (path:/tmp/pip-jkQCCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:01 INFO - Running setup.py (path:/tmp/pip-JtJ1Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:01 INFO - Running setup.py (path:/tmp/pip-OY3LxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:01 INFO - Running setup.py (path:/tmp/pip-fjPnQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:01 INFO - Running setup.py (path:/tmp/pip-nSefXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:01 INFO - Running setup.py (path:/tmp/pip-P69GCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:01 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:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:01 INFO - Running setup.py (path:/tmp/pip-2lhHvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:02 INFO - Downloading blessings-1.6.tar.gz 03:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:03 INFO - Installing collected packages: blessings 03:35:03 INFO - Running setup.py install for blessings 03:35:03 INFO - Successfully installed blessings 03:35:03 INFO - Cleaning up... 03:35:03 INFO - Return code: 0 03:35:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:03 INFO - Reading from file tmpfile_stdout 03:35:03 INFO - Current package versions: 03:35:03 INFO - argparse == 1.2.1 03:35:03 INFO - blessings == 1.6 03:35:03 INFO - blobuploader == 1.2.4 03:35:03 INFO - docopt == 0.6.1 03:35:03 INFO - functools32 == 3.2.3-2 03:35:03 INFO - jsonschema == 2.5.1 03:35:03 INFO - manifestparser == 1.1 03:35:03 INFO - mozInstall == 1.13 03:35:03 INFO - mozcrash == 1.0 03:35:03 INFO - mozdebug == 0.1 03:35:03 INFO - mozdevice == 0.51 03:35:03 INFO - mozfile == 1.2 03:35:03 INFO - mozhttpd == 0.7 03:35:03 INFO - mozinfo == 0.10 03:35:03 INFO - mozleak == 0.1 03:35:03 INFO - mozlog == 3.5 03:35:03 INFO - moznetwork == 0.27 03:35:03 INFO - mozprocess == 0.25 03:35:03 INFO - mozprofile == 0.28 03:35:03 INFO - mozrunner == 6.13 03:35:03 INFO - mozscreenshot == 0.1 03:35:03 INFO - mozsystemmonitor == 0.3 03:35:03 INFO - moztest == 0.8 03:35:03 INFO - mozversion == 1.4 03:35:03 INFO - psutil == 3.1.1 03:35:03 INFO - requests == 1.2.3 03:35:03 INFO - wsgiref == 0.1.2 03:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:03 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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:35:03 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:35:03 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:35:03 INFO - Using env: {'DISPLAY': ':0', 03:35:03 INFO - 'HOME': '/home/cltbld', 03:35:03 INFO - 'LANG': 'en_US.UTF-8', 03:35:03 INFO - 'LANGUAGE': 'en_US:en', 03:35:03 INFO - 'LOGNAME': 'cltbld', 03:35:03 INFO - 'MAIL': '/var/mail/cltbld', 03:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:03 INFO - 'MOZ_NO_REMOTE': '1', 03:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:03 INFO - 'NO_EM_RESTART': '1', 03:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:03 INFO - 'PWD': '/builds/slave/test', 03:35:03 INFO - 'SHELL': '/bin/bash', 03:35:03 INFO - 'SHLVL': '1', 03:35:03 INFO - 'TERM': 'linux', 03:35:03 INFO - 'TMOUT': '86400', 03:35:03 INFO - 'USER': 'cltbld', 03:35:03 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:03 INFO - '_': '/tools/buildbot/bin/python'} 03:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 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:35:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:35:04 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:35:04 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:35:04 INFO - Installing collected packages: simplejson 03:35:04 INFO - Running setup.py install for simplejson 03:35:04 INFO - building 'simplejson._speedups' extension 03:35:04 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:35:05 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:35:05 INFO - Successfully installed simplejson 03:35:05 INFO - Cleaning up... 03:35:05 INFO - Return code: 0 03:35:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:05 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 0x276f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aded10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, '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': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', '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:35:05 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:35:05 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:35:05 INFO - Using env: {'DISPLAY': ':0', 03:35:05 INFO - 'HOME': '/home/cltbld', 03:35:05 INFO - 'LANG': 'en_US.UTF-8', 03:35:05 INFO - 'LANGUAGE': 'en_US:en', 03:35:05 INFO - 'LOGNAME': 'cltbld', 03:35:05 INFO - 'MAIL': '/var/mail/cltbld', 03:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:05 INFO - 'MOZ_NO_REMOTE': '1', 03:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:05 INFO - 'NO_EM_RESTART': '1', 03:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:05 INFO - 'PWD': '/builds/slave/test', 03:35:05 INFO - 'SHELL': '/bin/bash', 03:35:05 INFO - 'SHLVL': '1', 03:35:05 INFO - 'TERM': 'linux', 03:35:05 INFO - 'TMOUT': '86400', 03:35:05 INFO - 'USER': 'cltbld', 03:35:05 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:05 INFO - '_': '/tools/buildbot/bin/python'} 03:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:06 INFO - Cleaning up... 03:35:06 INFO - Return code: 0 03:35:06 INFO - Running post-action listener: _resource_record_post_action 03:35:06 INFO - Running post-action listener: _start_resource_monitoring 03:35:06 INFO - Starting resource monitoring. 03:35:06 INFO - [mozharness: 2017-08-03 10:35:06.091268Z] Finished create-virtualenv step (success) 03:35:06 INFO - [mozharness: 2017-08-03 10:35:06.091787Z] Running install step. 03:35:06 INFO - Running pre-action listener: _resource_record_pre_action 03:35:06 INFO - Running main action method: install 03:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:06 INFO - Reading from file tmpfile_stdout 03:35:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:06 INFO - Reading from file tmpfile_stdout 03:35:06 INFO - Output received: 03:35:06 INFO - Usage: mozinstall [options] installer 03:35:06 INFO - Options: 03:35:06 INFO - -h, --help show this help message and exit 03:35:06 INFO - -d DEST, --destination=DEST 03:35:06 INFO - Directory to install application into. [default: 03:35:06 INFO - "/builds/slave/test"] 03:35:06 INFO - --app=APP Application being installed. [default: firefox] 03:35:06 INFO - mkdir: /builds/slave/test/build/application 03:35:06 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:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:35:24 INFO - Reading from file tmpfile_stdout 03:35:24 INFO - Output received: 03:35:24 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:24 INFO - Running post-action listener: _resource_record_post_action 03:35:24 INFO - [mozharness: 2017-08-03 10:35:24.467333Z] Finished install step (success) 03:35:24 INFO - [mozharness: 2017-08-03 10:35:24.467616Z] Running setup-mitmproxy step. 03:35:24 INFO - Running pre-action listener: _resource_record_pre_action 03:35:24 INFO - Running main action method: setup_mitmproxy 03:35:24 INFO - Skipping: mitmproxy is not required 03:35:24 INFO - Running post-action listener: _resource_record_post_action 03:35:24 INFO - [mozharness: 2017-08-03 10:35:24.468748Z] Finished setup-mitmproxy step (success) 03:35:24 INFO - [mozharness: 2017-08-03 10:35:24.468970Z] Running run-tests step. 03:35:24 INFO - Running pre-action listener: _resource_record_pre_action 03:35:24 INFO - Running pre-action listener: _set_gcov_prefix 03:35:24 INFO - Running main action method: run_tests 03:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:24 INFO - Python 2.7.3 03:35:24 INFO - Return code: 0 03:35:24 INFO - grabbing minidump binary from tooltool 03:35:24 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:35:24 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 0x2adbeb0>, '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 0x2adcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2add240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:24 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:35:24 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:35:24 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:35:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:24 INFO - Return code: 0 03:35:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:24 INFO - ENV: RUST_BACKTRACE is now 1 03:35:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:24 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/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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:35:24 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/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --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:35:24 INFO - Using env: {'DISPLAY': ':0', 03:35:24 INFO - 'HOME': '/home/cltbld', 03:35:24 INFO - 'LANG': 'en_US.UTF-8', 03:35:24 INFO - 'LANGUAGE': 'en_US:en', 03:35:24 INFO - 'LOGNAME': 'cltbld', 03:35:24 INFO - 'MAIL': '/var/mail/cltbld', 03:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:24 INFO - 'MOZ_NO_REMOTE': '1', 03:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:24 INFO - 'NO_EM_RESTART': '1', 03:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:24 INFO - 'PWD': '/builds/slave/test', 03:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:24 INFO - 'RUST_BACKTRACE': '1', 03:35:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:35:24 INFO - 'SHELL': '/bin/bash', 03:35:24 INFO - 'SHLVL': '1', 03:35:24 INFO - 'STYLO_FORCE_ENABLED': '1', 03:35:24 INFO - 'TERM': 'linux', 03:35:24 INFO - 'TMOUT': '86400', 03:35:24 INFO - 'USER': 'cltbld', 03:35:24 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909', 03:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:24 INFO - '_': '/tools/buildbot/bin/python'} 03:35:24 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/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--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:35:24 INFO - mozversion application_buildid: 20170803094416 03:35:24 INFO - mozversion application_changeset: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 03:35:24 INFO - mozversion application_display_name: Nightly 03:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:24 INFO - mozversion application_name: Firefox 03:35:24 INFO - mozversion application_remotingname: firefox 03:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:24 INFO - mozversion application_vendor: Mozilla 03:35:24 INFO - mozversion application_version: 57.0a1 03:35:24 INFO - mozversion platform_buildid: 20170803094416 03:35:24 INFO - mozversion platform_changeset: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 03:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:24 INFO - mozversion platform_version: 57.0a1 03:35:24 INFO - using testdate: 1501756524 03:35:24 INFO - actual date: 1501756524 03:35:24 INFO - starting webserver on 'localhost:36489' 03:35:24 INFO - SUITE-START | Running 2 tests 03:35:24 INFO - TEST-START | dromaeo_css 03:35:24 INFO - Initialising browser for dromaeo_css test... 03:35:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36489/getInfo.html -profile /tmp/tmpMMp_rD/profile 03:35:24 INFO - TEST-INFO | started process 27683 (/builds/slave/test/build/application/firefox/firefox http://localhost:36489/getInfo.html) 03:35:30 INFO - TEST-INFO | 27683: exit 0 03:35:31 INFO - Browser initialized. 03:35:31 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:31 INFO - TEST-INFO | started process 27908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMp_rD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:32 INFO - PID 27908 | 03:35:32 INFO - PID 27908 | (/builds/slave/test/build/application/firefox/firefox:27962): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:32 INFO - PID 27908 | 03:35:42 INFO - PID 27908 | RSS: Main: 174223360 03:35:42 INFO - PID 27908 | 03:38:41 INFO - PID 27908 | Cycle 1(1): loaded http://localhost:36489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36489/tests/dromaeo/cssquery-ext.html) 03:38:43 INFO - PID 27908 | RSS: Main: 175734784 03:38:43 INFO - PID 27908 | 03:41:45 INFO - PID 27908 | Cycle 1(1): loaded http://localhost:36489/tests/dromaeo/cssquery-ext.html (next: http://localhost:36489/tests/dromaeo/cssquery-jquery.html) 03:41:45 INFO - PID 27908 | RSS: Main: 173297664 03:41:45 INFO - PID 27908 | 03:44:47 INFO - PID 27908 | Cycle 1(1): loaded http://localhost:36489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36489/tests/dromaeo/cssquery-mootools.html) 03:44:48 INFO - PID 27908 | RSS: Main: 175611904 03:44:48 INFO - PID 27908 | 03:47:50 INFO - PID 27908 | Cycle 1(1): loaded http://localhost:36489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36489/tests/dromaeo/cssquery-prototype.html) 03:47:50 INFO - PID 27908 | RSS: Main: 174194688 03:47:50 INFO - PID 27908 | 03:50:54 INFO - PID 27908 | Cycle 1(1): loaded http://localhost:36489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36489/tests/dromaeo/cssquery-yui.html) 03:50:55 INFO - PID 27908 | RSS: Main: 177369088 03:50:55 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | Cycle 1(1): loaded http://localhost:36489/tests/dromaeo/cssquery-yui.html (next: http://localhost:36489/tests/dromaeo/cssquery-dojo.html) 03:53:57 INFO - PID 27908 | RSS: Main: 176308224 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | __start_tp_report 03:53:57 INFO - PID 27908 | _x_x_mozilla_page_load 03:53:57 INFO - PID 27908 | _x_x_mozilla_page_load_details 03:53:57 INFO - PID 27908 | |i|pagename|runs| 03:53:57 INFO - PID 27908 | |0;dojo.html;3156.9368612627763;3176.555282260484;3189.537517060026;3209.3741720364537;3247.3180632067265;6145.72344244509;6203.410675985785;6235.781747638834;6269.686515674221;6275.435210831024;6230.626162430257;6267.717952692128;6275.9372406275925;6281.591696539722;6291.465225455841;5714.7428365723645;5731.168980497825;5736.397678243787;5778.59549831512;5815.534757219412;5789.884202315951;5839.8540036499;5843.64938103713;5850.736716847752;5871.677057761822;5711.571632127607;5793.594448388614;5796.043652797283;5826.533877289807;5854.707264636772;5584.413636568183;5688.800891968761;5693.202951586781;5734.713264336767;5829.679367634779;5454.91817622736;5671.291088613923;5695.857603559903;5738.454846789548;5752.338481074688;6143.32423433422;6150.938490615082;6159.784407545714;6197.0704394340755;6248.718807653667;6537.64042977636;6626.602403855784;6677.833054173684;6689.1972963244725;6772.8984065239065;6735;6762.188537375547;6765.424938880201;6767;6770.458363330922;6237.594556353823;6243.937560624427;6256.311805701369;6262.12330273762;6267.592606480564;6791.286914873867;6804.251532331439;6877.1747390313485;6880;6896.965515172392;6580.21037475506;6586.37429444202;6635.336466353326;6662.167229096363;6668.199816022108;6661.833454163588;6686.933130668728;6774;6776.796696099125;6816.07982922309;6551.836204094936;6572.737090516422;6643.10318107059;6655.46756259498;6755.49333799967;6765.898511522331;6769.289224631343;6780.559263647946;6790.898136527956;6795.694193761293;5438.646487978269;5457.072297709399;5465.371482279509;5479.67121972675;5500.257465242141;4645.535446455395;4682.180618391836;4712.88217794551;4718.9382388962895;4721.244600863845;5687.971560142173;5780.479756821822;5807.651540907559;5812.622179558315;5820.970895145497;6668.933310666831;6694.163229596301;6711.765088221889;6713.932860671429;6721.7311307548125;5722.713864306768;5748.39641837601;5758.193852860602;5768.942310576925;5829.621074630136;5383.111786555174;5859.765609375577;5890.911636325459;5895.02732049207;5897.970510147422;6452.870942581122;6458.773942911976;6485.967570162119;6486.643234622046;6491.67541622917;6713.597184168965;6821.89767153503;6823.965880170766;6828.351306625863;6830.658467076726;6473.805785826433;6570.934290657032;6585.176852893388;6586.604803711793;6602.735890564323;6600.471962242913;6612.4710023198995;6636.502262330248;6724.93275067243;6735.528513004043;6604.933950660432;6707;6714.328567143247;6721.193456785021;6732.023856540872;6500.219973603198;6508.446782023391;6508.8047358579315;6510.934890651033;6521.152250207443;6509.414152726277;6513.381228783258;6536.83657908537;6589.374009469093;6606.240282367589;6305.96847015762;6445;6494.870102598016;6560.9343906560325;6579.638119903451;6406.647634380154;6469.967650161719;6481.643509606828;6487.3836985486305;6504.447121994494;6208.410201030895;6258.43674069336;6259.467945224525;6271.43557079865;6273.937260627518 03:53:57 INFO - PID 27908 | |1;ext.html;799.560241866973;866.982660346793;894.4320356573573;904.7964208053187;1171.145064103204;29243.56134657982;30297.545536816964;40959.385609215846;41129;41550.79224603873;40968;41306.38040429389;41396.172076558454;41413.58586414135;41442.17115657685;7083.327083927044;7480.700771969115;7700.4609677322605;7731.188225236326;7742.303192712655;7534.849303013936;7644.847103057963;7651.617419129049;7651.693932242703;7652.349550288204;7652.234776522331;7676.846463070735;7710.074791025057;7710.460267781257;7729.458937874351;7609.733659321925;7657.081150261948;7660.5403675779635;7672.309492145706;7705.537667739954;7542.736004239825;7588.962055189744;7599.772006839804;7608.505447145973;7608.961955190244;37833.43249851254;37991.620083799084;38077.428838567444;38149.427758583646;38246.61753382458;3542.822858857047;3578.8389522471552;3587.031501494608;3592.9281414371826;3595.8741444049333;31066.689333106606;31270.218244544067;31275.84362078198;31406.685933140834;31461.37077258465;4644.95355046452;4891.926621100686;4894.461609222983;4909.410870695539;4926.285688575173;191492;191921;192169;192494;192760;48112.03775924532;48125;48293.75853120782;48352.27471587929;48481.75759121182;53721.73139134357;53945.73027134917;54234;54381.45618543843;54455;16261.918690406472;16299.266533006043;16404.589885252964;16405.507834764976;16409.91795041017;12103.81844272319;12278.754424911453;12295.56965506203;13530.458781648624;13729.656758581115;14315.57053288403;14343.78484322736;14355.066920650124;14540.49108281205;14563.635909102357;5832.883342333214;5876.7355469004;5880.147378630075;5886.587938844325;5926.081457374028;1004.9899501005043;1019.5412064570972;1021.5096753558333;1030.7114008077751;1040.765827688764;23142;23639.645405318934;23800.523989520112;28824.279393015342;30728.53907191394;1087.7226307291749;1107.0811226681997;1113.33200079953;1115.8716747573972;1115.9442027898572;12854.03594730399;16483.58791030234;16667.33330666784;16771.91614041922;16815.91592042032;220664;221044;221482;221531;222079;56618.716906415204;57123.714381427824;57199.42800571941;57245.14132288019;57312.42687573071;1410.6543896745363;1467.8972471926863;1470.353044660346;1472.3153733513752;1481.8073650425376;27059.594106088032;28422.147335579964;28598.857005715672;28713;29024;38303.808480957414;38819;38883.611163887996;38901;39049.82850514489;213707;214422;214946;215291;215798;34508.30983380369;37171.25657486781;37958.24083518369;38015.809920951324;38062.61937380591;45621.771891140335;46629.3005604923;46682.53317466782;47420.2886956689;47467;34238;34399.484007739404;34409.31181376308;34659;34921.301573968885;34304.656953430145;34552;34621;34799.30401392009;34928;37096.07259818526;37138.07154821151;37148.81425592855;37293.440598391586;37462;33114.5032824503;33283.50074748929;33287.50068749019;33439.66560334365;33622.83188584042;24200.636990444804;25620.8718956404;25696;25706.35734106662;26046.218613441626 03:53:57 INFO - PID 27908 | |2;jquery.html;570.8801151758131;571.8255931940759;576.2221001647774;585.2245774348988;598.2730981857044;21598.568028639416;22519.887400563017;22666.43333916651;22676.319710408694;22684.54630907381;26018.089366872162;26634.6004809928;26650.466990660174;26662.200133995964;26766.330841728966;6440.516961227903;6651.634160121192;6660.733570657168;6662.034005069262;6662.10061641677;3882.2429626222897;4078.8980275493054;6235.968820155916;6537.673116344187;6568.343165683417;6601.900971485432;6605.768798092067;6614.338566143371;6615.404613584777;6615.6030638161865;6575.934240657604;6582.44049255809;6604;6610.537262391635;6634.800955971328;6139.201903752528;6146.66193359365;6151.323354431009;6157.938420615781;6162.661053642048;28689.713102868915;30049.699503004907;30268.394632107455;30333.393332133455;30745.692543074507;1773.813749556291;1813.8276863697927;1817.0551313317;1823.3527097880194;1824.1973531646033;18690.906545467187;19322.227110915548;19394.418167454856;19453.4163975081;19474.318398856114;2214.269291133922;2230.710007699005;2237.2281562860785;2285.1773361589812;2313.0400883633274;136362;140200;140698.59301406957;141636.29181854127;142010.28994855064;14269;14751.631209219855;14848.406063757544;15040.32318545668;15658;22994.8850255751;23955.16156934499;24248;24281.39296517601;24304.513909721707;10259.384436933808;10487;10487.94756026215;10505.947470262752;10537.42044187577;9577.808443831223;9595.520223988913;9607.711768646812;9667.419954802594;9710.951445242728;9118.81762364749;9460.1485866271;9575.186109180797;9577.377470464537;9607.855882161773;2911.548709949961;2914.664813546427;2926.536731634183;2945.528715405525;2979.61265035544;975.2100798353357;990.3315262198131;993.5032483758121;1003.4631472162504;1007.2697294461457;19591.11839967205;19651.901740491205;20121.698174527395;23453.648195277085;24905.750942490344;1036.8081904847627;1044.4777611194402;1049.8057859296055;1063.3460421840666;1065.4406436620682;10806.94596527028;11180.329180249211;11246.437678116225;11281.887181128248;11420.88579114215;496407;496520;497041;502909;513425;118367.40816295863;119269.40365298119;121466;124409.37795310965;125341;1232.8150777383285;1266.0567876931561;1287.6973911130876;1294.3851670456459;1296.0603562417361;20809;20967.84657381098;20986.740795552316;21004;21171.364859053636;48998.510014899395;51391.48608514017;57516;57598.7120064397;60804;69365.65317173382;74949.25050749641;78549;78633.60683196547;80170;14585.270736462922;15043.247837608295;15329.540113796158;15356.539303820904;15371.231438428258;23367.88316058409;23656.763432366144;23702.88148559246;23787.64318535258;23803.761962380846;18881.527961801065;18886.905565472083;18906.14922328526;18983.33558325452;18990.905045474683;16251.674966500841;16314.836851631331;16759.66480670404;17545.82454175493;17587.648247035242;19110.33113841009;19115.713264301325;19446.513837154183;19547;19801.702974455107;14657.92671036638;14930.178840163895;15168.772468413203;15215.923920380328;15350.846491534941;18919.337823176123;18948.05259737035;19186.808131918504;19320;19343.613127737648 03:53:57 INFO - PID 27908 | |3;mootools.html;1319.1293746127556;1383.9031267811251;1388.5834249725092;1407.9366428510716;1408.2747385096677;13323.467061317548;13925.930370348135;13945.093568918039;13949.581512554627;13967.860321396784;12850.293233872157;13751.381187846546;13789.72420551591;13811.792823107662;13851.376688049037;2710.227585138236;2760.323720688424;2763.392053748182;2772.085211880085;2774.6392968914015;2615.7515036071636;2627.8686065696734;2707.431439397729;2722.863856807152;2750.9037183698574;2704.6078318643786;2742.5474796658527;2743.0810678422754;2745.3136715821047;2748.051922086887;2557.693076830783;2615.1500762252344;2616.123598594473;2616.2674451153707;2628.342914271432;2587.3660953066433;2608.4261462478225;2614.0328078611037;2614.359481926921;2626.0808716949105;13742.106763060468;14066.085704429179;14078.155310681392;14081.155130692192;14084.647883802987;7665.501742386727;7958.164392738795;7961.72133975308;7979.122296547375;7986.960065199695;4875.122477953967;5031.396232452093;5156.664816786897;5217.087009773274;5227.26818245446;1866.9066546672748;1887.3582981786258;1895.9431217063511;1944.3486432045281;1949.9122539485757;22287.554248915094;22318.330450086523;22511.887440562856;22526.549469010693;22540.09839606414;6315.905261421082;6425.485961123099;6534.135753748976;6641.335866413417;6677;16103.436379726654;16109.436169734237;16120.435784747477;16127.032378057354;16133.354665813471;7642.617869106522;7763.844723105619;7827.726029588937;7832.020997375328;7849.293563579306;6961.164660240804;7081.964590177016;7133.251008644018;7221.061262035902;7281.927180728125;4926.753662316942;5102.642815002989;5120.846374608767;5131.717755523482;5148.613853960893;1405.0796728143082;1449.6738233897288;1545.6985887752005;1549.387991743255;1580.573245223783;678.8065401360589;863.369740089738;876.7588913048962;879.7052987249343;888.995435158267;7677.270659287359;7795.415343849234;7931.920680793118;7934.56359900211;8007.0391553014015;978.9021097890296;996.0686757881404;1000.5797565022563;1001.4141727089589;1009.6213919780082;4859.586935110485;5365.38298095724;5390.137577987503;5402.324709411324;5459.836204913859;19374;19673.311434099738;19743.308984185773;19746.308879189448;19761.505962351057;18527.72208416875;18712.345067922557;18914.24343026291;18933.33733319327;19056.61886762257;11090.889091109148;11260.943695281636;11265.831012534818;11344.20590558653;11390.487428065757;7643.4267429941865;7877.527348359117;7906.565138917184;7939.483933544301;7940.523568585903;16156.222815490051;16484.917575412048;16510.33958641689;16863.325466981183;17004.65990680204;16048.277827497557;16090.115043672711;16197;16501.09243991592;16554.337826487288;11241.775164496828;11551.075913927034;11580.478878450322;11598.768024639292;11608.593699220486;13085.214887106804;13101.672458188621;13109.475620975054;13263.734725305632;13266.867331326563;9913.157381622643;10646.148308135176;10646.8935310649;10684.89315106839;10767.676969690921;10596.31123976939;10618.36289822613;10620.575176992834;10694.19793515505;10870.293430926964;9380.437173769596;9549.761255968657;9560.043995600663;9560.28297877648;9600.567974441306;6949.722011119498;6964.930350696428;6978.47661425385;6979.546329488567;7014.018037474656;6768.932310676831;6840.452763778786;6842.863142737217;6888.242293347627;6908.5509441886115 03:53:57 INFO - PID 27908 | |4;prototype.html;495.90577790219857;500.13783326113486;523.0924346259237;523.9921401178983;526.3552148617944;6054.485368743656;6086.330503644606;6111.144439778434;6143.170671959284;6150.200473938393;5965.671888046156;5971.731272092756;5999.460048595625;6043.909341359883;6112.6638034908065;4849.515048495157;4878.75562750772;4910.508949105097;4912.435069966946;4940.555350018498;4771.737554434505;4854.781534830923;4898.951010489885;4909.533594308535;4936.679115857476;4818.566329030386;4841.7337046462435;4880.926786098212;4887.511248875119;4902.754862256891;4898.8040478381;4908.558229759339;4911.287863259825;4917.188663870493;4934.360117337207;4442.3336499525;4463.531329210418;4467.195904737146;4481.753503557303;4490.124425736983;5981.970090149565;5982.491488223506;5998.220231369894;6044.24446944132;6054.606450580698;5643.717814109319;5660;5676.716164191774;5680.602357834953;5704.857378565527;6453.903191452132;6486.708098135595;6523.902141467882;6534.117894084286;6558.967205163944;4773.546513081252;4837.32277481153;4847.684900481458;4866.440359358684;4871.8064074301665;6740.887753520712;6823.965880170617;6839.931600683979;6860.6673730932225;6915.723371065152;4912.72979986097;4921.409430868247;4931.926021109686;4936.160852655057;4968.428630707443;5039.160706342159;5047.596192304607;5047.747612619354;5054.292399064134;5072.112380333427;5608.298962629671;5609.943900560942;5665.178549110438;5665.6034077614995;5707.800226992035;6434.485241180694;6472.935270647234;6517.773702017532;6529.608223506605;6566.507511936624;1643.4576589725361;1672.8912620679616;1688.6200604863807;1698.456493921933;1763.7971633262082;1207.8610959739567;1210.9636710898687;1233.993830030844;1238.0961897814645;1238.7921776268247;5714.7428365723645;5720.485156335866;5775.971120144456;5781.421857814269;5805.970970145122;6586.077949087132;6619.304972977864;6667.166604174478;6717.832054198684;6751.177182160789;5757.798477053283;5772.855678608068;5810.1865738796605;5816.702402550969;5830.4461076197695;3542.875999340011;3576.159602493412;3605.387084195693;3606.85572577094;3609.639036096369;6429.58207716497;6434.388733070351;6440.0679796060995;6469.870602587922;6495.805125846232;6789.185297764201;6792.675428291534;6822.795316140524;6849.863002739918;6874.346937040973;6418.903716444257;6444.935550644527;6478.319776423407;6510.73957041713;6515.185601799775;6624.6025238485845;6651;6675.265720770614;6683.8663226734225;6736.663166841737;6626.933730662631;6628.834279142867;6635.701393437211;6649.434798042221;6720.395164435225;6484.448821850196;6503.479721622353;6509.967450162719;6521.902171467337;6524.543281970216;4928.137575924127;4938.1358262304675;4973.602111830973;4986.47641997585;5014.517813682251;6481.675916204076;6711.194656641234;6713.858644030429;6728.562643428161;6770.796876093725;6115.6330620162935;6339.104632691641;6350.206224221973;6369.617822930639;6482.513811464253;6375.840603984938;6411.294757576569;6447.838804029937;6454.644994525346;6478.481721462177;6450.129232553545;6471.708773105316;6489.286178520265;6503.967480162569;6529.347065293433;6466.385693359123;6498.187726534184;6520.413162815369;6562.573432726857;6603.603783772989;6243.8126856194385;6296.464800491826;6315;6326.398992095744;6351.2696039956 03:53:57 INFO - PID 27908 | |5;yui.html;869.6608322754123;900.9819803603928;901.9368644194909;908.6320040383645;910.1535571918114;18114.90942545287;18898.338558150466;18933.431997040076;18934.14796334165;18956.62086758264;17186.312547498084;18593.81406185938;21509.462263443384;21513.139474421045;21538;1007.2043085962099;1031.705963800317;1033.225081189108;1033.2870319479573;1033.731229880229;747.9626018699071;1057.820170571001;1057.8783439904394;1058.095328494138;1059.3167407022465;849.4818160921833;1085.3704851186333;1122.7586068995165;1133.5182547417314;1135.829625556169;1111.522045520426;1116.5366372955214;1116.7375666718315;1120.42858142348;1121.495327102803;811.5860910935406;815.1522416686639;816.4285000499615;817.513579420244;820.5568992743911;19495.415137545755;19765.209391624318;20214.292499762436;20343.79656203434;20466.283680071276;21325.466863328387;21380.57238855214;21581.244656437106;21891;21919.67120493178;15699;16039.278232479566;16082.43711470093;16159.111248881307;16288.592785180346;3531.4526248431534;3532.311199316134;3543.291341731638;3558.395072837624;3565.4830049642655;126258;127567;128240;130943;131033.34483327523;14480.565583032527;15030.473933412279;15032;16677.99864016326;17283.567910802332;30645.233869153002;30993.070207893797;31039.224019399695;31130.066098017094;31245.218869528442;8860.955695221483;9025.684101056562;9049.909500905038;9079.68221112258;9091.954540227389;3930.6462418382484;4008.939865902014;4023.939640905389;4139.855105071308;4320.481542214954;5229.267902493654;5325.4674532547215;5336.573074154058;5338.733063346895;5357.249985002103;1035.5495359518634;1078.0567003871613;1081.3403823667556;1090.2531765740334;1090.7273181704575;671.325318055361;701.9649017549102;702.220535205921;709.3722055980494;716.2300526933567;12021.939890300493;12181.756364872654;12524;12952.158109722837;12955.352232388343;695.3498478922224;698.3609996852823;709.5272973686698;710.1300906389735;717.9641017949186;5505.587080968943;5607.102863541813;5975.492083172892;6172.969135154295;6315.336889626615;98530.5073474628;99370;99403.50298248463;100726;102026.48986755167;88423;88680;90585.54707226422;90904.9092790826;91131.54434227786;75064.62467687626;78161.60919195367;80055.59972200102;80671;85659.14340856636;12504.687382815502;12687.80968285458;12819.551315703906;12891.290978996245;12924.224546527239;34980.12549686278;35029.299414012086;35743.46384804178;36111.63888361083;36581;46179.53820461887;46494.767526162155;46978.76510617425;47354;47596.7620161897;17654.911725441805;17844.375446859296;18018.549536261173;18144.364947226783;18413.631727365646;20567.58864822665;20782.896085519475;20795.376138715863;20806.791932080487;20839.47901302419;18595.628087438447;18967.14647840878;19006.429807105807;19108.808911910703;19212;18959.43121706296;19190.328338508087;19399.515012124244;19585.216591336186;20119.798802011792;18583;19044.523886902938;19700.90149549243;19746.50633734168;19829.504262393555;13253.933730331672;13275.468981240641;13566.050376473551;13907.652308692364;14132;14417.13497190172;14462.710745784814;14509.473221993194;14605.466426025114;14877.851221487646 03:53:57 INFO - PID 27908 | __end_tp_report 03:53:57 INFO - PID 27908 | __start_cc_report 03:53:57 INFO - PID 27908 | _x_x_mozilla_cycle_collect,377 03:53:57 INFO - PID 27908 | __end_cc_report 03:53:57 INFO - PID 27908 | __startTimestamp1501757637341__endTimestamp 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | ------- Summary: start ------- 03:53:57 INFO - PID 27908 | Number of tests: 6 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | [#0] dojo.html Cycles:165 Average:6169.81 Median:6445.00 stddev:721.65 (11.2%) stddev-sans-first:684.06 03:53:57 INFO - PID 27908 | Values: 3156.9 3176.6 3189.5 3209.4 3247.3 6145.7 6203.4 6235.8 6269.7 6275.4 6230.6 6267.7 6275.9 6281.6 6291.5 5714.7 5731.2 5736.4 5778.6 5815.5 5789.9 5839.9 5843.6 5850.7 5871.7 5711.6 5793.6 5796.0 5826.5 5854.7 5584.4 5688.8 5693.2 5734.7 5829.7 5454.9 5671.3 5695.9 5738.5 5752.3 6143.3 6150.9 6159.8 6197.1 6248.7 6537.6 6626.6 6677.8 6689.2 6772.9 6735.0 6762.2 6765.4 6767.0 6770.5 6237.6 6243.9 6256.3 6262.1 6267.6 6791.3 6804.3 6877.2 6880.0 6897.0 6580.2 6586.4 6635.3 6662.2 6668.2 6661.8 6686.9 6774.0 6776.8 6816.1 6551.8 6572.7 6643.1 6655.5 6755.5 6765.9 6769.3 6780.6 6790.9 6795.7 5438.6 5457.1 5465.4 5479.7 5500.3 4645.5 4682.2 4712.9 4718.9 4721.2 5688.0 5780.5 5807.7 5812.6 5821.0 6668.9 6694.2 6711.8 6713.9 6721.7 5722.7 5748.4 5758.2 5768.9 5829.6 5383.1 5859.8 5890.9 5895.0 5898.0 6452.9 6458.8 6486.0 6486.6 6491.7 6713.6 6821.9 6824.0 6828.4 6830.7 6473.8 6570.9 6585.2 6586.6 6602.7 6600.5 6612.5 6636.5 6724.9 6735.5 6604.9 6707.0 6714.3 6721.2 6732.0 6500.2 6508.4 6508.8 6510.9 6521.2 6509.4 6513.4 6536.8 6589.4 6606.2 6306.0 6445.0 6494.9 6560.9 6579.6 6406.6 6470.0 6481.6 6487.4 6504.4 6208.4 6258.4 6259.5 6271.4 6273.9 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | [#1] ext.html Cycles:180 Average:38719.59 Median:3582.94 stddev:54287.81 (1515.2%) stddev-sans-first:54365.43 03:53:57 INFO - PID 27908 | Values: 799.6 867.0 894.4 904.8 1171.1 29243.6 30297.5 40959.4 41129.0 41550.8 40968.0 41306.4 41396.2 41413.6 41442.2 7083.3 7480.7 7700.5 7731.2 7742.3 7534.8 7644.8 7651.6 7651.7 7652.3 7652.2 7676.8 7710.1 7710.5 7729.5 7609.7 7657.1 7660.5 7672.3 7705.5 7542.7 7589.0 7599.8 7608.5 7609.0 37833.4 37991.6 38077.4 38149.4 38246.6 3542.8 3578.8 3587.0 3592.9 3595.9 31066.7 31270.2 31275.8 31406.7 31461.4 4645.0 4891.9 4894.5 4909.4 4926.3 191492.0 191921.0 192169.0 192494.0 192760.0 48112.0 48125.0 48293.8 48352.3 48481.8 53721.7 53945.7 54234.0 54381.5 54455.0 16261.9 16299.3 16404.6 16405.5 16409.9 12103.8 12278.8 12295.6 13530.5 13729.7 14315.6 14343.8 14355.1 14540.5 14563.6 5832.9 5876.7 5880.1 5886.6 5926.1 1005.0 1019.5 1021.5 1030.7 1040.8 23142.0 23639.6 23800.5 28824.3 30728.5 1087.7 1107.1 1113.3 1115.9 1115.9 12854.0 16483.6 16667.3 16771.9 16815.9 220664.0 221044.0 221482.0 221531.0 222079.0 56618.7 57123.7 57199.4 57245.1 57312.4 1410.7 1467.9 1470.4 1472.3 1481.8 27059.6 28422.1 28598.9 28713.0 29024.0 38303.8 38819.0 38883.6 38901.0 39049.8 213707.0 214422.0 214946.0 215291.0 215798.0 34508.3 37171.3 37958.2 38015.8 38062.6 45621.8 46629.3 46682.5 47420.3 47467.0 34238.0 34399.5 34409.3 34659.0 34921.3 34304.7 34552.0 34621.0 34799.3 34928.0 37096.1 37138.1 37148.8 37293.4 37462.0 33114.5 33283.5 33287.5 33439.7 33622.8 24200.6 25620.9 25696.0 25706.4 26046.2 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | [#2] jquery.html Cycles:180 Average:35716.44 Median:22671.38 stddev:84565.12 (373.0%) stddev-sans-first:84761.18 03:53:57 INFO - PID 27908 | Values: 570.9 571.8 576.2 585.2 598.3 21598.6 22519.9 22666.4 22676.3 22684.5 26018.1 26634.6 26650.5 26662.2 26766.3 6440.5 6651.6 6660.7 6662.0 6662.1 3882.2 4078.9 6236.0 6537.7 6568.3 6601.9 6605.8 6614.3 6615.4 6615.6 6575.9 6582.4 6604.0 6610.5 6634.8 6139.2 6146.7 6151.3 6157.9 6162.7 28689.7 30049.7 30268.4 30333.4 30745.7 1773.8 1813.8 1817.1 1823.4 1824.2 18690.9 19322.2 19394.4 19453.4 19474.3 2214.3 2230.7 2237.2 2285.2 2313.0 136362.0 140200.0 140698.6 141636.3 142010.3 14269.0 14751.6 14848.4 15040.3 15658.0 22994.9 23955.2 24248.0 24281.4 24304.5 10259.4 10487.0 10487.9 10505.9 10537.4 9577.8 9595.5 9607.7 9667.4 9711.0 9118.8 9460.1 9575.2 9577.4 9607.9 2911.5 2914.7 2926.5 2945.5 2979.6 975.2 990.3 993.5 1003.5 1007.3 19591.1 19651.9 20121.7 23453.6 24905.8 1036.8 1044.5 1049.8 1063.3 1065.4 10806.9 11180.3 11246.4 11281.9 11420.9 496407.0 496520.0 497041.0 502909.0 513425.0 118367.4 119269.4 121466.0 124409.4 125341.0 1232.8 1266.1 1287.7 1294.4 1296.1 20809.0 20967.8 20986.7 21004.0 21171.4 48998.5 51391.5 57516.0 57598.7 60804.0 69365.7 74949.3 78549.0 78633.6 80170.0 14585.3 15043.2 15329.5 15356.5 15371.2 23367.9 23656.8 23702.9 23787.6 23803.8 18881.5 18886.9 18906.1 18983.3 18990.9 16251.7 16314.8 16759.7 17545.8 17587.6 19110.3 19115.7 19446.5 19547.0 19801.7 14657.9 14930.2 15168.8 15215.9 15350.8 18919.3 18948.1 19186.8 19320.0 19343.6 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | [#3] mootools.html Cycles:180 Average:8679.97 Median:2614.20 stddev:5828.08 (222.9%) stddev-sans-first:5818.19 03:53:57 INFO - PID 27908 | Values: 1319.1 1383.9 1388.6 1407.9 1408.3 13323.5 13925.9 13945.1 13949.6 13967.9 12850.3 13751.4 13789.7 13811.8 13851.4 2710.2 2760.3 2763.4 2772.1 2774.6 2615.8 2627.9 2707.4 2722.9 2750.9 2704.6 2742.5 2743.1 2745.3 2748.1 2557.7 2615.2 2616.1 2616.3 2628.3 2587.4 2608.4 2614.0 2614.4 2626.1 13742.1 14066.1 14078.2 14081.2 14084.6 7665.5 7958.2 7961.7 7979.1 7987.0 4875.1 5031.4 5156.7 5217.1 5227.3 1866.9 1887.4 1895.9 1944.3 1949.9 22287.6 22318.3 22511.9 22526.5 22540.1 6315.9 6425.5 6534.1 6641.3 6677.0 16103.4 16109.4 16120.4 16127.0 16133.4 7642.6 7763.8 7827.7 7832.0 7849.3 6961.2 7082.0 7133.3 7221.1 7281.9 4926.8 5102.6 5120.8 5131.7 5148.6 1405.1 1449.7 1545.7 1549.4 1580.6 678.8 863.4 876.8 879.7 889.0 7677.3 7795.4 7931.9 7934.6 8007.0 978.9 996.1 1000.6 1001.4 1009.6 4859.6 5365.4 5390.1 5402.3 5459.8 19374.0 19673.3 19743.3 19746.3 19761.5 18527.7 18712.3 18914.2 18933.3 19056.6 11090.9 11260.9 11265.8 11344.2 11390.5 7643.4 7877.5 7906.6 7939.5 7940.5 16156.2 16484.9 16510.3 16863.3 17004.7 16048.3 16090.1 16197.0 16501.1 16554.3 11241.8 11551.1 11580.5 11598.8 11608.6 13085.2 13101.7 13109.5 13263.7 13266.9 9913.2 10646.1 10646.9 10684.9 10767.7 10596.3 10618.4 10620.6 10694.2 10870.3 9380.4 9549.8 9560.0 9560.3 9600.6 6949.7 6964.9 6978.5 6979.5 7014.0 6768.9 6840.5 6842.9 6888.2 6908.6 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | [#4] prototype.html Cycles:180 Average:5465.01 Median:6021.68 stddev:1535.24 (25.5%) stddev-sans-first:1493.56 03:53:57 INFO - PID 27908 | Values: 495.9 500.1 523.1 524.0 526.4 6054.5 6086.3 6111.1 6143.2 6150.2 5965.7 5971.7 5999.5 6043.9 6112.7 4849.5 4878.8 4910.5 4912.4 4940.6 4771.7 4854.8 4899.0 4909.5 4936.7 4818.6 4841.7 4880.9 4887.5 4902.8 4898.8 4908.6 4911.3 4917.2 4934.4 4442.3 4463.5 4467.2 4481.8 4490.1 5982.0 5982.5 5998.2 6044.2 6054.6 5643.7 5660.0 5676.7 5680.6 5704.9 6453.9 6486.7 6523.9 6534.1 6559.0 4773.5 4837.3 4847.7 4866.4 4871.8 6740.9 6824.0 6839.9 6860.7 6915.7 4912.7 4921.4 4931.9 4936.2 4968.4 5039.2 5047.6 5047.7 5054.3 5072.1 5608.3 5609.9 5665.2 5665.6 5707.8 6434.5 6472.9 6517.8 6529.6 6566.5 1643.5 1672.9 1688.6 1698.5 1763.8 1207.9 1211.0 1234.0 1238.1 1238.8 5714.7 5720.5 5776.0 5781.4 5806.0 6586.1 6619.3 6667.2 6717.8 6751.2 5757.8 5772.9 5810.2 5816.7 5830.4 3542.9 3576.2 3605.4 3606.9 3609.6 6429.6 6434.4 6440.1 6469.9 6495.8 6789.2 6792.7 6822.8 6849.9 6874.3 6418.9 6444.9 6478.3 6510.7 6515.2 6624.6 6651.0 6675.3 6683.9 6736.7 6626.9 6628.8 6635.7 6649.4 6720.4 6484.4 6503.5 6510.0 6521.9 6524.5 4928.1 4938.1 4973.6 4986.5 5014.5 6481.7 6711.2 6713.9 6728.6 6770.8 6115.6 6339.1 6350.2 6369.6 6482.5 6375.8 6411.3 6447.8 6454.6 6478.5 6450.1 6471.7 6489.3 6504.0 6529.3 6466.4 6498.2 6520.4 6562.6 6603.6 6243.8 6296.5 6315.0 6326.4 6351.3 03:53:57 INFO - PID 27908 | 03:53:57 INFO - PID 27908 | [#5] yui.html Cycles:180 Average:22526.11 Median:20405.04 stddev:29974.18 (146.9%) stddev-sans-first:30014.15 03:53:57 INFO - PID 27908 | Values: 869.7 901.0 901.9 908.6 910.2 18114.9 18898.3 18933.4 18934.1 18956.6 17186.3 18593.8 21509.5 21513.1 21538.0 1007.2 1031.7 1033.2 1033.3 1033.7 748.0 1057.8 1057.9 1058.1 1059.3 849.5 1085.4 1122.8 1133.5 1135.8 1111.5 1116.5 1116.7 1120.4 1121.5 811.6 815.2 816.4 817.5 820.6 19495.4 19765.2 20214.3 20343.8 20466.3 21325.5 21380.6 21581.2 21891.0 21919.7 15699.0 16039.3 16082.4 16159.1 16288.6 3531.5 3532.3 3543.3 3558.4 3565.5 126258.0 127567.0 128240.0 130943.0 131033.3 14480.6 15030.5 15032.0 16678.0 17283.6 30645.2 30993.1 31039.2 31130.1 31245.2 8861.0 9025.7 9049.9 9079.7 9092.0 3930.6 4008.9 4023.9 4139.9 4320.5 5229.3 5325.5 5336.6 5338.7 5357.2 1035.5 1078.1 1081.3 1090.3 1090.7 671.3 702.0 702.2 709.4 716.2 12021.9 12181.8 12524.0 12952.2 12955.4 695.3 698.4 709.5 710.1 718.0 5505.6 5607.1 5975.5 6173.0 6315.3 98530.5 99370.0 99403.5 100726.0 102026.5 88423.0 88680.0 90585.5 90904.9 91131.5 75064.6 78161.6 80055.6 80671.0 85659.1 12504.7 12687.8 12819.6 12891.3 12924.2 34980.1 35029.3 35743.5 36111.6 36581.0 46179.5 46494.8 46978.8 47354.0 47596.8 17654.9 17844.4 18018.5 18144.4 18413.6 20567.6 20782.9 20795.4 20806.8 20839.5 18595.6 18967.1 19006.4 19108.8 19212.0 18959.4 19190.3 19399.5 19585.2 20119.8 18583.0 19044.5 19700.9 19746.5 19829.5 13253.9 13275.5 13566.1 13907.7 14132.0 14417.1 14462.7 14509.5 14605.5 14877.9 03:53:57 INFO - PID 27908 | -------- Summary: end -------- 03:53:57 INFO - PID 27908 | 03:53:57 INFO - TEST-INFO | 27908: exit 0 03:53:57 INFO - TEST-OK | dromaeo_css | took 1113150ms 03:53:57 INFO - TEST-START | kraken 03:53:57 INFO - Initialising browser for kraken test... 03:53:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36489/getInfo.html -profile /tmp/tmp_0MKTq/profile 03:53:57 INFO - TEST-INFO | started process 28279 (/builds/slave/test/build/application/firefox/firefox http://localhost:36489/getInfo.html) 03:54:03 INFO - TEST-INFO | 28279: exit 0 03:54:03 INFO - Browser initialized. 03:54:03 INFO - Running cycle 1/1 for kraken test... 03:54:03 INFO - TEST-INFO | started process 28505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_0MKTq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:04 INFO - PID 28505 | 03:54:04 INFO - PID 28505 | (/builds/slave/test/build/application/firefox/firefox:28559): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:04 INFO - PID 28505 | 03:54:15 INFO - PID 28505 | RSS: Main: 174112768 03:54:15 INFO - PID 28505 | 03:54:17 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36489/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:18 INFO - PID 28505 | RSS: Main: 179159040 03:54:18 INFO - PID 28505 | 03:54:21 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36489/tests/kraken/driver.html?testName=audio-dft) 03:54:22 INFO - PID 28505 | RSS: Main: 179183616 03:54:22 INFO - PID 28505 | 03:54:25 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36489/tests/kraken/driver.html?testName=audio-fft) 03:54:25 INFO - PID 28505 | RSS: Main: 174338048 03:54:25 INFO - PID 28505 | 03:54:28 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36489/tests/kraken/driver.html?testName=audio-oscillator) 03:54:28 INFO - PID 28505 | RSS: Main: 174895104 03:54:28 INFO - PID 28505 | 03:54:30 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:31 INFO - PID 28505 | RSS: Main: 175337472 03:54:31 INFO - PID 28505 | 03:54:34 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36489/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:35 INFO - PID 28505 | RSS: Main: 177815552 03:54:35 INFO - PID 28505 | 03:54:38 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36489/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:39 INFO - PID 28505 | RSS: Main: 177557504 03:54:39 INFO - PID 28505 | 03:54:42 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36489/tests/kraken/driver.html?testName=json-parse-financial) 03:54:43 INFO - PID 28505 | RSS: Main: 178020352 03:54:43 INFO - PID 28505 | 03:54:44 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:45 INFO - PID 28505 | RSS: Main: 178270208 03:54:45 INFO - PID 28505 | 03:54:47 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:47 INFO - PID 28505 | RSS: Main: 174956544 03:54:47 INFO - PID 28505 | 03:54:50 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:50 INFO - PID 28505 | RSS: Main: 175427584 03:54:50 INFO - PID 28505 | 03:54:53 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:54 INFO - PID 28505 | RSS: Main: 175714304 03:54:54 INFO - PID 28505 | 03:54:57 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:58 INFO - PID 28505 | RSS: Main: 175755264 03:54:58 INFO - PID 28505 | 03:54:59 INFO - PID 28505 | Cycle 1(1): loaded http://localhost:36489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36489/tests/kraken/driver.html?testName=ai-astar) 03:55:00 INFO - PID 28505 | RSS: Main: 177348608 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | __start_tp_report 03:55:00 INFO - PID 28505 | _x_x_mozilla_page_load 03:55:00 INFO - PID 28505 | _x_x_mozilla_page_load_details 03:55:00 INFO - PID 28505 | |i|pagename|runs| 03:55:00 INFO - PID 28505 | |0;ai-astar;101;109;103;110;112;112;109;100;108;111 03:55:00 INFO - PID 28505 | |1;audio-beat-detection;150;120;148;178;125;153;143;122;173;121 03:55:00 INFO - PID 28505 | |2;audio-dft;163;163;164;171;168;165;163;172;162;166 03:55:00 INFO - PID 28505 | |3;audio-fft;75;76;76;179;75;76;76;74;158;78 03:55:00 INFO - PID 28505 | |4;audio-oscillator;83;79;133;78;79;79;123;79;79;131 03:55:00 INFO - PID 28505 | |5;imaging-gaussian-blur;114;114;114;121;115;114;115;115;115;113 03:55:00 INFO - PID 28505 | |6;imaging-darkroom;153;150;152;153;150;152;156;151;151;150 03:55:00 INFO - PID 28505 | |7;imaging-desaturate;93;93;94;98;99;94;94;94;95;94 03:55:00 INFO - PID 28505 | |8;json-parse-financial;55;55;58;55;55;55;55;57;58;60 03:55:00 INFO - PID 28505 | |9;json-stringify-tinderbox;54;59;54;54;53;56;54;54;58;54 03:55:00 INFO - PID 28505 | |10;stanford-crypto-aes;80;89;78;92;77;89;79;79;90;80 03:55:00 INFO - PID 28505 | |11;stanford-crypto-ccm;143;132;127;135;130;129;144;134;139;170 03:55:00 INFO - PID 28505 | |12;stanford-crypto-pbkdf2;174;192;180;177;196;177;193;182;177;172 03:55:00 INFO - PID 28505 | |13;stanford-crypto-sha256-iterative;68;67;67;71;67;68;68;66;71;65 03:55:00 INFO - PID 28505 | __end_tp_report 03:55:00 INFO - PID 28505 | __start_cc_report 03:55:00 INFO - PID 28505 | _x_x_mozilla_cycle_collect,983 03:55:00 INFO - PID 28505 | __end_cc_report 03:55:00 INFO - PID 28505 | __startTimestamp1501757700164__endTimestamp 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | ------- Summary: start ------- 03:55:00 INFO - PID 28505 | Number of tests: 14 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:4.50 (4.1%) stddev-sans-first:4.12 03:55:00 INFO - PID 28505 | Values: 101.0 109.0 103.0 110.0 112.0 112.0 109.0 100.0 108.0 111.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:21.28 (14.3%) stddev-sans-first:22.43 03:55:00 INFO - PID 28505 | Values: 150.0 120.0 148.0 178.0 125.0 153.0 143.0 122.0 173.0 121.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:3.53 (2.1%) stddev-sans-first:3.61 03:55:00 INFO - PID 28505 | Values: 163.0 163.0 164.0 171.0 168.0 165.0 163.0 172.0 162.0 166.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:39.43 (51.9%) stddev-sans-first:41.20 03:55:00 INFO - PID 28505 | Values: 75.0 76.0 76.0 179.0 75.0 76.0 76.0 74.0 158.0 78.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:24.11 (30.5%) stddev-sans-first:25.22 03:55:00 INFO - PID 28505 | Values: 83.0 79.0 133.0 78.0 79.0 79.0 123.0 79.0 79.0 131.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:2.21 (1.9%) stddev-sans-first:2.32 03:55:00 INFO - PID 28505 | Values: 114.0 114.0 114.0 121.0 115.0 114.0 115.0 115.0 115.0 113.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:152.00 stddev:1.87 (1.2%) stddev-sans-first:1.94 03:55:00 INFO - PID 28505 | Values: 153.0 150.0 152.0 153.0 150.0 152.0 156.0 151.0 151.0 150.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.04 (2.2%) stddev-sans-first:2.06 03:55:00 INFO - PID 28505 | Values: 93.0 93.0 94.0 98.0 99.0 94.0 94.0 94.0 95.0 94.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:1.83 (3.3%) stddev-sans-first:1.88 03:55:00 INFO - PID 28505 | Values: 55.0 55.0 58.0 55.0 55.0 55.0 55.0 57.0 58.0 60.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:54.00 stddev:2.00 (3.7%) stddev-sans-first:2.09 03:55:00 INFO - PID 28505 | Values: 54.0 59.0 54.0 54.0 53.0 56.0 54.0 54.0 58.0 54.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.50 stddev:5.89 (7.0%) stddev-sans-first:6.12 03:55:00 INFO - PID 28505 | Values: 80.0 89.0 78.0 92.0 77.0 89.0 79.0 79.0 90.0 80.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.00 stddev:12.53 (9.1%) stddev-sans-first:13.17 03:55:00 INFO - PID 28505 | Values: 143.0 132.0 127.0 135.0 130.0 129.0 144.0 134.0 139.0 170.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:181.00 stddev:8.56 (4.7%) stddev-sans-first:8.58 03:55:00 INFO - PID 28505 | Values: 174.0 192.0 180.0 177.0 196.0 177.0 193.0 182.0 177.0 172.0 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:2.05 03:55:00 INFO - PID 28505 | Values: 68.0 67.0 67.0 71.0 67.0 68.0 68.0 66.0 71.0 65.0 03:55:00 INFO - PID 28505 | -------- Summary: end -------- 03:55:00 INFO - PID 28505 | 03:55:00 INFO - PID 28505 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:00 INFO - TEST-INFO | 28505: exit 0 03:55:00 INFO - TEST-OK | kraken | took 62961ms 03:55:00 INFO - SUITE-END | took 1176s 03:55:01 INFO - Completed test suite (00:19:36) 03:55:01 INFO - javascript benchmark 03:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8527.640622277817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.9368612627763, 3176.555282260484, 3189.537517060026, 3209.3741720364537, 3247.3180632067265, 6145.72344244509, 6203.410675985785, 6235.781747638834, 6269.686515674221, 6275.435210831024, 6230.626162430257, 6267.717952692128, 6275.9372406275925, 6281.591696539722, 6291.465225455841, 5714.7428365723645, 5731.168980497825, 5736.397678243787, 5778.59549831512, 5815.534757219412, 5789.884202315951, 5839.8540036499, 5843.64938103713, 5850.736716847752, 5871.677057761822, 5711.571632127607, 5793.594448388614, 5796.043652797283, 5826.533877289807, 5854.707264636772, 5584.413636568183, 5688.800891968761, 5693.202951586781, 5734.713264336767, 5829.679367634779, 5454.91817622736, 5671.291088613923, 5695.857603559903, 5738.454846789548, 5752.338481074688, 6143.32423433422, 6150.938490615082, 6159.784407545714, 6197.0704394340755, 6248.718807653667, 6537.64042977636, 6626.602403855784, 6677.833054173684, 6689.1972963244725, 6772.8984065239065, 6735.0, 6762.188537375547, 6765.424938880201, 6767.0, 6770.458363330922, 6237.594556353823, 6243.937560624427, 6256.311805701369, 6262.12330273762, 6267.592606480564, 6791.286914873867, 6804.251532331439, 6877.1747390313485, 6880.0, 6896.965515172392, 6580.21037475506, 6586.37429444202, 6635.336466353326, 6662.167229096363, 6668.199816022108, 6661.833454163588, 6686.933130668728, 6774.0, 6776.796696099125, 6816.07982922309, 6551.836204094936, 6572.737090516422, 6643.10318107059, 6655.46756259498, 6755.49333799967, 6765.898511522331, 6769.289224631343, 6780.559263647946, 6790.898136527956, 6795.694193761293, 5438.646487978269, 5457.072297709399, 5465.371482279509, 5479.67121972675, 5500.257465242141, 4645.535446455395, 4682.180618391836, 4712.88217794551, 4718.9382388962895, 4721.244600863845, 5687.971560142173, 5780.479756821822, 5807.651540907559, 5812.622179558315, 5820.970895145497, 6668.933310666831, 6694.163229596301, 6711.765088221889, 6713.932860671429, 6721.7311307548125, 5722.713864306768, 5748.39641837601, 5758.193852860602, 5768.942310576925, 5829.621074630136, 5383.111786555174, 5859.765609375577, 5890.911636325459, 5895.02732049207, 5897.970510147422, 6452.870942581122, 6458.773942911976, 6485.967570162119, 6486.643234622046, 6491.67541622917, 6713.597184168965, 6821.89767153503, 6823.965880170766, 6828.351306625863, 6830.658467076726, 6473.805785826433, 6570.934290657032, 6585.176852893388, 6586.604803711793, 6602.735890564323, 6600.471962242913, 6612.4710023198995, 6636.502262330248, 6724.93275067243, 6735.528513004043, 6604.933950660432, 6707.0, 6714.328567143247, 6721.193456785021, 6732.023856540872, 6500.219973603198, 6508.446782023391, 6508.8047358579315, 6510.934890651033, 6521.152250207443, 6509.414152726277, 6513.381228783258, 6536.83657908537, 6589.374009469093, 6606.240282367589, 6305.96847015762, 6445.0, 6494.870102598016, 6560.9343906560325, 6579.638119903451, 6406.647634380154, 6469.967650161719, 6481.643509606828, 6487.3836985486305, 6504.447121994494, 6208.410201030895, 6258.43674069336, 6259.467945224525, 6271.43557079865, 6273.937260627518], "value": 6116.479094360325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.560241866973, 866.982660346793, 894.4320356573573, 904.7964208053187, 1171.145064103204, 29243.56134657982, 30297.545536816964, 40959.385609215846, 41129.0, 41550.79224603873, 40968.0, 41306.38040429389, 41396.172076558454, 41413.58586414135, 41442.17115657685, 7083.327083927044, 7480.700771969115, 7700.4609677322605, 7731.188225236326, 7742.303192712655, 7534.849303013936, 7644.847103057963, 7651.617419129049, 7651.693932242703, 7652.349550288204, 7652.234776522331, 7676.846463070735, 7710.074791025057, 7710.460267781257, 7729.458937874351, 7609.733659321925, 7657.081150261948, 7660.5403675779635, 7672.309492145706, 7705.537667739954, 7542.736004239825, 7588.962055189744, 7599.772006839804, 7608.505447145973, 7608.961955190244, 37833.43249851254, 37991.620083799084, 38077.428838567444, 38149.427758583646, 38246.61753382458, 3542.822858857047, 3578.8389522471552, 3587.031501494608, 3592.9281414371826, 3595.8741444049333, 31066.689333106606, 31270.218244544067, 31275.84362078198, 31406.685933140834, 31461.37077258465, 4644.95355046452, 4891.926621100686, 4894.461609222983, 4909.410870695539, 4926.285688575173, 191492.0, 191921.0, 192169.0, 192494.0, 192760.0, 48112.03775924532, 48125.0, 48293.75853120782, 48352.27471587929, 48481.75759121182, 53721.73139134357, 53945.73027134917, 54234.0, 54381.45618543843, 54455.0, 16261.918690406472, 16299.266533006043, 16404.589885252964, 16405.507834764976, 16409.91795041017, 12103.81844272319, 12278.754424911453, 12295.56965506203, 13530.458781648624, 13729.656758581115, 14315.57053288403, 14343.78484322736, 14355.066920650124, 14540.49108281205, 14563.635909102357, 5832.883342333214, 5876.7355469004, 5880.147378630075, 5886.587938844325, 5926.081457374028, 1004.9899501005043, 1019.5412064570972, 1021.5096753558333, 1030.7114008077751, 1040.765827688764, 23142.0, 23639.645405318934, 23800.523989520112, 28824.279393015342, 30728.53907191394, 1087.7226307291749, 1107.0811226681997, 1113.33200079953, 1115.8716747573972, 1115.9442027898572, 12854.03594730399, 16483.58791030234, 16667.33330666784, 16771.91614041922, 16815.91592042032, 220664.0, 221044.0, 221482.0, 221531.0, 222079.0, 56618.716906415204, 57123.714381427824, 57199.42800571941, 57245.14132288019, 57312.42687573071, 1410.6543896745363, 1467.8972471926863, 1470.353044660346, 1472.3153733513752, 1481.8073650425376, 27059.594106088032, 28422.147335579964, 28598.857005715672, 28713.0, 29024.0, 38303.808480957414, 38819.0, 38883.611163887996, 38901.0, 39049.82850514489, 213707.0, 214422.0, 214946.0, 215291.0, 215798.0, 34508.30983380369, 37171.25657486781, 37958.24083518369, 38015.809920951324, 38062.61937380591, 45621.771891140335, 46629.3005604923, 46682.53317466782, 47420.2886956689, 47467.0, 34238.0, 34399.484007739404, 34409.31181376308, 34659.0, 34921.301573968885, 34304.656953430145, 34552.0, 34621.0, 34799.30401392009, 34928.0, 37096.07259818526, 37138.07154821151, 37148.81425592855, 37293.440598391586, 37462.0, 33114.5032824503, 33283.50074748929, 33287.50068749019, 33439.66560334365, 33622.83188584042, 24200.636990444804, 25620.8718956404, 25696.0, 25706.35734106662, 26046.218613441626], "value": 17731.13256525066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8801151758131, 571.8255931940759, 576.2221001647774, 585.2245774348988, 598.2730981857044, 21598.568028639416, 22519.887400563017, 22666.43333916651, 22676.319710408694, 22684.54630907381, 26018.089366872162, 26634.6004809928, 26650.466990660174, 26662.200133995964, 26766.330841728966, 6440.516961227903, 6651.634160121192, 6660.733570657168, 6662.034005069262, 6662.10061641677, 3882.2429626222897, 4078.8980275493054, 6235.968820155916, 6537.673116344187, 6568.343165683417, 6601.900971485432, 6605.768798092067, 6614.338566143371, 6615.404613584777, 6615.6030638161865, 6575.934240657604, 6582.44049255809, 6604.0, 6610.537262391635, 6634.800955971328, 6139.201903752528, 6146.66193359365, 6151.323354431009, 6157.938420615781, 6162.661053642048, 28689.713102868915, 30049.699503004907, 30268.394632107455, 30333.393332133455, 30745.692543074507, 1773.813749556291, 1813.8276863697927, 1817.0551313317, 1823.3527097880194, 1824.1973531646033, 18690.906545467187, 19322.227110915548, 19394.418167454856, 19453.4163975081, 19474.318398856114, 2214.269291133922, 2230.710007699005, 2237.2281562860785, 2285.1773361589812, 2313.0400883633274, 136362.0, 140200.0, 140698.59301406957, 141636.29181854127, 142010.28994855064, 14269.0, 14751.631209219855, 14848.406063757544, 15040.32318545668, 15658.0, 22994.8850255751, 23955.16156934499, 24248.0, 24281.39296517601, 24304.513909721707, 10259.384436933808, 10487.0, 10487.94756026215, 10505.947470262752, 10537.42044187577, 9577.808443831223, 9595.520223988913, 9607.711768646812, 9667.419954802594, 9710.951445242728, 9118.81762364749, 9460.1485866271, 9575.186109180797, 9577.377470464537, 9607.855882161773, 2911.548709949961, 2914.664813546427, 2926.536731634183, 2945.528715405525, 2979.61265035544, 975.2100798353357, 990.3315262198131, 993.5032483758121, 1003.4631472162504, 1007.2697294461457, 19591.11839967205, 19651.901740491205, 20121.698174527395, 23453.648195277085, 24905.750942490344, 1036.8081904847627, 1044.4777611194402, 1049.8057859296055, 1063.3460421840666, 1065.4406436620682, 10806.94596527028, 11180.329180249211, 11246.437678116225, 11281.887181128248, 11420.88579114215, 496407.0, 496520.0, 497041.0, 502909.0, 513425.0, 118367.40816295863, 119269.40365298119, 121466.0, 124409.37795310965, 125341.0, 1232.8150777383285, 1266.0567876931561, 1287.6973911130876, 1294.3851670456459, 1296.0603562417361, 20809.0, 20967.84657381098, 20986.740795552316, 21004.0, 21171.364859053636, 48998.510014899395, 51391.48608514017, 57516.0, 57598.7120064397, 60804.0, 69365.65317173382, 74949.25050749641, 78549.0, 78633.60683196547, 80170.0, 14585.270736462922, 15043.247837608295, 15329.540113796158, 15356.539303820904, 15371.231438428258, 23367.88316058409, 23656.763432366144, 23702.88148559246, 23787.64318535258, 23803.761962380846, 18881.527961801065, 18886.905565472083, 18906.14922328526, 18983.33558325452, 18990.905045474683, 16251.674966500841, 16314.836851631331, 16759.66480670404, 17545.82454175493, 17587.648247035242, 19110.33113841009, 19115.713264301325, 19446.513837154183, 19547.0, 19801.702974455107, 14657.92671036638, 14930.178840163895, 15168.772468413203, 15215.923920380328, 15350.846491534941, 18919.337823176123, 18948.05259737035, 19186.808131918504, 19320.0, 19343.613127737648], "value": 12188.376031506297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.1293746127556, 1383.9031267811251, 1388.5834249725092, 1407.9366428510716, 1408.2747385096677, 13323.467061317548, 13925.930370348135, 13945.093568918039, 13949.581512554627, 13967.860321396784, 12850.293233872157, 13751.381187846546, 13789.72420551591, 13811.792823107662, 13851.376688049037, 2710.227585138236, 2760.323720688424, 2763.392053748182, 2772.085211880085, 2774.6392968914015, 2615.7515036071636, 2627.8686065696734, 2707.431439397729, 2722.863856807152, 2750.9037183698574, 2704.6078318643786, 2742.5474796658527, 2743.0810678422754, 2745.3136715821047, 2748.051922086887, 2557.693076830783, 2615.1500762252344, 2616.123598594473, 2616.2674451153707, 2628.342914271432, 2587.3660953066433, 2608.4261462478225, 2614.0328078611037, 2614.359481926921, 2626.0808716949105, 13742.106763060468, 14066.085704429179, 14078.155310681392, 14081.155130692192, 14084.647883802987, 7665.501742386727, 7958.164392738795, 7961.72133975308, 7979.122296547375, 7986.960065199695, 4875.122477953967, 5031.396232452093, 5156.664816786897, 5217.087009773274, 5227.26818245446, 1866.9066546672748, 1887.3582981786258, 1895.9431217063511, 1944.3486432045281, 1949.9122539485757, 22287.554248915094, 22318.330450086523, 22511.887440562856, 22526.549469010693, 22540.09839606414, 6315.905261421082, 6425.485961123099, 6534.135753748976, 6641.335866413417, 6677.0, 16103.436379726654, 16109.436169734237, 16120.435784747477, 16127.032378057354, 16133.354665813471, 7642.617869106522, 7763.844723105619, 7827.726029588937, 7832.020997375328, 7849.293563579306, 6961.164660240804, 7081.964590177016, 7133.251008644018, 7221.061262035902, 7281.927180728125, 4926.753662316942, 5102.642815002989, 5120.846374608767, 5131.717755523482, 5148.613853960893, 1405.0796728143082, 1449.6738233897288, 1545.6985887752005, 1549.387991743255, 1580.573245223783, 678.8065401360589, 863.369740089738, 876.7588913048962, 879.7052987249343, 888.995435158267, 7677.270659287359, 7795.415343849234, 7931.920680793118, 7934.56359900211, 8007.0391553014015, 978.9021097890296, 996.0686757881404, 1000.5797565022563, 1001.4141727089589, 1009.6213919780082, 4859.586935110485, 5365.38298095724, 5390.137577987503, 5402.324709411324, 5459.836204913859, 19374.0, 19673.311434099738, 19743.308984185773, 19746.308879189448, 19761.505962351057, 18527.72208416875, 18712.345067922557, 18914.24343026291, 18933.33733319327, 19056.61886762257, 11090.889091109148, 11260.943695281636, 11265.831012534818, 11344.20590558653, 11390.487428065757, 7643.4267429941865, 7877.527348359117, 7906.565138917184, 7939.483933544301, 7940.523568585903, 16156.222815490051, 16484.917575412048, 16510.33958641689, 16863.325466981183, 17004.65990680204, 16048.277827497557, 16090.115043672711, 16197.0, 16501.09243991592, 16554.337826487288, 11241.775164496828, 11551.075913927034, 11580.478878450322, 11598.768024639292, 11608.593699220486, 13085.214887106804, 13101.672458188621, 13109.475620975054, 13263.734725305632, 13266.867331326563, 9913.157381622643, 10646.148308135176, 10646.8935310649, 10684.89315106839, 10767.676969690921, 10596.31123976939, 10618.36289822613, 10620.575176992834, 10694.19793515505, 10870.293430926964, 9380.437173769596, 9549.761255968657, 9560.043995600663, 9560.28297877648, 9600.567974441306, 6949.722011119498, 6964.930350696428, 6978.47661425385, 6979.546329488567, 7014.018037474656, 6768.932310676831, 6840.452763778786, 6842.863142737217, 6888.242293347627, 6908.5509441886115], "value": 6378.321808720282, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.90577790219857, 500.13783326113486, 523.0924346259237, 523.9921401178983, 526.3552148617944, 6054.485368743656, 6086.330503644606, 6111.144439778434, 6143.170671959284, 6150.200473938393, 5965.671888046156, 5971.731272092756, 5999.460048595625, 6043.909341359883, 6112.6638034908065, 4849.515048495157, 4878.75562750772, 4910.508949105097, 4912.435069966946, 4940.555350018498, 4771.737554434505, 4854.781534830923, 4898.951010489885, 4909.533594308535, 4936.679115857476, 4818.566329030386, 4841.7337046462435, 4880.926786098212, 4887.511248875119, 4902.754862256891, 4898.8040478381, 4908.558229759339, 4911.287863259825, 4917.188663870493, 4934.360117337207, 4442.3336499525, 4463.531329210418, 4467.195904737146, 4481.753503557303, 4490.124425736983, 5981.970090149565, 5982.491488223506, 5998.220231369894, 6044.24446944132, 6054.606450580698, 5643.717814109319, 5660.0, 5676.716164191774, 5680.602357834953, 5704.857378565527, 6453.903191452132, 6486.708098135595, 6523.902141467882, 6534.117894084286, 6558.967205163944, 4773.546513081252, 4837.32277481153, 4847.684900481458, 4866.440359358684, 4871.8064074301665, 6740.887753520712, 6823.965880170617, 6839.931600683979, 6860.6673730932225, 6915.723371065152, 4912.72979986097, 4921.409430868247, 4931.926021109686, 4936.160852655057, 4968.428630707443, 5039.160706342159, 5047.596192304607, 5047.747612619354, 5054.292399064134, 5072.112380333427, 5608.298962629671, 5609.943900560942, 5665.178549110438, 5665.6034077614995, 5707.800226992035, 6434.485241180694, 6472.935270647234, 6517.773702017532, 6529.608223506605, 6566.507511936624, 1643.4576589725361, 1672.8912620679616, 1688.6200604863807, 1698.456493921933, 1763.7971633262082, 1207.8610959739567, 1210.9636710898687, 1233.993830030844, 1238.0961897814645, 1238.7921776268247, 5714.7428365723645, 5720.485156335866, 5775.971120144456, 5781.421857814269, 5805.970970145122, 6586.077949087132, 6619.304972977864, 6667.166604174478, 6717.832054198684, 6751.177182160789, 5757.798477053283, 5772.855678608068, 5810.1865738796605, 5816.702402550969, 5830.4461076197695, 3542.875999340011, 3576.159602493412, 3605.387084195693, 3606.85572577094, 3609.639036096369, 6429.58207716497, 6434.388733070351, 6440.0679796060995, 6469.870602587922, 6495.805125846232, 6789.185297764201, 6792.675428291534, 6822.795316140524, 6849.863002739918, 6874.346937040973, 6418.903716444257, 6444.935550644527, 6478.319776423407, 6510.73957041713, 6515.185601799775, 6624.6025238485845, 6651.0, 6675.265720770614, 6683.8663226734225, 6736.663166841737, 6626.933730662631, 6628.834279142867, 6635.701393437211, 6649.434798042221, 6720.395164435225, 6484.448821850196, 6503.479721622353, 6509.967450162719, 6521.902171467337, 6524.543281970216, 4928.137575924127, 4938.1358262304675, 4973.602111830973, 4986.47641997585, 5014.517813682251, 6481.675916204076, 6711.194656641234, 6713.858644030429, 6728.562643428161, 6770.796876093725, 6115.6330620162935, 6339.104632691641, 6350.206224221973, 6369.617822930639, 6482.513811464253, 6375.840603984938, 6411.294757576569, 6447.838804029937, 6454.644994525346, 6478.481721462177, 6450.129232553545, 6471.708773105316, 6489.286178520265, 6503.967480162569, 6529.347065293433, 6466.385693359123, 6498.187726534184, 6520.413162815369, 6562.573432726857, 6603.603783772989, 6243.8126856194385, 6296.464800491826, 6315.0, 6326.398992095744, 6351.2696039956], "value": 5013.759960404709, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.6608322754123, 900.9819803603928, 901.9368644194909, 908.6320040383645, 910.1535571918114, 18114.90942545287, 18898.338558150466, 18933.431997040076, 18934.14796334165, 18956.62086758264, 17186.312547498084, 18593.81406185938, 21509.462263443384, 21513.139474421045, 21538.0, 1007.2043085962099, 1031.705963800317, 1033.225081189108, 1033.2870319479573, 1033.731229880229, 747.9626018699071, 1057.820170571001, 1057.8783439904394, 1058.095328494138, 1059.3167407022465, 849.4818160921833, 1085.3704851186333, 1122.7586068995165, 1133.5182547417314, 1135.829625556169, 1111.522045520426, 1116.5366372955214, 1116.7375666718315, 1120.42858142348, 1121.495327102803, 811.5860910935406, 815.1522416686639, 816.4285000499615, 817.513579420244, 820.5568992743911, 19495.415137545755, 19765.209391624318, 20214.292499762436, 20343.79656203434, 20466.283680071276, 21325.466863328387, 21380.57238855214, 21581.244656437106, 21891.0, 21919.67120493178, 15699.0, 16039.278232479566, 16082.43711470093, 16159.111248881307, 16288.592785180346, 3531.4526248431534, 3532.311199316134, 3543.291341731638, 3558.395072837624, 3565.4830049642655, 126258.0, 127567.0, 128240.0, 130943.0, 131033.34483327523, 14480.565583032527, 15030.473933412279, 15032.0, 16677.99864016326, 17283.567910802332, 30645.233869153002, 30993.070207893797, 31039.224019399695, 31130.066098017094, 31245.218869528442, 8860.955695221483, 9025.684101056562, 9049.909500905038, 9079.68221112258, 9091.954540227389, 3930.6462418382484, 4008.939865902014, 4023.939640905389, 4139.855105071308, 4320.481542214954, 5229.267902493654, 5325.4674532547215, 5336.573074154058, 5338.733063346895, 5357.249985002103, 1035.5495359518634, 1078.0567003871613, 1081.3403823667556, 1090.2531765740334, 1090.7273181704575, 671.325318055361, 701.9649017549102, 702.220535205921, 709.3722055980494, 716.2300526933567, 12021.939890300493, 12181.756364872654, 12524.0, 12952.158109722837, 12955.352232388343, 695.3498478922224, 698.3609996852823, 709.5272973686698, 710.1300906389735, 717.9641017949186, 5505.587080968943, 5607.102863541813, 5975.492083172892, 6172.969135154295, 6315.336889626615, 98530.5073474628, 99370.0, 99403.50298248463, 100726.0, 102026.48986755167, 88423.0, 88680.0, 90585.54707226422, 90904.9092790826, 91131.54434227786, 75064.62467687626, 78161.60919195367, 80055.59972200102, 80671.0, 85659.14340856636, 12504.687382815502, 12687.80968285458, 12819.551315703906, 12891.290978996245, 12924.224546527239, 34980.12549686278, 35029.299414012086, 35743.46384804178, 36111.63888361083, 36581.0, 46179.53820461887, 46494.767526162155, 46978.76510617425, 47354.0, 47596.7620161897, 17654.911725441805, 17844.375446859296, 18018.549536261173, 18144.364947226783, 18413.631727365646, 20567.58864822665, 20782.896085519475, 20795.376138715863, 20806.791932080487, 20839.47901302419, 18595.628087438447, 18967.14647840878, 19006.429807105807, 19108.808911910703, 19212.0, 18959.43121706296, 19190.328338508087, 19399.515012124244, 19585.216591336186, 20119.798802011792, 18583.0, 19044.523886902938, 19700.90149549243, 19746.50633734168, 19829.504262393555, 13253.933730331672, 13275.468981240641, 13566.050376473551, 13907.652308692364, 14132.0, 14417.13497190172, 14462.710745784814, 14509.473221993194, 14605.466426025114, 14877.851221487646], "value": 9096.86082423324, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 103.0, 110.0, 112.0, 112.0, 109.0, 100.0, 108.0, 111.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 148.0, 178.0, 125.0, 153.0, 143.0, 122.0, 173.0, 121.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 171.0, 168.0, 165.0, 163.0, 172.0, 162.0, 166.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 179.0, 75.0, 76.0, 76.0, 74.0, 158.0, 78.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 133.0, 78.0, 79.0, 79.0, 123.0, 79.0, 79.0, 131.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 121.0, 115.0, 114.0, 115.0, 115.0, 115.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 152.0, 153.0, 150.0, 152.0, 156.0, 151.0, 151.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 98.0, 99.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 55.0, 55.0, 55.0, 55.0, 57.0, 58.0, 60.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 54.0, 54.0, 53.0, 56.0, 54.0, 54.0, 58.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 89.0, 78.0, 92.0, 77.0, 89.0, 79.0, 79.0, 90.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 127.0, 135.0, 130.0, 129.0, 144.0, 134.0, 139.0, 170.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 192.0, 180.0, 177.0, 196.0, 177.0, 193.0, 182.0, 177.0, 172.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 71.0, 67.0, 68.0, 68.0, 66.0, 71.0, 65.0], "value": 67.8, "unit": "score"}]}]} 03:55:01 INFO - Return code: 0 03:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:01 INFO - # TBPL SUCCESS # 03:55:01 INFO - Running post-action listener: _package_coverage_data 03:55:01 INFO - Running post-action listener: _resource_record_post_action 03:55:01 INFO - [mozharness: 2017-08-03 10:55:01.451807Z] Finished run-tests step (success) 03:55:01 INFO - Running post-run listener: _resource_record_post_run 03:55:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433430528; Read time: 8; Write time: 253172 03:55:01 INFO - TinderboxPrint: CPU usage
13.2% 03:55:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:55:01 INFO - TinderboxPrint: I/O write bytes / time
433,430,528 / 253,172 03:55:01 INFO - TinderboxPrint: CPU idle
8,272.2 (86.8%) 03:55:01 INFO - TinderboxPrint: CPU user
1,207.0 (12.7%) 03:55:01 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107565056; Read time: 0; Write time: 74096 03:55:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:55:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 325865472; Read time: 0; Write time: 179076 03:55:02 INFO - Running post-run listener: _upload_blobber_files 03:55:02 INFO - Blob upload gear active. 03:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:02 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 03:55:02 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'] 03:55:02 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 03:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:03 INFO - (blobuploader) - INFO - Done attempting. 03:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:04 INFO - (blobuploader) - INFO - Done attempting. 03:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:05 INFO - (blobuploader) - INFO - Done attempting. 03:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:12 INFO - (blobuploader) - INFO - Done attempting. 03:55:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:12 INFO - Return code: 0 03:55:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c9573075464f97a7d7aec20614c23f3e8b8bb3046bb5b0855f53432835ca52f7562dbfd5eefe8f747f86ef7e7dd610bb59504164cd89cf031233f0f04e2f96c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4eea5057da29e428d2543d7d970113cfd6b383a9ffecbd07d2b7c9e0323d53a3e156ba4b6a9c58a4ba4334dd3dcfe80f7677dd8a93c3bdab131492e35b4ddd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5148ddc8c3ae1f1f5a5bf73355b0e64d1e43ec75abb2e7b2918f33f8b6e196517cae9457179a2dcc21955deac5cd56d7958e732495fb8ab56d82b966c62ec866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67c2d775bd5dfebfdddd7f50ad4fe4ae55962fbfdd75311652ceeccffa58c44912392c55e5a6e003175dd23a4c3316ec6b26ef3d7c52aae4aaf76407eed6438"} 03:55:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:12 INFO - Contents: 03:55:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c9573075464f97a7d7aec20614c23f3e8b8bb3046bb5b0855f53432835ca52f7562dbfd5eefe8f747f86ef7e7dd610bb59504164cd89cf031233f0f04e2f96c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4eea5057da29e428d2543d7d970113cfd6b383a9ffecbd07d2b7c9e0323d53a3e156ba4b6a9c58a4ba4334dd3dcfe80f7677dd8a93c3bdab131492e35b4ddd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5148ddc8c3ae1f1f5a5bf73355b0e64d1e43ec75abb2e7b2918f33f8b6e196517cae9457179a2dcc21955deac5cd56d7958e732495fb8ab56d82b966c62ec866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67c2d775bd5dfebfdddd7f50ad4fe4ae55962fbfdd75311652ceeccffa58c44912392c55e5a6e003175dd23a4c3316ec6b26ef3d7c52aae4aaf76407eed6438"} 03:55:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:12 INFO - Copying logs to upload dir... 03:55:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.193197 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-03 03:55:12.348220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.354148) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c9573075464f97a7d7aec20614c23f3e8b8bb3046bb5b0855f53432835ca52f7562dbfd5eefe8f747f86ef7e7dd610bb59504164cd89cf031233f0f04e2f96c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4eea5057da29e428d2543d7d970113cfd6b383a9ffecbd07d2b7c9e0323d53a3e156ba4b6a9c58a4ba4334dd3dcfe80f7677dd8a93c3bdab131492e35b4ddd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5148ddc8c3ae1f1f5a5bf73355b0e64d1e43ec75abb2e7b2918f33f8b6e196517cae9457179a2dcc21955deac5cd56d7958e732495fb8ab56d82b966c62ec866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67c2d775bd5dfebfdddd7f50ad4fe4ae55962fbfdd75311652ceeccffa58c44912392c55e5a6e003175dd23a4c3316ec6b26ef3d7c52aae4aaf76407eed6438"} build_url:https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c9573075464f97a7d7aec20614c23f3e8b8bb3046bb5b0855f53432835ca52f7562dbfd5eefe8f747f86ef7e7dd610bb59504164cd89cf031233f0f04e2f96c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4eea5057da29e428d2543d7d970113cfd6b383a9ffecbd07d2b7c9e0323d53a3e156ba4b6a9c58a4ba4334dd3dcfe80f7677dd8a93c3bdab131492e35b4ddd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5148ddc8c3ae1f1f5a5bf73355b0e64d1e43ec75abb2e7b2918f33f8b6e196517cae9457179a2dcc21955deac5cd56d7958e732495fb8ab56d82b966c62ec866", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67c2d775bd5dfebfdddd7f50ad4fe4ae55962fbfdd75311652ceeccffa58c44912392c55e5a6e003175dd23a4c3316ec6b26ef3d7c52aae4aaf76407eed6438"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.379092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.379431) ========= 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=3297cc2eebb5444a7688c33f000001b5-1501756130.929820-682953909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.469932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:12.470256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:12.470581) ========= ========= Total master_lag: 0.18 =========