builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1501756452.61 results: success (0) revision: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.610505) ========= 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.610911) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.611178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.632365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.632755) ========= 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=d2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.1M=0s 2017-08-03 03:34:12 (34.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.762237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.762511) ========= 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=d2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015884 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.817099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:12.817397) ========= 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=d2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 03:34:12,816 truncating revision to first 12 chars 2017-08-03 03:34:12,816 Setting DEBUG logging. 2017-08-03 03:34:12,816 attempt 1/10 2017-08-03 03:34:12,816 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:13,448 unpacking tar archive at: mozilla-central-681a2489f6a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:13.777376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:13.777699) ========= script_repo_revision: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:13.778082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:13.778346) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:34:13.789338) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-03 03:34:13.789605) ========= /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=d2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:13 INFO - MultiFileLogger online at 20170803 03:34:13 in /builds/slave/test 03:34:13 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:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:13 INFO - {'append_to_log': False, 03:34:13 INFO - 'base_work_dir': '/builds/slave/test', 03:34:13 INFO - 'blob_upload_branch': 'Firefox', 03:34:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:13 INFO - 'branch': 'Firefox', 03:34:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:13 INFO - 'code_coverage': False, 03:34:13 INFO - 'config_files': ('talos/linux_config.py',), 03:34:13 INFO - 'default_actions': ('clobber', 03:34:13 INFO - 'read-buildbot-config', 03:34:13 INFO - 'download-and-extract', 03:34:13 INFO - 'populate-webroot', 03:34:13 INFO - 'create-virtualenv', 03:34:13 INFO - 'install', 03:34:13 INFO - 'setup-mitmproxy', 03:34:13 INFO - 'run-tests'), 03:34:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:13 INFO - 'disable_ccov_upload': False, 03:34:13 INFO - 'download_minidump_stackwalk': True, 03:34:13 INFO - 'download_symbols': 'ondemand', 03:34:13 INFO - 'enable_stylo': False, 03:34:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:13 INFO - 'gecko_profile': False, 03:34:13 INFO - 'gecko_profile_interval': 0, 03:34:13 INFO - 'installer_path': 'installer.exe', 03:34:13 INFO - 'log_level': 'info', 03:34:13 INFO - 'log_name': 'talos', 03:34:13 INFO - 'log_to_console': True, 03:34:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:13 INFO - 'opt_config_files': (), 03:34:13 INFO - 'pip_index': False, 03:34:13 INFO - 'suite': 'dromaeojs-e10s', 03:34:13 INFO - 'system_bits': '32', 03:34:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:13 INFO - 'title': 'talos-linux64-ix-043', 03:34:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:13 INFO - 'use_talos_json': True, 03:34:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:13 INFO - 'work_dir': 'build'} 03:34:13 INFO - [mozharness: 2017-08-03 10:34:13.898898Z] Running clobber step. 03:34:13 INFO - Running pre-action listener: _resource_record_pre_action 03:34:13 INFO - Running main action method: clobber 03:34:13 INFO - rmtree: /builds/slave/test/build 03:34:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:14 INFO - Running post-action listener: _resource_record_post_action 03:34:14 INFO - [mozharness: 2017-08-03 10:34:14.913461Z] Finished clobber step (success) 03:34:14 INFO - [mozharness: 2017-08-03 10:34:14.914215Z] Running read-buildbot-config step. 03:34:14 INFO - Running pre-action listener: _resource_record_pre_action 03:34:14 INFO - Running main action method: read_buildbot_config 03:34:14 INFO - Using buildbot properties: 03:34:14 INFO - { 03:34:14 INFO - "project": "", 03:34:14 INFO - "product": "firefox", 03:34:14 INFO - "who": "archaeopteryx@coole-files.de", 03:34:14 INFO - "installer_path": "public/build/target.tar.bz2", 03:34:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:34:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:34:14 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:34:14 INFO - "stage_platform": "linux64-stylosequential", 03:34:14 INFO - "basedir": "/builds/slave/test", 03:34:14 INFO - "buildnumber": 167, 03:34:14 INFO - "platform": "ubuntu64_hw_styloseq", 03:34:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:34:14 INFO - "slavebuilddir": "test", 03:34:14 INFO - "taskId": "K-xATeG3SJKbsBBsgMuC6w", 03:34:14 INFO - "branch": "mozilla-central", 03:34:14 INFO - "script_repo_revision": "production", 03:34:14 INFO - "revision": "681a2489f6a92a09f87336c4ebfcd55030ffcda1", 03:34:14 INFO - "slavename": "talos-linux64-ix-043", 03:34:14 INFO - "repo_path": "mozilla-central" 03:34:14 INFO - } 03:34:14 INFO - Finding installer, test and symbols from parent task. 03:34:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-xATeG3SJKbsBBsgMuC6w'}, attempt #1 03:34:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-xATeG3SJKbsBBsgMuC6w'}, attempt #1 03:34:15 INFO - Task dependencies: ZeSY-_-GThiB0d3w2ugulQ 03:34:15 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.257594Z] Finished read-buildbot-config step (success) 03:34:16 INFO - [mozharness: 2017-08-03 10:34:16.257829Z] 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:16 INFO - Downloaded 989 bytes. 03:34:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:34:16 INFO - Using the following test package requirements: 03:34:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:34:16 INFO - u'common': [u'target.common.tests.zip'], 03:34:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:34:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:34:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:34:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:34:16 INFO - u'mozbase': [u'target.common.tests.zip'], 03:34:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:34:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:34:16 INFO - u'web-platform': [u'target.common.tests.zip', 03:34:16 INFO - u'target.web-platform.tests.tar.gz'], 03:34:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:34:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:34:16 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:16 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:16 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:43 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:43 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:43 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.talos.tests.zip into memory 03:34:44 INFO - Content-Length response header: 14496464 03:34:44 INFO - Bytes received: 14496464 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 INFO - trying https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 03:34:44 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:44 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.490885Z] Finished download-and-extract step (success) 03:34:46 INFO - [mozharness: 2017-08-03 10:34:46.491009Z] 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.502111Z] Finished populate-webroot step (success) 03:34:46 INFO - [mozharness: 2017-08-03 10:34:46.502202Z] 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:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:49 INFO - Installing pip.................done. 03:34:49 INFO - Return code: 0 03:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:49 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 03:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:54 INFO - '_': '/tools/buildbot/bin/python'} 03:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:55 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:55 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 - 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:55 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 blobuploader-1.2.4.tar.gz 03:34:56 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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-P3gHnQ-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-LBcJKO-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-yg9OMC-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-fFLBRT-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-700Ks_-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-vkUnKX-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-TePZyf-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:58 INFO - Running setup.py (path:/tmp/pip-EOyy1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:58 INFO - Running setup.py (path:/tmp/pip-7f8JA6-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-InclsU-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-yMQEVd-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-Da2EXI-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-0RDzPT-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-g5_jue-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-xg9rjQ-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-AVfdjx-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-Ylp35Z-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:59 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:35:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:00 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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-dtbRnK-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-AEFTaI-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-9LNuNg-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-kzfuXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:01 INFO - Running setup.py (path:/tmp/pip-SKdHx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:01 INFO - Running setup.py (path:/tmp/pip-qn3LLH-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-ZWQBXS-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-64lV4j-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-Bqxiz5-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-9eYSwu-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-4fEY1n-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-5uQMDi-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-zdkCRA-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-n6JzlI-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-QODyx6-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-gZWfMI-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-UYxtiA-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:03 INFO - Downloading blessings-1.6.tar.gz 03:35:03 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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 0xf1f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128ed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', '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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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.207553Z] Finished create-virtualenv step (success) 03:35:06 INFO - [mozharness: 2017-08-03 10:35:06.208059Z] 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.595234Z] Finished install step (success) 03:35:24 INFO - [mozharness: 2017-08-03 10:35:24.595488Z] 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.596612Z] Finished setup-mitmproxy step (success) 03:35:24 INFO - [mozharness: 2017-08-03 10:35:24.596832Z] 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 0x128beb0>, '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 0x128cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x128d240>, '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-043', '--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-043 --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': 'd2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779', 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-043', '--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:53285' 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:53285/getInfo.html -profile /tmp/tmpgA4rfm/profile 03:35:24 INFO - TEST-INFO | started process 5451 (/builds/slave/test/build/application/firefox/firefox http://localhost:53285/getInfo.html) 03:35:31 INFO - TEST-INFO | 5451: 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 5677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgA4rfm/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 5677 | 03:35:32 INFO - PID 5677 | (/builds/slave/test/build/application/firefox/firefox:5731): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:35:32 INFO - PID 5677 | 03:35:42 INFO - PID 5677 | RSS: Main: 173993984 03:35:42 INFO - PID 5677 | 03:38:42 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53285/tests/dromaeo/cssquery-ext.html) 03:38:43 INFO - PID 5677 | RSS: Main: 173338624 03:38:43 INFO - PID 5677 | 03:41:45 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-ext.html (next: http://localhost:53285/tests/dromaeo/cssquery-jquery.html) 03:41:46 INFO - PID 5677 | RSS: Main: 173895680 03:41:46 INFO - PID 5677 | 03:44:47 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53285/tests/dromaeo/cssquery-mootools.html) 03:44:48 INFO - PID 5677 | RSS: Main: 175812608 03:44:48 INFO - PID 5677 | 03:47:50 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53285/tests/dromaeo/cssquery-prototype.html) 03:47:50 INFO - PID 5677 | RSS: Main: 174161920 03:47:50 INFO - PID 5677 | 03:50:54 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53285/tests/dromaeo/cssquery-yui.html) 03:50:55 INFO - PID 5677 | RSS: Main: 177414144 03:50:55 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | Cycle 1(1): loaded http://localhost:53285/tests/dromaeo/cssquery-yui.html (next: http://localhost:53285/tests/dromaeo/cssquery-dojo.html) 03:53:57 INFO - PID 5677 | RSS: Main: 178184192 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | __start_tp_report 03:53:57 INFO - PID 5677 | _x_x_mozilla_page_load 03:53:57 INFO - PID 5677 | _x_x_mozilla_page_load_details 03:53:57 INFO - PID 5677 | |i|pagename|runs| 03:53:57 INFO - PID 5677 | |0;dojo.html;3136.1532386255712;3165.050484854543;3187.3784612000663;3188.5057816038507;3246.8863589774346;6072.02847544393;6122.693865306739;6140.20177376941;6153.230846144232;6371.108044873721;6221.377862213776;6274.811755647338;6297.18136642237;6316.399942005513;6332.873342533147;5688.317401911776;5749.252597162363;5791.478766910977;5806.59353845231;5854.975379308604;5532.944670553304;5620.016497113009;5625.662460252377;5664.490195882369;5773.1051686988585;5681.346645135821;5693.174489698991;5750.942490575104;5763.366029736726;5781.248437703114;5677.063284558043;5695.14572814077;5750.769969201227;5765.567582431335;5775.047117225653;5497.917531237034;5633.408492108351;5699.031164702011;5702.714864256771;5724.599278050497;6040.0939859021055;6059.909101363483;6060.848478788022;6061.54538409621;6087.756489740405;6622.37087476689;6633.535652504326;6728.730850765964;6730.528862979593;6731.427828634572;6689.531732778707;6727.66361681914;6756.729730810811;6782.220044694874;6803.319668033207;6211.65835879022;6230.314665386803;6307.369263073656;6315.147455093549;6340.556161068681;6731.461483081342;6880.862382752317;6907.171139463297;6972.686229119702;7002.474814388839;6538.836529086716;6541.738330466823;6555.147830781968;6556.409923106943;6579.342065793382;6580.309067547934;6630.403263706193;6726.226483954408;6740;6747.527673062838;6678.799636010927;6684.364985326386;6691.665416729144;6781.898271525931;6787.966060169766;6644.534882558174;6710.429613482908;6732.3267673232285;6734.528582999143;6749.5612785168805;5317.867053323621;5381.67709937405;5439.292891924025;5447.1829225616475;5470.7264636768;4542;4593.356930029799;4621.23749581322;4631.258998560214;4648.697834640738;5715.31416230055;5722.914156287659;5724.79963201286;5740.052891272977;5778.537716982715;5776.335721392094;6589.110470086573;6616.8345791355605;6654.567453115532;6667.33326667339;5769.134629805562;5825.79609713658;5845.210896528999;5849.268841394825;5914.9704251479325;5907.084401917709;5931.991561434566;5975.7609695612555;5980.581359304894;5982.341942386334;6407.327230640809;6470.579412338183;6470.838229044218;6470.838229044218;6479.1901012373455;6630;6657.434118100015;6659.833504162435;6680.63256520896;6768.763093291908;6488.383603557843;6492.870142597028;6533.640649764118;6536.346365363425;6552.475801935929;6589.209294884645;6680.3987641112535;6689.431398331002;6701.597904125768;6707.42986846104;6693.665316734046;6707.228668702966;6719.294474080151;6808.62552559614;6821.8635627286185;6347.174867267226;6448.1295025171;6509.707063182263;6563.704633291418;6579;6484.643344616092;6509.934900650933;6521.217453905561;6522.380373864476;6522.608643481406;6399.840003999937;6408.198975128109;6482.837929051623;6483.578567393104;6492.058651495601;6429.099926010455;6499.415052645285;6557.147570815763;6584.308647591934;6588.176477940257;6182.103594978613;6313.684315784284;6326.082718005771;6330.651814150266;6339.207599050119 03:53:57 INFO - PID 5677 | |1;ext.html;827.710301394512;883.2360008592567;914.1452741686521;1163.5520324674997;1186.6973921649978;30716.232094197658;31335.68664313359;31415;41297;41920.37119443211;43417;43466.56533434665;43551.56448435515;43999.340009899795;44010.67967960958;7594.810129746759;7748.496347737408;7757.728479503218;7770.145284018753;7777.572233527154;6990.405815505688;7257.092863392076;7709.575973321465;7714.074311082678;7719.189485104067;7669.156392796788;7688.15430302669;7731.072271327449;7745.535267883945;7760.805979850521;7616.543007419545;7670.30967212948;7677.155512893577;7694.345980591601;7700.730474433424;7577.2422757724335;7580.734674286374;7589.8861517077285;7632.427567932427;7646.464747467679;38302.61697383046;38636;38688.80655596704;38689.61310386917;38701.80649096736;3495.615482296945;3547.6629720176543;3565.322588708163;3575.982120089383;3579.6957258633047;30187.547186792217;30385;30432.54351184734;30494.695053049407;30549.389012219854;4671.205894997858;4816.109019831342;4825.276208568707;4839.540243676845;4948.331975183341;192616;193474;193883;194887;195340;46116.3082553762;46321;46321;46347.30479042817;46379.76810115928;48615.513844861096;48707.756461218174;48986.510134898905;49072.50927490679;49093.50906490961;15978.60053498672;16204.513864584082;16254.18729063542;16268;16285.185740712917;11640.243384180001;13273.867261327456;13296;13299.534516291884;13326.866731332757;12671.936640316739;13326.20042797416;14063.367148478343;14135.71728565423;14150.504732334319;5425.403205647375;5565.749541270652;5569.303837020372;5688.175214593944;5744.454276843693;995.1640621877658;1012.8227560177087;1022.6676330192718;1023.2325755683238;1024.078329503438;22314.21900233484;22419.775802242097;22767.203147889744;22958.551500859467;23410.53178936412;1107.1751545098953;1112.7996960547018;1114.0808832713044;1120.1486869978712;1144.6508814811395;12136.939315303543;16450.917745411196;16469.258883350278;16618.418355357506;16738;238352;240430;240906;240998;241830;55473.72263138658;55533.72233138889;55630;55829.72085139548;55963;1465.2600436779358;1479.216015511759;1490.7018596280786;1503.7142942840826;1517.544736579022;27859.44281114407;27926.581101283904;28788.568171477025;28821.711782881903;28864;52199.21701174409;52305.21542176946;52666.47333526769;52859.73570132279;52937;196421;201154;201232;201430;201603;35045.64954350424;35070.47394289036;35375.11562210862;36266.8186659065;37180.814095929345;39278.4108238371;40025.799871001625;40306.79846600866;40339.1932161361;40377.79811100926;32230;32928;33218.83390583032;33443.33113337768;34462.48306275358;30668.38663226678;30923.845380772953;31349.686503134675;31522.527162092127;31562;36539.451908220864;37086.62913370832;37306.25387492289;37543.62456375401;37560.43659345058;32470.837645811618;32864.671353287114;33008;33233.83383083166;33742.66257337395;23996.76003240015;25005.249842504752;25264.62103068492;25411.618825717258;25653.486930261664 03:53:57 INFO - PID 5677 | |2;jquery.html;564.5849457244349;574.4026212738746;574.8764015736618;594.2007999241021;600.7086563016936;22200;22590.66114008287;22954.08183672653;23039.76960230397;23067.653985190194;27196;27980.860095699543;28070.43859122816;28096.297592560197;28177;6872.553284036534;7033.683484243222;7086.503944723871;7086.929130708704;7091;4128.091819799639;4130.339145736682;5748.45389687979;7015.088038554981;7101.360877521022;6894;6900.896486552706;6925.203601585832;6926.445884329267;6932.341427564374;6862.764702353599;6891.827704307432;6901.896471552931;6902.482313826483;6906.171259448874;6764.898526522106;6787.846066168714;6802.761903333359;6805.965970170167;6812.48906332027;30894.536581951288;31700;32334.191645208823;33270.83364583162;33352.332953340796;1904.2954106980367;1933;1934.0523143659505;1935.9709604355946;1938.04066986841;19392.321268755524;19655.213791448325;20698.275560355316;20764.792352076438;20788.168473261052;2309.711286089239;2348.072511358004;2359.988200059006;2373.1931143411152;2381.6784734060852;135198.32400837934;138621;140239.29880350534;147885.2605736975;151553.24223378923;21416.89291553532;21638.35084947454;22836.65745013826;23350.299491015296;23448.179313723937;43059.56940430618;43146.35280470795;43288.78355608202;43342.783286084;43466.34800477995;11620.825687614693;11953.880461195451;12098.092643051807;12129.332886691316;12192.329421881705;8445.408821382567;8964.193222609996;10158.288919775692;10193.694189174337;10229.795404092025;10816.891831081746;11452.94273528627;11765.823512647317;11772.293662380285;12029.759404811855;4281.871543853689;4349.650349650349;4390.736555806662;4572.497025327211;4607.746573938465;940.116290686766;948.3882895532342;960.3325688646463;984.0356450678375;988.0958922585897;20427.795722042887;20490;20519.281825136346;20594.897025515078;20966.685499717212;1046.9685909422728;1055.1137044882337;1057.1701214546545;1065.0042210533177;1069.5828626835385;11074;11435.885641143648;11477.196596238184;11535.596254131066;11628.895254950767;513961;524820;532738;541751;544835;103429;105468;107655.46172269089;108097.45951270193;108766.45616771866;1193.7194759231575;1208.1482554798845;1229.5266322465916;1229.57579635024;1232.969175770613;17909.19408626589;17946.37187698424;18105.547361316072;18113.909430452764;18323.08384580739;53474.45422789685;54510;54580.454195459126;55629.44370556243;55697;67535.66232168808;67661;68137;68252;69068;20646.277380291616;20681.482962926046;20717.89641051785;20937.26719564808;21038;23273.76726232716;23305.650415243446;23953.880230598734;24079.27762167138;24272.27183184507;18466.261349546407;18529.35147269893;18772.15525301392;19001.144948477075;19245.711314330016;17003.659926801643;17271.7409238859;17425.39011134604;17507.21217545239;17895.37366192177;19533.413997580094;19790.70313945263;19919.60160796805;19933.60132797365;20037;14874.256287185814;15206;15266.160361180242;15383.61540961485;15435.305411256744;18988.525286867938;19170.329038484146;19309.806901930802;19521.219151233792;19531.437485000883 03:53:57 INFO - PID 5677 | |3;mootools.html;1346.649871033531;1372.409863758584;1393.8815200707938;1394.4561620967825;1412.1967893730946;13342.733145337099;13964.511242106528;13980.580582582514;14010.579682609512;14028.368723407446;13470.124441911268;13953.720925581481;13953.790693139612;14001.29993500326;14019.228942408163;2652.2971412575685;2720.8503532305717;2721.18364490653;2723.128598848369;2728.031548800177;2583.586626139818;2758.8620568971573;2767.33583939854;2770.7506324430797;2770.972290277102;2712.905048323309;2750.119961612285;2786.9303267418272;2787.1220565521794;2800.7619352355073;2658.587918872568;2704.094128466966;2716.171567671859;2740.862956852169;2746.917592472219;2601.661783968072;2656.030548849675;2673.2782148819906;2695.0836715516816;2696.3124403277234;13975.161490310615;14113.223772692498;14121;14130;14146.080504767157;7513.398928085795;7677.616119194018;7945.761627151194;8015.158408367096;8021.879671804928;5210.635255532076;5306.628536002481;5425.616467800685;5427.782888684448;5435.565154787608;1794.0939825388225;1797.8202179782047;1835.5502901789014;1881.6613009658256;1889.6598612249788;23076.076956921705;23413.648795268084;23492.530149397087;23509.529809403888;23517.882410587838;6510.3489651034515;6554.410103090745;6576.736930522821;6761.594304341756;6794.694238759268;15870.889037767245;15915.363385464452;15928.362865485482;15933;16065;7480.139783924809;7677.193894641094;7707.499012564165;7711.652975616111;7714.845703085907;5981.730822113015;6977.511574189758;7044.894326585106;7102.644867756591;7205.639718014078;4800.1119792838435;5144.15121504955;5181.041507321158;5262.657927234717;5299.920501192485;1519.8632123108973;1520.6730552931174;1545.20421982679;1552.1463195242573;1553.6504286535665;882.8543290357147;893.5800173918248;904.6471875968246;906.6826610686207;908.0646933658343;7649.885251721229;7915.604219788987;7988.241117093867;7990;8145.959270203611;957.6696039866235;983.5721461164273;986.8273052215834;990.0841721407669;1021.4841505039907;4733.816545863534;4810.542998415145;4915.16442204826;4928.285398617252;4961.652684312064;19088.71366929497;19223.231070757294;19469.51326216856;19524.316648917506;19613.117409716597;18633.347832825784;18902.43292701221;18956.336528221447;19210.231590736214;19342.32301869456;10580.100691441314;10710.089642380484;10764.892351076389;10781.191410644076;10786.191035672198;7248.238934911758;7525.285097915689;7526.134494533198;7589.468737188344;7623.885641715267;16208.432704855273;16665.3333866644;16836.326546937984;16938.576535586708;17267.91366043162;16869.91565042167;17040.744388834424;17095.57261068483;17457.56356091057;17569.912150439166;10109.949450252701;10464.47677616101;10513.264071514921;10520.842187367043;10538.57845686164;11518.94240528792;11909.76180476403;11944.880551194377;11975.161738678209;13300.866991329964;10620.362778233331;10649.787004259717;10691.732706682395;10919.39943303126;11130.109591232844;9742;10382.117520010883;10547.367157970546;10571.577136914437;10662.520186591777;8662.956685216534;8742.60658270392;8748.60631271607;8789.121087891159;8873.378863479495;6693.765718199839;6824.761133360308;6843.589384636938;6858.588484690935;6882.208546017272;6761.121054262914;6797.422219111431;6865.450763938973;6881.862362752617;6935.375816176568 03:53:57 INFO - PID 5677 | |4;prototype.html;498.8128254753686;500;529.7510170219997;530.0221092085102;534.6070638081012;6046.455818976291;6121.816345509631;6151.354107818682;6162.168107305512;6236.189295391604;5898.764049438028;6067.514598832094;6092.969535152329;6095.420935011167;6144.723487443064;4890.168671325865;4902.534259245375;4952.257161425779;4957.702537847723;4976.4774698656665;4937.2840938063955;4954.860382112116;4968.205087186051;4980.850574482772;4990.101781679296;4651.302304654295;4832.87715022076;4907.337509436216;4909.189983652693;4928.605711543068;4873.317735517013;4893.290472881412;4893.388326459192;4906.779194936236;4929.75351232437;4376.365427013097;4387.188370151533;4388.758618275993;4398.538153493901;4412.646988240933;5936.525077993793;6009.75960961561;6015.75936962521;6033.5474839387225;6035.939640603626;5607.691576963265;5626.1842032905;5635.09838425854;5658.519025882805;5668.631538949955;6475.449586785129;6519.576227545194;6527.15147030883;6549.181352330958;6571.211454625428;4826.951730482685;4832.275158726184;4845.685030473008;4879.8780030499165;4889.584385327216;6786.405194779223;6840.452763778886;6924.684309981088;6924.7576334828545;6951.409130223937;4917.901641967141;4996.225585034325;5000.199968005175;5004;5063.088644044034;4977.705796492938;5026.472220416877;5060.873478163002;5076.568491678175;5092.9745351273;5641.605087643908;5661.490465858093;5690.231818704422;5690.630109042899;5723.5707321950185;6468.191476065492;6606.8348291293105;6623.834404139839;6660.666966651648;6676.332366763285;1663.052060325627;1695.5676302542772;1727.153694689593;1730.7749992501147;1743.6425532765752;1152.8386025956372;1154.722866512031;1217.993910030444;1225.8170865115208;1239.4112796421807;5675.404082571353;5680.460356266148;5747.6838773867;5767.336756273083;5796.565257605696;6721.428678562279;6724.361185687352;6728.798136055926;6767.492438067165;6772.390484856386;5760.625559338713;5788.797392091256;5797;5802.738876750556;5802.752408232251;3556.5376501055216;3580.462930560385;3584.229390681016;3603.8558457661925;3611.4582812578324;6328.810135695937;6383.616982981036;6460.903086453707;6502.187226596676;6559.540172435337;6746.527743058037;6764.255931847493;6826.4538836892925;6833.658317084225;6841.93158068413;6369.936300637027;6446;6475.1582294303325;6516.315786842408;6523.8695226095215;6498.057781621733;6537.607743535403;6553.803385898431;6579.671016449254;6610.182199895067;6530.902036469552;6540.444062254762;6551.6069035858;6642.800715978528;6677.699503522256;6410.230772307353;6432.903506447501;6471.288158302677;6474.798568486549;6498.252700939263;5001.174806157089;5016.147254966591;5016.398032236155;5027.824026159214;5044.772985215747;6606.306337834458;6616.636085015371;6707.262201157966;6732.629705366252;6749.966250168718;6385.8722825544155;6406.551541392244;6428.935710643021;6430.935690643221;6499.5125365598715;6481.0880790166075;6497.252815926229;6533.934660653523;6558.508111891722;6569.043930231511;5834.94165058344;6211.09939058843;6350;6375.003748238506;6418.229812422539;6453.741850325934;6456.612603243821;6512.185976752906;6563.9343606563325;6564.606123632598;6095.451409373178;6288.899442597619;6307.716152773228;6379.904301435575;6396.648184349905 03:53:57 INFO - PID 5677 | |5;yui.html;869.2394155114279;895.8477058899987;906.1210625693076;910.4764760262847;917.3945196170527;18390.54023649408;19194.616107677855;19313.61372772544;19316.130774115147;19346.709799353022;19901.50246243841;21665.133394664193;21681.132754689792;21731;21813.67279490805;1009.2279406254221;1039.049269918024;1039.8856125826153;1040.1522758951469;1041.536516250269;970.1365784451843;1057.6668349469892;1064.377339256532;1065.211743309953;1065.525841000755;1111.288775183883;1117.8435019097333;1118.3848883114294;1118.485496671528;1118.5302173087323;1110.8056090184225;1111.660943412259;1112.3548341961684;1112.8664560252741;1113.8551988241559;810.8905297784783;817.2767101115496;817.6851912013917;818.5743413425046;818.7789296889866;17922.641547169114;17999;18104.456866294033;18608.348707795296;20331.390058298275;20631.896840515703;21087.894560527253;21136.682949755766;21229.893850530803;21248.15007399702;16003.839961600352;16424.589385265463;16487.752683709754;16568.92302000366;16709.081000544964;3517.982410087933;3547.592026916912;3557.2707594942976;3559.341521818446;3560.092176495003;119810;122438;123188;124340;127110;15304.693906121815;15655.921720391325;15832;15856.286467109008;15878.92060539713;30348.54477182844;30507.69492305093;31279;31347.843260784008;31354.43227838599;8075.515469071875;8103.473274237156;8144.470609410369;8165.591720413956;8202.056763472157;3587.587427445825;3674.540682414698;3694.3534881396185;3703.2963736890442;3709.7403181777017;4649.883752906205;5270.841874743764;5644.717764111778;5876.08920617305;5878.853028674317;1052.1582733812918;1074.2802322443981;1076.3219171921796;1097.1442275025493;1100.3672888089382;651.6774196772628;673.9797806065826;681.4786688183543;685.5954986557855;694.2155364438153;11464.312141271384;12074.637760867188;12192.719764424784;12317.322547259986;13450.86549134496;691.0636088100551;713.1798431803364;717.6591119218434;717.9928200717926;729.6023667101442;5358.973205134027;5428.7950467853425;5575.637583557056;5705.62913410627;5749.051406517961;98714.50642746883;103340;104367;105108;105881.47059264654;84259.5787021061;88611.55694221616;89829;89923;92911;78401;78990.81513777298;79387.60306198547;79855;81884.59057704674;10839.512221950188;11034.724131896766;11108.111351092055;11285.43572821372;11303.604373847205;34416.31167376688;35120.64879351174;35434.645653543135;35501.82249088738;36856.26287474289;45728.54271457243;45841.54158458373;45906.31140532828;46394.30408543942;47466.28800567925;15291.082535047934;15634.609134771721;15683.1374274416;15754.921225394259;15784.92107539455;16436.424725134562;16447.342106315613;16476.588085297964;16557.91721041387;16614.50156495259;15485.148316842682;17316.740248896527;18794.624107518048;19078.236870525023;19439.70840437423;18930.242790288234;19238.8076119237;19285.61428771389;19356.516087097934;19499.220031198594;19098;19161.90419047896;19276.710849336992;19493.70759438638;19611.509712257306;14137.505187318395;14319.427222910967;14433.134011959317;14478.203698796668;14635.195064271567;15050.924745376204;15068.773968390702;15103.39586416531;15148.242587870784;15201.467948621745 03:53:57 INFO - PID 5677 | __end_tp_report 03:53:57 INFO - PID 5677 | __start_cc_report 03:53:57 INFO - PID 5677 | _x_x_mozilla_cycle_collect,379 03:53:57 INFO - PID 5677 | __end_cc_report 03:53:57 INFO - PID 5677 | __startTimestamp1501757637419__endTimestamp 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | ------- Summary: start ------- 03:53:57 INFO - PID 5677 | Number of tests: 6 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | [#0] dojo.html Cycles:165 Average:6149.31 Median:6399.84 stddev:726.85 (11.4%) stddev-sans-first:689.57 03:53:57 INFO - PID 5677 | Values: 3136.2 3165.1 3187.4 3188.5 3246.9 6072.0 6122.7 6140.2 6153.2 6371.1 6221.4 6274.8 6297.2 6316.4 6332.9 5688.3 5749.3 5791.5 5806.6 5855.0 5532.9 5620.0 5625.7 5664.5 5773.1 5681.3 5693.2 5750.9 5763.4 5781.2 5677.1 5695.1 5750.8 5765.6 5775.0 5497.9 5633.4 5699.0 5702.7 5724.6 6040.1 6059.9 6060.8 6061.5 6087.8 6622.4 6633.5 6728.7 6730.5 6731.4 6689.5 6727.7 6756.7 6782.2 6803.3 6211.7 6230.3 6307.4 6315.1 6340.6 6731.5 6880.9 6907.2 6972.7 7002.5 6538.8 6541.7 6555.1 6556.4 6579.3 6580.3 6630.4 6726.2 6740.0 6747.5 6678.8 6684.4 6691.7 6781.9 6788.0 6644.5 6710.4 6732.3 6734.5 6749.6 5317.9 5381.7 5439.3 5447.2 5470.7 4542.0 4593.4 4621.2 4631.3 4648.7 5715.3 5722.9 5724.8 5740.1 5778.5 5776.3 6589.1 6616.8 6654.6 6667.3 5769.1 5825.8 5845.2 5849.3 5915.0 5907.1 5932.0 5975.8 5980.6 5982.3 6407.3 6470.6 6470.8 6470.8 6479.2 6630.0 6657.4 6659.8 6680.6 6768.8 6488.4 6492.9 6533.6 6536.3 6552.5 6589.2 6680.4 6689.4 6701.6 6707.4 6693.7 6707.2 6719.3 6808.6 6821.9 6347.2 6448.1 6509.7 6563.7 6579.0 6484.6 6509.9 6521.2 6522.4 6522.6 6399.8 6408.2 6482.8 6483.6 6492.1 6429.1 6499.4 6557.1 6584.3 6588.2 6182.1 6313.7 6326.1 6330.7 6339.2 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | [#1] ext.html Cycles:180 Average:38572.67 Median:35058.06 stddev:55107.54 (157.2%) stddev-sans-first:55189.25 03:53:57 INFO - PID 5677 | Values: 827.7 883.2 914.1 1163.6 1186.7 30716.2 31335.7 31415.0 41297.0 41920.4 43417.0 43466.6 43551.6 43999.3 44010.7 7594.8 7748.5 7757.7 7770.1 7777.6 6990.4 7257.1 7709.6 7714.1 7719.2 7669.2 7688.2 7731.1 7745.5 7760.8 7616.5 7670.3 7677.2 7694.3 7700.7 7577.2 7580.7 7589.9 7632.4 7646.5 38302.6 38636.0 38688.8 38689.6 38701.8 3495.6 3547.7 3565.3 3576.0 3579.7 30187.5 30385.0 30432.5 30494.7 30549.4 4671.2 4816.1 4825.3 4839.5 4948.3 192616.0 193474.0 193883.0 194887.0 195340.0 46116.3 46321.0 46321.0 46347.3 46379.8 48615.5 48707.8 48986.5 49072.5 49093.5 15978.6 16204.5 16254.2 16268.0 16285.2 11640.2 13273.9 13296.0 13299.5 13326.9 12671.9 13326.2 14063.4 14135.7 14150.5 5425.4 5565.7 5569.3 5688.2 5744.5 995.2 1012.8 1022.7 1023.2 1024.1 22314.2 22419.8 22767.2 22958.6 23410.5 1107.2 1112.8 1114.1 1120.1 1144.7 12136.9 16450.9 16469.3 16618.4 16738.0 238352.0 240430.0 240906.0 240998.0 241830.0 55473.7 55533.7 55630.0 55829.7 55963.0 1465.3 1479.2 1490.7 1503.7 1517.5 27859.4 27926.6 28788.6 28821.7 28864.0 52199.2 52305.2 52666.5 52859.7 52937.0 196421.0 201154.0 201232.0 201430.0 201603.0 35045.6 35070.5 35375.1 36266.8 37180.8 39278.4 40025.8 40306.8 40339.2 40377.8 32230.0 32928.0 33218.8 33443.3 34462.5 30668.4 30923.8 31349.7 31522.5 31562.0 36539.5 37086.6 37306.3 37543.6 37560.4 32470.8 32864.7 33008.0 33233.8 33742.7 23996.8 25005.2 25264.6 25411.6 25653.5 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | [#2] jquery.html Cycles:180 Average:37145.15 Median:22395.33 stddev:88721.93 (396.2%) stddev-sans-first:88928.30 03:53:57 INFO - PID 5677 | Values: 564.6 574.4 574.9 594.2 600.7 22200.0 22590.7 22954.1 23039.8 23067.7 27196.0 27980.9 28070.4 28096.3 28177.0 6872.6 7033.7 7086.5 7086.9 7091.0 4128.1 4130.3 5748.5 7015.1 7101.4 6894.0 6900.9 6925.2 6926.4 6932.3 6862.8 6891.8 6901.9 6902.5 6906.2 6764.9 6787.8 6802.8 6806.0 6812.5 30894.5 31700.0 32334.2 33270.8 33352.3 1904.3 1933.0 1934.1 1936.0 1938.0 19392.3 19655.2 20698.3 20764.8 20788.2 2309.7 2348.1 2360.0 2373.2 2381.7 135198.3 138621.0 140239.3 147885.3 151553.2 21416.9 21638.4 22836.7 23350.3 23448.2 43059.6 43146.4 43288.8 43342.8 43466.3 11620.8 11953.9 12098.1 12129.3 12192.3 8445.4 8964.2 10158.3 10193.7 10229.8 10816.9 11452.9 11765.8 11772.3 12029.8 4281.9 4349.7 4390.7 4572.5 4607.7 940.1 948.4 960.3 984.0 988.1 20427.8 20490.0 20519.3 20594.9 20966.7 1047.0 1055.1 1057.2 1065.0 1069.6 11074.0 11435.9 11477.2 11535.6 11628.9 513961.0 524820.0 532738.0 541751.0 544835.0 103429.0 105468.0 107655.5 108097.5 108766.5 1193.7 1208.1 1229.5 1229.6 1233.0 17909.2 17946.4 18105.5 18113.9 18323.1 53474.5 54510.0 54580.5 55629.4 55697.0 67535.7 67661.0 68137.0 68252.0 69068.0 20646.3 20681.5 20717.9 20937.3 21038.0 23273.8 23305.7 23953.9 24079.3 24272.3 18466.3 18529.4 18772.2 19001.1 19245.7 17003.7 17271.7 17425.4 17507.2 17895.4 19533.4 19790.7 19919.6 19933.6 20037.0 14874.3 15206.0 15266.2 15383.6 15435.3 18988.5 19170.3 19309.8 19521.2 19531.4 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | [#3] mootools.html Cycles:180 Average:8625.19 Median:2684.18 stddev:5896.61 (219.7%) stddev-sans-first:5887.79 03:53:57 INFO - PID 5677 | Values: 1346.6 1372.4 1393.9 1394.5 1412.2 13342.7 13964.5 13980.6 14010.6 14028.4 13470.1 13953.7 13953.8 14001.3 14019.2 2652.3 2720.9 2721.2 2723.1 2728.0 2583.6 2758.9 2767.3 2770.8 2771.0 2712.9 2750.1 2786.9 2787.1 2800.8 2658.6 2704.1 2716.2 2740.9 2746.9 2601.7 2656.0 2673.3 2695.1 2696.3 13975.2 14113.2 14121.0 14130.0 14146.1 7513.4 7677.6 7945.8 8015.2 8021.9 5210.6 5306.6 5425.6 5427.8 5435.6 1794.1 1797.8 1835.6 1881.7 1889.7 23076.1 23413.6 23492.5 23509.5 23517.9 6510.3 6554.4 6576.7 6761.6 6794.7 15870.9 15915.4 15928.4 15933.0 16065.0 7480.1 7677.2 7707.5 7711.7 7714.8 5981.7 6977.5 7044.9 7102.6 7205.6 4800.1 5144.2 5181.0 5262.7 5299.9 1519.9 1520.7 1545.2 1552.1 1553.7 882.9 893.6 904.6 906.7 908.1 7649.9 7915.6 7988.2 7990.0 8146.0 957.7 983.6 986.8 990.1 1021.5 4733.8 4810.5 4915.2 4928.3 4961.7 19088.7 19223.2 19469.5 19524.3 19613.1 18633.3 18902.4 18956.3 19210.2 19342.3 10580.1 10710.1 10764.9 10781.2 10786.2 7248.2 7525.3 7526.1 7589.5 7623.9 16208.4 16665.3 16836.3 16938.6 17267.9 16869.9 17040.7 17095.6 17457.6 17569.9 10109.9 10464.5 10513.3 10520.8 10538.6 11518.9 11909.8 11944.9 11975.2 13300.9 10620.4 10649.8 10691.7 10919.4 11130.1 9742.0 10382.1 10547.4 10571.6 10662.5 8663.0 8742.6 8748.6 8789.1 8873.4 6693.8 6824.8 6843.6 6858.6 6882.2 6761.1 6797.4 6865.5 6881.9 6935.4 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | [#4] prototype.html Cycles:180 Average:5466.51 Median:6034.74 stddev:1534.72 (25.4%) stddev-sans-first:1493.04 03:53:57 INFO - PID 5677 | Values: 498.8 500.0 529.8 530.0 534.6 6046.5 6121.8 6151.4 6162.2 6236.2 5898.8 6067.5 6093.0 6095.4 6144.7 4890.2 4902.5 4952.3 4957.7 4976.5 4937.3 4954.9 4968.2 4980.9 4990.1 4651.3 4832.9 4907.3 4909.2 4928.6 4873.3 4893.3 4893.4 4906.8 4929.8 4376.4 4387.2 4388.8 4398.5 4412.6 5936.5 6009.8 6015.8 6033.5 6035.9 5607.7 5626.2 5635.1 5658.5 5668.6 6475.4 6519.6 6527.2 6549.2 6571.2 4827.0 4832.3 4845.7 4879.9 4889.6 6786.4 6840.5 6924.7 6924.8 6951.4 4917.9 4996.2 5000.2 5004.0 5063.1 4977.7 5026.5 5060.9 5076.6 5093.0 5641.6 5661.5 5690.2 5690.6 5723.6 6468.2 6606.8 6623.8 6660.7 6676.3 1663.1 1695.6 1727.2 1730.8 1743.6 1152.8 1154.7 1218.0 1225.8 1239.4 5675.4 5680.5 5747.7 5767.3 5796.6 6721.4 6724.4 6728.8 6767.5 6772.4 5760.6 5788.8 5797.0 5802.7 5802.8 3556.5 3580.5 3584.2 3603.9 3611.5 6328.8 6383.6 6460.9 6502.2 6559.5 6746.5 6764.3 6826.5 6833.7 6841.9 6369.9 6446.0 6475.2 6516.3 6523.9 6498.1 6537.6 6553.8 6579.7 6610.2 6530.9 6540.4 6551.6 6642.8 6677.7 6410.2 6432.9 6471.3 6474.8 6498.3 5001.2 5016.1 5016.4 5027.8 5044.8 6606.3 6616.6 6707.3 6732.6 6750.0 6385.9 6406.6 6428.9 6430.9 6499.5 6481.1 6497.3 6533.9 6558.5 6569.0 5834.9 6211.1 6350.0 6375.0 6418.2 6453.7 6456.6 6512.2 6563.9 6564.6 6095.5 6288.9 6307.7 6379.9 6396.6 03:53:57 INFO - PID 5677 | 03:53:57 INFO - PID 5677 | [#5] yui.html Cycles:180 Average:22144.70 Median:19331.42 stddev:29681.78 (153.5%) stddev-sans-first:29722.05 03:53:57 INFO - PID 5677 | Values: 869.2 895.8 906.1 910.5 917.4 18390.5 19194.6 19313.6 19316.1 19346.7 19901.5 21665.1 21681.1 21731.0 21813.7 1009.2 1039.0 1039.9 1040.2 1041.5 970.1 1057.7 1064.4 1065.2 1065.5 1111.3 1117.8 1118.4 1118.5 1118.5 1110.8 1111.7 1112.4 1112.9 1113.9 810.9 817.3 817.7 818.6 818.8 17922.6 17999.0 18104.5 18608.3 20331.4 20631.9 21087.9 21136.7 21229.9 21248.2 16003.8 16424.6 16487.8 16568.9 16709.1 3518.0 3547.6 3557.3 3559.3 3560.1 119810.0 122438.0 123188.0 124340.0 127110.0 15304.7 15655.9 15832.0 15856.3 15878.9 30348.5 30507.7 31279.0 31347.8 31354.4 8075.5 8103.5 8144.5 8165.6 8202.1 3587.6 3674.5 3694.4 3703.3 3709.7 4649.9 5270.8 5644.7 5876.1 5878.9 1052.2 1074.3 1076.3 1097.1 1100.4 651.7 674.0 681.5 685.6 694.2 11464.3 12074.6 12192.7 12317.3 13450.9 691.1 713.2 717.7 718.0 729.6 5359.0 5428.8 5575.6 5705.6 5749.1 98714.5 103340.0 104367.0 105108.0 105881.5 84259.6 88611.6 89829.0 89923.0 92911.0 78401.0 78990.8 79387.6 79855.0 81884.6 10839.5 11034.7 11108.1 11285.4 11303.6 34416.3 35120.6 35434.6 35501.8 36856.3 45728.5 45841.5 45906.3 46394.3 47466.3 15291.1 15634.6 15683.1 15754.9 15784.9 16436.4 16447.3 16476.6 16557.9 16614.5 15485.1 17316.7 18794.6 19078.2 19439.7 18930.2 19238.8 19285.6 19356.5 19499.2 19098.0 19161.9 19276.7 19493.7 19611.5 14137.5 14319.4 14433.1 14478.2 14635.2 15050.9 15068.8 15103.4 15148.2 15201.5 03:53:57 INFO - PID 5677 | -------- Summary: end -------- 03:53:57 INFO - PID 5677 | 03:53:58 INFO - TEST-INFO | 5677: exit 0 03:53:58 INFO - TEST-OK | dromaeo_css | took 1113213ms 03:53:58 INFO - TEST-START | kraken 03:53:58 INFO - Initialising browser for kraken test... 03:53:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53285/getInfo.html -profile /tmp/tmpBiDjLX/profile 03:53:58 INFO - TEST-INFO | started process 6053 (/builds/slave/test/build/application/firefox/firefox http://localhost:53285/getInfo.html) 03:54:04 INFO - TEST-INFO | 6053: exit 0 03:54:04 INFO - Browser initialized. 03:54:04 INFO - Running cycle 1/1 for kraken test... 03:54:04 INFO - TEST-INFO | started process 6276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBiDjLX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:05 INFO - PID 6276 | 03:54:05 INFO - PID 6276 | (/builds/slave/test/build/application/firefox/firefox:6330): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:05 INFO - PID 6276 | 03:54:15 INFO - PID 6276 | RSS: Main: 174473216 03:54:15 INFO - PID 6276 | 03:54:18 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:19 INFO - PID 6276 | RSS: Main: 179544064 03:54:19 INFO - PID 6276 | 03:54:22 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-dft) 03:54:22 INFO - PID 6276 | RSS: Main: 179818496 03:54:22 INFO - PID 6276 | 03:54:25 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-fft) 03:54:26 INFO - PID 6276 | RSS: Main: 174436352 03:54:26 INFO - PID 6276 | 03:54:28 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53285/tests/kraken/driver.html?testName=audio-oscillator) 03:54:29 INFO - PID 6276 | RSS: Main: 175353856 03:54:29 INFO - PID 6276 | 03:54:31 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:32 INFO - PID 6276 | RSS: Main: 175869952 03:54:32 INFO - PID 6276 | 03:54:35 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53285/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:36 INFO - PID 6276 | RSS: Main: 178470912 03:54:36 INFO - PID 6276 | 03:54:39 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53285/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:40 INFO - PID 6276 | RSS: Main: 177205248 03:54:40 INFO - PID 6276 | 03:54:43 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53285/tests/kraken/driver.html?testName=json-parse-financial) 03:54:43 INFO - PID 6276 | RSS: Main: 178372608 03:54:43 INFO - PID 6276 | 03:54:45 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:46 INFO - PID 6276 | RSS: Main: 178147328 03:54:46 INFO - PID 6276 | 03:54:48 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:48 INFO - PID 6276 | RSS: Main: 175042560 03:54:48 INFO - PID 6276 | 03:54:50 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:51 INFO - PID 6276 | RSS: Main: 175366144 03:54:51 INFO - PID 6276 | 03:54:54 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:55 INFO - PID 6276 | RSS: Main: 175509504 03:54:55 INFO - PID 6276 | 03:54:58 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:58 INFO - PID 6276 | RSS: Main: 175685632 03:54:58 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | Cycle 1(1): loaded http://localhost:53285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53285/tests/kraken/driver.html?testName=ai-astar) 03:55:00 INFO - PID 6276 | RSS: Main: 177070080 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | __start_tp_report 03:55:00 INFO - PID 6276 | _x_x_mozilla_page_load 03:55:00 INFO - PID 6276 | _x_x_mozilla_page_load_details 03:55:00 INFO - PID 6276 | |i|pagename|runs| 03:55:00 INFO - PID 6276 | |0;ai-astar;98;118;103;107;110;110;109;101;111;109 03:55:00 INFO - PID 6276 | |1;audio-beat-detection;152;120;144;182;124;145;150;119;168;124 03:55:00 INFO - PID 6276 | |2;audio-dft;163;164;163;164;163;166;173;167;162;173 03:55:00 INFO - PID 6276 | |3;audio-fft;76;75;76;179;75;74;77;76;170;78 03:55:00 INFO - PID 6276 | |4;audio-oscillator;80;79;137;78;79;79;136;78;81;130 03:55:00 INFO - PID 6276 | |5;imaging-gaussian-blur;114;114;118;115;114;114;119;113;118;114 03:55:00 INFO - PID 6276 | |6;imaging-darkroom;151;156;157;157;150;151;152;158;151;152 03:55:00 INFO - PID 6276 | |7;imaging-desaturate;94;99;94;95;97;95;98;94;95;94 03:55:00 INFO - PID 6276 | |8;json-parse-financial;57;59;55;55;57;54;55;54;55;55 03:55:00 INFO - PID 6276 | |9;json-stringify-tinderbox;54;53;56;54;54;58;57;63;53;53 03:55:00 INFO - PID 6276 | |10;stanford-crypto-aes;79;80;78;88;79;79;85;77;78;76 03:55:00 INFO - PID 6276 | |11;stanford-crypto-ccm;132;133;129;133;127;153;132;124;127;169 03:55:00 INFO - PID 6276 | |12;stanford-crypto-pbkdf2;187;185;180;183;187;183;183;180;175;177 03:55:00 INFO - PID 6276 | |13;stanford-crypto-sha256-iterative;71;68;68;70;67;67;71;73;70;70 03:55:00 INFO - PID 6276 | __end_tp_report 03:55:00 INFO - PID 6276 | __start_cc_report 03:55:00 INFO - PID 6276 | _x_x_mozilla_cycle_collect,957 03:55:00 INFO - PID 6276 | __end_cc_report 03:55:00 INFO - PID 6276 | __startTimestamp1501757700925__endTimestamp 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | ------- Summary: start ------- 03:55:00 INFO - PID 6276 | Number of tests: 14 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#0] ai-astar Cycles:10 Average:107.60 Median:110.00 stddev:5.70 (5.2%) stddev-sans-first:4.87 03:55:00 INFO - PID 6276 | Values: 98.0 118.0 103.0 107.0 110.0 110.0 109.0 101.0 111.0 109.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:147.50 stddev:21.36 (14.5%) stddev-sans-first:22.40 03:55:00 INFO - PID 6276 | Values: 152.0 120.0 144.0 182.0 124.0 145.0 150.0 119.0 168.0 124.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:4.08 (2.5%) stddev-sans-first:4.20 03:55:00 INFO - PID 6276 | Values: 163.0 164.0 163.0 164.0 163.0 166.0 173.0 167.0 162.0 173.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.65 (54.8%) stddev-sans-first:43.57 03:55:00 INFO - PID 6276 | Values: 76.0 75.0 76.0 179.0 75.0 74.0 77.0 76.0 170.0 78.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:79.00 stddev:26.73 (33.8%) stddev-sans-first:27.74 03:55:00 INFO - PID 6276 | Values: 80.0 79.0 137.0 78.0 79.0 79.0 136.0 78.0 81.0 130.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:114.50 stddev:2.16 (1.9%) stddev-sans-first:2.24 03:55:00 INFO - PID 6276 | Values: 114.0 114.0 118.0 115.0 114.0 114.0 119.0 113.0 118.0 114.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#6] imaging-darkroom Cycles:10 Average:153.50 Median:154.00 stddev:3.10 (2.0%) stddev-sans-first:3.15 03:55:00 INFO - PID 6276 | Values: 151.0 156.0 157.0 157.0 150.0 151.0 152.0 158.0 151.0 152.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.84 (1.9%) stddev-sans-first:1.87 03:55:00 INFO - PID 6276 | Values: 94.0 99.0 94.0 95.0 97.0 95.0 98.0 94.0 95.0 94.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:1.58 (2.9%) stddev-sans-first:1.59 03:55:00 INFO - PID 6276 | Values: 57.0 59.0 55.0 55.0 57.0 54.0 55.0 54.0 55.0 55.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:3.17 (5.8%) stddev-sans-first:3.32 03:55:00 INFO - PID 6276 | Values: 54.0 53.0 56.0 54.0 54.0 58.0 57.0 63.0 53.0 53.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:3.73 (4.7%) stddev-sans-first:3.94 03:55:00 INFO - PID 6276 | Values: 79.0 80.0 78.0 88.0 79.0 79.0 85.0 77.0 78.0 76.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:132.50 stddev:14.07 (10.6%) stddev-sans-first:14.86 03:55:00 INFO - PID 6276 | Values: 132.0 133.0 129.0 133.0 127.0 153.0 132.0 124.0 127.0 169.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:183.00 stddev:4.00 (2.2%) stddev-sans-first:3.81 03:55:00 INFO - PID 6276 | Values: 187.0 185.0 180.0 183.0 187.0 183.0 183.0 180.0 175.0 177.0 03:55:00 INFO - PID 6276 | 03:55:00 INFO - PID 6276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.96 (2.8%) stddev-sans-first:2.00 03:55:00 INFO - PID 6276 | Values: 71.0 68.0 68.0 70.0 67.0 67.0 71.0 73.0 70.0 70.0 03:55:00 INFO - PID 6276 | -------- Summary: end -------- 03:55:00 INFO - PID 6276 | 03:55:01 INFO - PID 6276 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:55:01 INFO - TEST-INFO | 6276: exit 0 03:55:01 INFO - TEST-OK | kraken | took 63535ms 03:55:01 INFO - SUITE-END | took 1176s 03:55:02 INFO - Completed test suite (00:19:37) 03:55:02 INFO - javascript benchmark 03:55:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8564.167104291839, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.1532386255712, 3165.050484854543, 3187.3784612000663, 3188.5057816038507, 3246.8863589774346, 6072.02847544393, 6122.693865306739, 6140.20177376941, 6153.230846144232, 6371.108044873721, 6221.377862213776, 6274.811755647338, 6297.18136642237, 6316.399942005513, 6332.873342533147, 5688.317401911776, 5749.252597162363, 5791.478766910977, 5806.59353845231, 5854.975379308604, 5532.944670553304, 5620.016497113009, 5625.662460252377, 5664.490195882369, 5773.1051686988585, 5681.346645135821, 5693.174489698991, 5750.942490575104, 5763.366029736726, 5781.248437703114, 5677.063284558043, 5695.14572814077, 5750.769969201227, 5765.567582431335, 5775.047117225653, 5497.917531237034, 5633.408492108351, 5699.031164702011, 5702.714864256771, 5724.599278050497, 6040.0939859021055, 6059.909101363483, 6060.848478788022, 6061.54538409621, 6087.756489740405, 6622.37087476689, 6633.535652504326, 6728.730850765964, 6730.528862979593, 6731.427828634572, 6689.531732778707, 6727.66361681914, 6756.729730810811, 6782.220044694874, 6803.319668033207, 6211.65835879022, 6230.314665386803, 6307.369263073656, 6315.147455093549, 6340.556161068681, 6731.461483081342, 6880.862382752317, 6907.171139463297, 6972.686229119702, 7002.474814388839, 6538.836529086716, 6541.738330466823, 6555.147830781968, 6556.409923106943, 6579.342065793382, 6580.309067547934, 6630.403263706193, 6726.226483954408, 6740.0, 6747.527673062838, 6678.799636010927, 6684.364985326386, 6691.665416729144, 6781.898271525931, 6787.966060169766, 6644.534882558174, 6710.429613482908, 6732.3267673232285, 6734.528582999143, 6749.5612785168805, 5317.867053323621, 5381.67709937405, 5439.292891924025, 5447.1829225616475, 5470.7264636768, 4542.0, 4593.356930029799, 4621.23749581322, 4631.258998560214, 4648.697834640738, 5715.31416230055, 5722.914156287659, 5724.79963201286, 5740.052891272977, 5778.537716982715, 5776.335721392094, 6589.110470086573, 6616.8345791355605, 6654.567453115532, 6667.33326667339, 5769.134629805562, 5825.79609713658, 5845.210896528999, 5849.268841394825, 5914.9704251479325, 5907.084401917709, 5931.991561434566, 5975.7609695612555, 5980.581359304894, 5982.341942386334, 6407.327230640809, 6470.579412338183, 6470.838229044218, 6470.838229044218, 6479.1901012373455, 6630.0, 6657.434118100015, 6659.833504162435, 6680.63256520896, 6768.763093291908, 6488.383603557843, 6492.870142597028, 6533.640649764118, 6536.346365363425, 6552.475801935929, 6589.209294884645, 6680.3987641112535, 6689.431398331002, 6701.597904125768, 6707.42986846104, 6693.665316734046, 6707.228668702966, 6719.294474080151, 6808.62552559614, 6821.8635627286185, 6347.174867267226, 6448.1295025171, 6509.707063182263, 6563.704633291418, 6579.0, 6484.643344616092, 6509.934900650933, 6521.217453905561, 6522.380373864476, 6522.608643481406, 6399.840003999937, 6408.198975128109, 6482.837929051623, 6483.578567393104, 6492.058651495601, 6429.099926010455, 6499.415052645285, 6557.147570815763, 6584.308647591934, 6588.176477940257, 6182.103594978613, 6313.684315784284, 6326.082718005771, 6330.651814150266, 6339.207599050119], "value": 6095.319834941379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.710301394512, 883.2360008592567, 914.1452741686521, 1163.5520324674997, 1186.6973921649978, 30716.232094197658, 31335.68664313359, 31415.0, 41297.0, 41920.37119443211, 43417.0, 43466.56533434665, 43551.56448435515, 43999.340009899795, 44010.67967960958, 7594.810129746759, 7748.496347737408, 7757.728479503218, 7770.145284018753, 7777.572233527154, 6990.405815505688, 7257.092863392076, 7709.575973321465, 7714.074311082678, 7719.189485104067, 7669.156392796788, 7688.15430302669, 7731.072271327449, 7745.535267883945, 7760.805979850521, 7616.543007419545, 7670.30967212948, 7677.155512893577, 7694.345980591601, 7700.730474433424, 7577.2422757724335, 7580.734674286374, 7589.8861517077285, 7632.427567932427, 7646.464747467679, 38302.61697383046, 38636.0, 38688.80655596704, 38689.61310386917, 38701.80649096736, 3495.615482296945, 3547.6629720176543, 3565.322588708163, 3575.982120089383, 3579.6957258633047, 30187.547186792217, 30385.0, 30432.54351184734, 30494.695053049407, 30549.389012219854, 4671.205894997858, 4816.109019831342, 4825.276208568707, 4839.540243676845, 4948.331975183341, 192616.0, 193474.0, 193883.0, 194887.0, 195340.0, 46116.3082553762, 46321.0, 46321.0, 46347.30479042817, 46379.76810115928, 48615.513844861096, 48707.756461218174, 48986.510134898905, 49072.50927490679, 49093.50906490961, 15978.60053498672, 16204.513864584082, 16254.18729063542, 16268.0, 16285.185740712917, 11640.243384180001, 13273.867261327456, 13296.0, 13299.534516291884, 13326.866731332757, 12671.936640316739, 13326.20042797416, 14063.367148478343, 14135.71728565423, 14150.504732334319, 5425.403205647375, 5565.749541270652, 5569.303837020372, 5688.175214593944, 5744.454276843693, 995.1640621877658, 1012.8227560177087, 1022.6676330192718, 1023.2325755683238, 1024.078329503438, 22314.21900233484, 22419.775802242097, 22767.203147889744, 22958.551500859467, 23410.53178936412, 1107.1751545098953, 1112.7996960547018, 1114.0808832713044, 1120.1486869978712, 1144.6508814811395, 12136.939315303543, 16450.917745411196, 16469.258883350278, 16618.418355357506, 16738.0, 238352.0, 240430.0, 240906.0, 240998.0, 241830.0, 55473.72263138658, 55533.72233138889, 55630.0, 55829.72085139548, 55963.0, 1465.2600436779358, 1479.216015511759, 1490.7018596280786, 1503.7142942840826, 1517.544736579022, 27859.44281114407, 27926.581101283904, 28788.568171477025, 28821.711782881903, 28864.0, 52199.21701174409, 52305.21542176946, 52666.47333526769, 52859.73570132279, 52937.0, 196421.0, 201154.0, 201232.0, 201430.0, 201603.0, 35045.64954350424, 35070.47394289036, 35375.11562210862, 36266.8186659065, 37180.814095929345, 39278.4108238371, 40025.799871001625, 40306.79846600866, 40339.1932161361, 40377.79811100926, 32230.0, 32928.0, 33218.83390583032, 33443.33113337768, 34462.48306275358, 30668.38663226678, 30923.845380772953, 31349.686503134675, 31522.527162092127, 31562.0, 36539.451908220864, 37086.62913370832, 37306.25387492289, 37543.62456375401, 37560.43659345058, 32470.837645811618, 32864.671353287114, 33008.0, 33233.83383083166, 33742.66257337395, 23996.76003240015, 25005.249842504752, 25264.62103068492, 25411.618825717258, 25653.486930261664], "value": 17560.558004120026, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5849457244349, 574.4026212738746, 574.8764015736618, 594.2007999241021, 600.7086563016936, 22200.0, 22590.66114008287, 22954.08183672653, 23039.76960230397, 23067.653985190194, 27196.0, 27980.860095699543, 28070.43859122816, 28096.297592560197, 28177.0, 6872.553284036534, 7033.683484243222, 7086.503944723871, 7086.929130708704, 7091.0, 4128.091819799639, 4130.339145736682, 5748.45389687979, 7015.088038554981, 7101.360877521022, 6894.0, 6900.896486552706, 6925.203601585832, 6926.445884329267, 6932.341427564374, 6862.764702353599, 6891.827704307432, 6901.896471552931, 6902.482313826483, 6906.171259448874, 6764.898526522106, 6787.846066168714, 6802.761903333359, 6805.965970170167, 6812.48906332027, 30894.536581951288, 31700.0, 32334.191645208823, 33270.83364583162, 33352.332953340796, 1904.2954106980367, 1933.0, 1934.0523143659505, 1935.9709604355946, 1938.04066986841, 19392.321268755524, 19655.213791448325, 20698.275560355316, 20764.792352076438, 20788.168473261052, 2309.711286089239, 2348.072511358004, 2359.988200059006, 2373.1931143411152, 2381.6784734060852, 135198.32400837934, 138621.0, 140239.29880350534, 147885.2605736975, 151553.24223378923, 21416.89291553532, 21638.35084947454, 22836.65745013826, 23350.299491015296, 23448.179313723937, 43059.56940430618, 43146.35280470795, 43288.78355608202, 43342.783286084, 43466.34800477995, 11620.825687614693, 11953.880461195451, 12098.092643051807, 12129.332886691316, 12192.329421881705, 8445.408821382567, 8964.193222609996, 10158.288919775692, 10193.694189174337, 10229.795404092025, 10816.891831081746, 11452.94273528627, 11765.823512647317, 11772.293662380285, 12029.759404811855, 4281.871543853689, 4349.650349650349, 4390.736555806662, 4572.497025327211, 4607.746573938465, 940.116290686766, 948.3882895532342, 960.3325688646463, 984.0356450678375, 988.0958922585897, 20427.795722042887, 20490.0, 20519.281825136346, 20594.897025515078, 20966.685499717212, 1046.9685909422728, 1055.1137044882337, 1057.1701214546545, 1065.0042210533177, 1069.5828626835385, 11074.0, 11435.885641143648, 11477.196596238184, 11535.596254131066, 11628.895254950767, 513961.0, 524820.0, 532738.0, 541751.0, 544835.0, 103429.0, 105468.0, 107655.46172269089, 108097.45951270193, 108766.45616771866, 1193.7194759231575, 1208.1482554798845, 1229.5266322465916, 1229.57579635024, 1232.969175770613, 17909.19408626589, 17946.37187698424, 18105.547361316072, 18113.909430452764, 18323.08384580739, 53474.45422789685, 54510.0, 54580.454195459126, 55629.44370556243, 55697.0, 67535.66232168808, 67661.0, 68137.0, 68252.0, 69068.0, 20646.277380291616, 20681.482962926046, 20717.89641051785, 20937.26719564808, 21038.0, 23273.76726232716, 23305.650415243446, 23953.880230598734, 24079.27762167138, 24272.27183184507, 18466.261349546407, 18529.35147269893, 18772.15525301392, 19001.144948477075, 19245.711314330016, 17003.659926801643, 17271.7409238859, 17425.39011134604, 17507.21217545239, 17895.37366192177, 19533.413997580094, 19790.70313945263, 19919.60160796805, 19933.60132797365, 20037.0, 14874.256287185814, 15206.0, 15266.160361180242, 15383.61540961485, 15435.305411256744, 18988.525286867938, 19170.329038484146, 19309.806901930802, 19521.219151233792, 19531.437485000883], "value": 12991.35162629273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.649871033531, 1372.409863758584, 1393.8815200707938, 1394.4561620967825, 1412.1967893730946, 13342.733145337099, 13964.511242106528, 13980.580582582514, 14010.579682609512, 14028.368723407446, 13470.124441911268, 13953.720925581481, 13953.790693139612, 14001.29993500326, 14019.228942408163, 2652.2971412575685, 2720.8503532305717, 2721.18364490653, 2723.128598848369, 2728.031548800177, 2583.586626139818, 2758.8620568971573, 2767.33583939854, 2770.7506324430797, 2770.972290277102, 2712.905048323309, 2750.119961612285, 2786.9303267418272, 2787.1220565521794, 2800.7619352355073, 2658.587918872568, 2704.094128466966, 2716.171567671859, 2740.862956852169, 2746.917592472219, 2601.661783968072, 2656.030548849675, 2673.2782148819906, 2695.0836715516816, 2696.3124403277234, 13975.161490310615, 14113.223772692498, 14121.0, 14130.0, 14146.080504767157, 7513.398928085795, 7677.616119194018, 7945.761627151194, 8015.158408367096, 8021.879671804928, 5210.635255532076, 5306.628536002481, 5425.616467800685, 5427.782888684448, 5435.565154787608, 1794.0939825388225, 1797.8202179782047, 1835.5502901789014, 1881.6613009658256, 1889.6598612249788, 23076.076956921705, 23413.648795268084, 23492.530149397087, 23509.529809403888, 23517.882410587838, 6510.3489651034515, 6554.410103090745, 6576.736930522821, 6761.594304341756, 6794.694238759268, 15870.889037767245, 15915.363385464452, 15928.362865485482, 15933.0, 16065.0, 7480.139783924809, 7677.193894641094, 7707.499012564165, 7711.652975616111, 7714.845703085907, 5981.730822113015, 6977.511574189758, 7044.894326585106, 7102.644867756591, 7205.639718014078, 4800.1119792838435, 5144.15121504955, 5181.041507321158, 5262.657927234717, 5299.920501192485, 1519.8632123108973, 1520.6730552931174, 1545.20421982679, 1552.1463195242573, 1553.6504286535665, 882.8543290357147, 893.5800173918248, 904.6471875968246, 906.6826610686207, 908.0646933658343, 7649.885251721229, 7915.604219788987, 7988.241117093867, 7990.0, 8145.959270203611, 957.6696039866235, 983.5721461164273, 986.8273052215834, 990.0841721407669, 1021.4841505039907, 4733.816545863534, 4810.542998415145, 4915.16442204826, 4928.285398617252, 4961.652684312064, 19088.71366929497, 19223.231070757294, 19469.51326216856, 19524.316648917506, 19613.117409716597, 18633.347832825784, 18902.43292701221, 18956.336528221447, 19210.231590736214, 19342.32301869456, 10580.100691441314, 10710.089642380484, 10764.892351076389, 10781.191410644076, 10786.191035672198, 7248.238934911758, 7525.285097915689, 7526.134494533198, 7589.468737188344, 7623.885641715267, 16208.432704855273, 16665.3333866644, 16836.326546937984, 16938.576535586708, 17267.91366043162, 16869.91565042167, 17040.744388834424, 17095.57261068483, 17457.56356091057, 17569.912150439166, 10109.949450252701, 10464.47677616101, 10513.264071514921, 10520.842187367043, 10538.57845686164, 11518.94240528792, 11909.76180476403, 11944.880551194377, 11975.161738678209, 13300.866991329964, 10620.362778233331, 10649.787004259717, 10691.732706682395, 10919.39943303126, 11130.109591232844, 9742.0, 10382.117520010883, 10547.367157970546, 10571.577136914437, 10662.520186591777, 8662.956685216534, 8742.60658270392, 8748.60631271607, 8789.121087891159, 8873.378863479495, 6693.765718199839, 6824.761133360308, 6843.589384636938, 6858.588484690935, 6882.208546017272, 6761.121054262914, 6797.422219111431, 6865.450763938973, 6881.862362752617, 6935.375816176568], "value": 6341.462308539511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.8128254753686, 500.0, 529.7510170219997, 530.0221092085102, 534.6070638081012, 6046.455818976291, 6121.816345509631, 6151.354107818682, 6162.168107305512, 6236.189295391604, 5898.764049438028, 6067.514598832094, 6092.969535152329, 6095.420935011167, 6144.723487443064, 4890.168671325865, 4902.534259245375, 4952.257161425779, 4957.702537847723, 4976.4774698656665, 4937.2840938063955, 4954.860382112116, 4968.205087186051, 4980.850574482772, 4990.101781679296, 4651.302304654295, 4832.87715022076, 4907.337509436216, 4909.189983652693, 4928.605711543068, 4873.317735517013, 4893.290472881412, 4893.388326459192, 4906.779194936236, 4929.75351232437, 4376.365427013097, 4387.188370151533, 4388.758618275993, 4398.538153493901, 4412.646988240933, 5936.525077993793, 6009.75960961561, 6015.75936962521, 6033.5474839387225, 6035.939640603626, 5607.691576963265, 5626.1842032905, 5635.09838425854, 5658.519025882805, 5668.631538949955, 6475.449586785129, 6519.576227545194, 6527.15147030883, 6549.181352330958, 6571.211454625428, 4826.951730482685, 4832.275158726184, 4845.685030473008, 4879.8780030499165, 4889.584385327216, 6786.405194779223, 6840.452763778886, 6924.684309981088, 6924.7576334828545, 6951.409130223937, 4917.901641967141, 4996.225585034325, 5000.199968005175, 5004.0, 5063.088644044034, 4977.705796492938, 5026.472220416877, 5060.873478163002, 5076.568491678175, 5092.9745351273, 5641.605087643908, 5661.490465858093, 5690.231818704422, 5690.630109042899, 5723.5707321950185, 6468.191476065492, 6606.8348291293105, 6623.834404139839, 6660.666966651648, 6676.332366763285, 1663.052060325627, 1695.5676302542772, 1727.153694689593, 1730.7749992501147, 1743.6425532765752, 1152.8386025956372, 1154.722866512031, 1217.993910030444, 1225.8170865115208, 1239.4112796421807, 5675.404082571353, 5680.460356266148, 5747.6838773867, 5767.336756273083, 5796.565257605696, 6721.428678562279, 6724.361185687352, 6728.798136055926, 6767.492438067165, 6772.390484856386, 5760.625559338713, 5788.797392091256, 5797.0, 5802.738876750556, 5802.752408232251, 3556.5376501055216, 3580.462930560385, 3584.229390681016, 3603.8558457661925, 3611.4582812578324, 6328.810135695937, 6383.616982981036, 6460.903086453707, 6502.187226596676, 6559.540172435337, 6746.527743058037, 6764.255931847493, 6826.4538836892925, 6833.658317084225, 6841.93158068413, 6369.936300637027, 6446.0, 6475.1582294303325, 6516.315786842408, 6523.8695226095215, 6498.057781621733, 6537.607743535403, 6553.803385898431, 6579.671016449254, 6610.182199895067, 6530.902036469552, 6540.444062254762, 6551.6069035858, 6642.800715978528, 6677.699503522256, 6410.230772307353, 6432.903506447501, 6471.288158302677, 6474.798568486549, 6498.252700939263, 5001.174806157089, 5016.147254966591, 5016.398032236155, 5027.824026159214, 5044.772985215747, 6606.306337834458, 6616.636085015371, 6707.262201157966, 6732.629705366252, 6749.966250168718, 6385.8722825544155, 6406.551541392244, 6428.935710643021, 6430.935690643221, 6499.5125365598715, 6481.0880790166075, 6497.252815926229, 6533.934660653523, 6558.508111891722, 6569.043930231511, 5834.94165058344, 6211.09939058843, 6350.0, 6375.003748238506, 6418.229812422539, 6453.741850325934, 6456.612603243821, 6512.185976752906, 6563.9343606563325, 6564.606123632598, 6095.451409373178, 6288.899442597619, 6307.716152773228, 6379.904301435575, 6396.648184349905], "value": 5015.200761274821, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.2394155114279, 895.8477058899987, 906.1210625693076, 910.4764760262847, 917.3945196170527, 18390.54023649408, 19194.616107677855, 19313.61372772544, 19316.130774115147, 19346.709799353022, 19901.50246243841, 21665.133394664193, 21681.132754689792, 21731.0, 21813.67279490805, 1009.2279406254221, 1039.049269918024, 1039.8856125826153, 1040.1522758951469, 1041.536516250269, 970.1365784451843, 1057.6668349469892, 1064.377339256532, 1065.211743309953, 1065.525841000755, 1111.288775183883, 1117.8435019097333, 1118.3848883114294, 1118.485496671528, 1118.5302173087323, 1110.8056090184225, 1111.660943412259, 1112.3548341961684, 1112.8664560252741, 1113.8551988241559, 810.8905297784783, 817.2767101115496, 817.6851912013917, 818.5743413425046, 818.7789296889866, 17922.641547169114, 17999.0, 18104.456866294033, 18608.348707795296, 20331.390058298275, 20631.896840515703, 21087.894560527253, 21136.682949755766, 21229.893850530803, 21248.15007399702, 16003.839961600352, 16424.589385265463, 16487.752683709754, 16568.92302000366, 16709.081000544964, 3517.982410087933, 3547.592026916912, 3557.2707594942976, 3559.341521818446, 3560.092176495003, 119810.0, 122438.0, 123188.0, 124340.0, 127110.0, 15304.693906121815, 15655.921720391325, 15832.0, 15856.286467109008, 15878.92060539713, 30348.54477182844, 30507.69492305093, 31279.0, 31347.843260784008, 31354.43227838599, 8075.515469071875, 8103.473274237156, 8144.470609410369, 8165.591720413956, 8202.056763472157, 3587.587427445825, 3674.540682414698, 3694.3534881396185, 3703.2963736890442, 3709.7403181777017, 4649.883752906205, 5270.841874743764, 5644.717764111778, 5876.08920617305, 5878.853028674317, 1052.1582733812918, 1074.2802322443981, 1076.3219171921796, 1097.1442275025493, 1100.3672888089382, 651.6774196772628, 673.9797806065826, 681.4786688183543, 685.5954986557855, 694.2155364438153, 11464.312141271384, 12074.637760867188, 12192.719764424784, 12317.322547259986, 13450.86549134496, 691.0636088100551, 713.1798431803364, 717.6591119218434, 717.9928200717926, 729.6023667101442, 5358.973205134027, 5428.7950467853425, 5575.637583557056, 5705.62913410627, 5749.051406517961, 98714.50642746883, 103340.0, 104367.0, 105108.0, 105881.47059264654, 84259.5787021061, 88611.55694221616, 89829.0, 89923.0, 92911.0, 78401.0, 78990.81513777298, 79387.60306198547, 79855.0, 81884.59057704674, 10839.512221950188, 11034.724131896766, 11108.111351092055, 11285.43572821372, 11303.604373847205, 34416.31167376688, 35120.64879351174, 35434.645653543135, 35501.82249088738, 36856.26287474289, 45728.54271457243, 45841.54158458373, 45906.31140532828, 46394.30408543942, 47466.28800567925, 15291.082535047934, 15634.609134771721, 15683.1374274416, 15754.921225394259, 15784.92107539455, 16436.424725134562, 16447.342106315613, 16476.588085297964, 16557.91721041387, 16614.50156495259, 15485.148316842682, 17316.740248896527, 18794.624107518048, 19078.236870525023, 19439.70840437423, 18930.242790288234, 19238.8076119237, 19285.61428771389, 19356.516087097934, 19499.220031198594, 19098.0, 19161.90419047896, 19276.710849336992, 19493.70759438638, 19611.509712257306, 14137.505187318395, 14319.427222910967, 14433.134011959317, 14478.203698796668, 14635.195064271567, 15050.924745376204, 15068.773968390702, 15103.39586416531, 15148.242587870784, 15201.467948621745], "value": 8921.030129426812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 118.0, 103.0, 107.0, 110.0, 110.0, 109.0, 101.0, 111.0, 109.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 144.0, 182.0, 124.0, 145.0, 150.0, 119.0, 168.0, 124.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 163.0, 166.0, 173.0, 167.0, 162.0, 173.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 179.0, 75.0, 74.0, 77.0, 76.0, 170.0, 78.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 137.0, 78.0, 79.0, 79.0, 136.0, 78.0, 81.0, 130.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 115.0, 114.0, 114.0, 119.0, 113.0, 118.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 156.0, 157.0, 157.0, 150.0, 151.0, 152.0, 158.0, 151.0, 152.0], "value": 153.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 95.0, 97.0, 95.0, 98.0, 94.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 55.0, 55.0, 57.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 54.0, 54.0, 58.0, 57.0, 63.0, 53.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 88.0, 79.0, 79.0, 85.0, 77.0, 78.0, 76.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 129.0, 133.0, 127.0, 153.0, 132.0, 124.0, 127.0, 169.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 180.0, 183.0, 187.0, 183.0, 183.0, 180.0, 175.0, 177.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 68.0, 70.0, 67.0, 67.0, 71.0, 73.0, 70.0, 70.0], "value": 69.5, "unit": "score"}]}]} 03:55:02 INFO - Return code: 0 03:55:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:02 INFO - # TBPL SUCCESS # 03:55:02 INFO - Running post-action listener: _package_coverage_data 03:55:02 INFO - Running post-action listener: _resource_record_post_action 03:55:02 INFO - [mozharness: 2017-08-03 10:55:02.177064Z] Finished run-tests step (success) 03:55:02 INFO - Running post-run listener: _resource_record_post_run 03:55:02 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 618496; Write bytes: 443797504; Read time: 92; Write time: 450152 03:55:02 INFO - TinderboxPrint: CPU usage
13.2% 03:55:02 INFO - TinderboxPrint: I/O read bytes / time
618,496 / 92 03:55:02 INFO - TinderboxPrint: I/O write bytes / time
443,797,504 / 450,152 03:55:02 INFO - TinderboxPrint: CPU idle
8,269.7 (86.8%) 03:55:02 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 03:55:02 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119754752; Read time: 0; Write time: 134228 03:55:02 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:02 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 614400; Write bytes: 322920448; Read time: 84; Write time: 315896 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:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 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: perfherder-data.json: 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/dromaeojs-e10s_errorsummary.log ... 03:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:04 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/resource-usage.json ... 03:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:11 INFO - (blobuploader) - INFO - Done attempting. 03:55:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: 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 {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c126e8fcbdb7d9cd73cea69d88d67b08064528114ddddc8504ae9720a2457352a659ae3c1730f2bbcf87f535f672a9e51d0cd8a00a074ebc36a1ac9f0a5e25", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e5578ead3ca62b578873e67d1b2d4c5f6bf5084a10cde92d957d3478739f2f24eeaf78528a8e8e95ff27913f7541bfe8ef213163395e3d3553bc447cc37a16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f454eca41a5b59175729909ad76e38a3b122a6828a7566f2316ff7e420494fa116022e140c211383a62a900e448940ada4f47667f68296da92d5a993d639934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c747f5e41f66e56393351bfb19d42a6f1fa32d3b00cd8b7fa08ecf92891fd7a41f6f8c58fb2a6d95909bb5f9896e9ce8c97f3e0654d62582df9822f98fa45"} 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:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c126e8fcbdb7d9cd73cea69d88d67b08064528114ddddc8504ae9720a2457352a659ae3c1730f2bbcf87f535f672a9e51d0cd8a00a074ebc36a1ac9f0a5e25", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e5578ead3ca62b578873e67d1b2d4c5f6bf5084a10cde92d957d3478739f2f24eeaf78528a8e8e95ff27913f7541bfe8ef213163395e3d3553bc447cc37a16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f454eca41a5b59175729909ad76e38a3b122a6828a7566f2316ff7e420494fa116022e140c211383a62a900e448940ada4f47667f68296da92d5a993d639934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c747f5e41f66e56393351bfb19d42a6f1fa32d3b00cd8b7fa08ecf92891fd7a41f6f8c58fb2a6d95909bb5f9896e9ce8c97f3e0654d62582df9822f98fa45"} 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.652821 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-03 03:55:12.459843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.463111) ========= 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=d2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c126e8fcbdb7d9cd73cea69d88d67b08064528114ddddc8504ae9720a2457352a659ae3c1730f2bbcf87f535f672a9e51d0cd8a00a074ebc36a1ac9f0a5e25", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e5578ead3ca62b578873e67d1b2d4c5f6bf5084a10cde92d957d3478739f2f24eeaf78528a8e8e95ff27913f7541bfe8ef213163395e3d3553bc447cc37a16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f454eca41a5b59175729909ad76e38a3b122a6828a7566f2316ff7e420494fa116022e140c211383a62a900e448940ada4f47667f68296da92d5a993d639934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c747f5e41f66e56393351bfb19d42a6f1fa32d3b00cd8b7fa08ecf92891fd7a41f6f8c58fb2a6d95909bb5f9896e9ce8c97f3e0654d62582df9822f98fa45"} build_url:https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/ZeSY-_-GThiB0d3w2ugulQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44c126e8fcbdb7d9cd73cea69d88d67b08064528114ddddc8504ae9720a2457352a659ae3c1730f2bbcf87f535f672a9e51d0cd8a00a074ebc36a1ac9f0a5e25", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e5578ead3ca62b578873e67d1b2d4c5f6bf5084a10cde92d957d3478739f2f24eeaf78528a8e8e95ff27913f7541bfe8ef213163395e3d3553bc447cc37a16e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f454eca41a5b59175729909ad76e38a3b122a6828a7566f2316ff7e420494fa116022e140c211383a62a900e448940ada4f47667f68296da92d5a993d639934", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c747f5e41f66e56393351bfb19d42a6f1fa32d3b00cd8b7fa08ecf92891fd7a41f6f8c58fb2a6d95909bb5f9896e9ce8c97f3e0654d62582df9822f98fa45"}' ========= master_lag: 0.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.952951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.953292) ========= 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=d2a8c569965ab8367867b893000001a1-1501756452.70195-1769904779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003703 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:55:12.972720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:12.973029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 03:55:12.973318) ========= ========= Total master_lag: 0.58 =========