builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-073 starttime: 1500911970.12 results: success (0) revision: 8c6bdb807255b0510591403628fbc30e1645bd0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.125049) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.125531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.125814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.152749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.153117) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 08:59:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.0M=0s 2017-07-24 08:59:30 (30.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.290256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.290568) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020408 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.339791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:30.340204) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 8c6bdb807255b0510591403628fbc30e1645bd0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev 8c6bdb807255b0510591403628fbc30e1645bd0a --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=9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 08:59:31,096 truncating revision to first 12 chars 2017-07-24 08:59:31,096 Setting DEBUG logging. 2017-07-24 08:59:31,096 attempt 1/10 2017-07-24 08:59:31,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/8c6bdb807255?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 08:59:31,624 unpacking tar archive at: cedar-8c6bdb807255/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:31.237975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:31.238292) ========= script_repo_revision: 8c6bdb807255b0510591403628fbc30e1645bd0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:31.238685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:31.238947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 08:59:31.249516) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-24 08:59:31.249831) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:32 INFO - MultiFileLogger online at 20170724 08:59:32 in /builds/slave/test 08:59:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:59:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:32 INFO - {'append_to_log': False, 08:59:32 INFO - 'base_work_dir': '/builds/slave/test', 08:59:32 INFO - 'blob_upload_branch': 'Cedar', 08:59:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:32 INFO - 'branch': 'Cedar', 08:59:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:32 INFO - 'code_coverage': False, 08:59:32 INFO - 'config_files': ('talos/linux_config.py',), 08:59:32 INFO - 'default_actions': ('clobber', 08:59:32 INFO - 'read-buildbot-config', 08:59:32 INFO - 'download-and-extract', 08:59:32 INFO - 'populate-webroot', 08:59:32 INFO - 'create-virtualenv', 08:59:32 INFO - 'install', 08:59:32 INFO - 'setup-mitmproxy', 08:59:32 INFO - 'run-tests'), 08:59:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:32 INFO - 'disable_ccov_upload': False, 08:59:32 INFO - 'download_minidump_stackwalk': True, 08:59:32 INFO - 'download_symbols': 'ondemand', 08:59:32 INFO - 'enable_stylo': False, 08:59:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:32 INFO - 'gecko_profile': False, 08:59:32 INFO - 'gecko_profile_interval': 0, 08:59:32 INFO - 'installer_path': 'installer.exe', 08:59:32 INFO - 'log_level': 'info', 08:59:32 INFO - 'log_name': 'talos', 08:59:32 INFO - 'log_to_console': True, 08:59:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:32 INFO - 'opt_config_files': (), 08:59:32 INFO - 'pip_index': False, 08:59:32 INFO - 'suite': 'dromaeojs-e10s', 08:59:32 INFO - 'system_bits': '32', 08:59:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:32 INFO - 'title': 'talos-linux64-ix-073', 08:59:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:32 INFO - 'use_talos_json': True, 08:59:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:32 INFO - 'work_dir': 'build'} 08:59:32 INFO - [mozharness: 2017-07-24 15:59:32.108123Z] Running clobber step. 08:59:32 INFO - Running pre-action listener: _resource_record_pre_action 08:59:32 INFO - Running main action method: clobber 08:59:32 INFO - rmtree: /builds/slave/test/build 08:59:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:33 INFO - Running post-action listener: _resource_record_post_action 08:59:33 INFO - [mozharness: 2017-07-24 15:59:33.654650Z] Finished clobber step (success) 08:59:33 INFO - [mozharness: 2017-07-24 15:59:33.654752Z] Running read-buildbot-config step. 08:59:33 INFO - Running pre-action listener: _resource_record_pre_action 08:59:33 INFO - Running main action method: read_buildbot_config 08:59:33 INFO - Using buildbot properties: 08:59:33 INFO - { 08:59:33 INFO - "project": "", 08:59:33 INFO - "product": "firefox", 08:59:33 INFO - "who": "mconley@mozilla.com", 08:59:33 INFO - "installer_path": "public/build/target.tar.bz2", 08:59:33 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 08:59:33 INFO - "repository": "https://hg.mozilla.org/projects/cedar/", 08:59:33 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 08:59:33 INFO - "stage_platform": "linux64", 08:59:33 INFO - "basedir": "/builds/slave/test", 08:59:33 INFO - "buildnumber": 13, 08:59:33 INFO - "platform": "ubuntu64_hw", 08:59:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:59:33 INFO - "slavebuilddir": "test", 08:59:33 INFO - "taskId": "PsaTAMbpRFy5oUE1sKvkuw", 08:59:33 INFO - "branch": "cedar", 08:59:33 INFO - "script_repo_revision": "default", 08:59:33 INFO - "revision": "8c6bdb807255b0510591403628fbc30e1645bd0a", 08:59:33 INFO - "slavename": "talos-linux64-ix-073", 08:59:33 INFO - "repo_path": "projects/cedar" 08:59:33 INFO - } 08:59:33 INFO - Finding installer, test and symbols from parent task. 08:59:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PsaTAMbpRFy5oUE1sKvkuw'}, attempt #1 08:59:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PsaTAMbpRFy5oUE1sKvkuw'}, attempt #1 08:59:34 INFO - Task dependencies: FBg96DS-TD678fjR-8rJQw 08:59:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw'}, attempt #1 08:59:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2 08:59:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/test_packages.json 08:59:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.crashreporter-symbols.zip 08:59:35 INFO - Running post-action listener: _resource_record_post_action 08:59:35 INFO - [mozharness: 2017-07-24 15:59:35.035537Z] Finished read-buildbot-config step (success) 08:59:35 INFO - [mozharness: 2017-07-24 15:59:35.035759Z] Running download-and-extract step. 08:59:35 INFO - Running pre-action listener: _resource_record_pre_action 08:59:35 INFO - Running main action method: download_and_extract 08:59:35 INFO - mkdir: /builds/slave/test/build/tests 08:59:35 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')]} 08:59:35 INFO - trying https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.test_packages.json 08:59:35 INFO - Downloading https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:59:35 INFO - Downloaded 989 bytes. 08:59:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:59:35 INFO - Using the following test package requirements: 08:59:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:59:35 INFO - u'common': [u'target.common.tests.zip'], 08:59:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:59:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:59:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:59:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:59:35 INFO - u'mozbase': [u'target.common.tests.zip'], 08:59:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:59:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:59:35 INFO - u'web-platform': [u'target.common.tests.zip', 08:59:35 INFO - u'target.web-platform.tests.tar.gz'], 08:59:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:59:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.common.tests.zip 08:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.common.tests.zip into memory 08:59:37 INFO - Content-Length response header: 72761298 08:59:37 INFO - Bytes received: 72761298 08:59:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:59:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.common.tests.zip 08:59:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:59:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.common.tests.zip into memory 08:59:49 INFO - Content-Length response header: 72761298 08:59:49 INFO - Bytes received: 72761298 09:00:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.talos.tests.zip 09:00:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:00:01 INFO - Fetch https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.talos.tests.zip into memory 09:00:02 INFO - Content-Length response header: 14498976 09:00:02 INFO - Bytes received: 14498976 09:00: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')]} 09:00:03 INFO - trying https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2 09:00:03 INFO - Downloading https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:00:04 INFO - Downloaded 62009098 bytes. 09:00:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2 09:00:04 INFO - mkdir: /builds/slave/test/properties 09:00:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:00:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:00:04 INFO - Contents: 09:00:04 INFO - build_url:https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2 09:00:04 INFO - Running post-action listener: _resource_record_post_action 09:00:04 INFO - Running post-action listener: set_extra_try_arguments 09:00:04 INFO - [mozharness: 2017-07-24 16:00:04.619988Z] Finished download-and-extract step (success) 09:00:04 INFO - [mozharness: 2017-07-24 16:00:04.620162Z] Running populate-webroot step. 09:00:04 INFO - Running pre-action listener: _resource_record_pre_action 09:00:04 INFO - Running main action method: populate_webroot 09:00:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:00:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:00:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:00:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:00:04 INFO - 'tests': ['damp', 'tps']}, 09:00:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:00:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:00:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:00:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:00:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:00:04 INFO - 'ts_paint', 09:00:04 INFO - 'tpaint', 09:00:04 INFO - 'sessionrestore', 09:00:04 INFO - 'sessionrestore_many_windows', 09:00:04 INFO - 'sessionrestore_no_auto_restore', 09:00:04 INFO - 'tabpaint']}, 09:00:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:00:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:00:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:00:04 INFO - 'talos_options': ['--mitmproxy', 09:00:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:00:04 INFO - '--firstNonBlankPaint'], 09:00:04 INFO - 'tests': ['quantum_pageload_google', 09:00:04 INFO - 'quantum_pageload_youtube', 09:00:04 INFO - 'quantum_pageload_amazon', 09:00:04 INFO - 'quantum_pageload_facebook']}, 09:00:04 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:00:04 INFO - 'talos_options': ['--stylo', 09:00:04 INFO - '--mitmproxy', 09:00:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:00:04 INFO - '--firstNonBlankPaint'], 09:00:04 INFO - 'tests': ['quantum_pageload_google', 09:00:04 INFO - 'quantum_pageload_youtube', 09:00:04 INFO - 'quantum_pageload_amazon', 09:00:04 INFO - 'quantum_pageload_facebook']}, 09:00:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:00:04 INFO - 'tsvgr_opacity', 09:00:04 INFO - 'tart', 09:00:04 INFO - 'tscrollx', 09:00:04 INFO - 'cart', 09:00:04 INFO - 'tsvg_static']}, 09:00:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:00:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:00:04 INFO - 'talos_options': ['--xperf_path', 09:00:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:04 INFO - 'tests': ['tp5n']}}} 09:00:04 INFO - Running post-action listener: _resource_record_post_action 09:00:04 INFO - [mozharness: 2017-07-24 16:00:04.630169Z] Finished populate-webroot step (success) 09:00:04 INFO - [mozharness: 2017-07-24 16:00:04.630259Z] Running create-virtualenv step. 09:00:04 INFO - Running pre-action listener: _resource_record_pre_action 09:00:04 INFO - Running main action method: create_virtualenv 09:00:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:00:04 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 09:00:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:00:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:00:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:00:04 INFO - Using real prefix '/usr' 09:00:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:00:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:00:07 INFO - Installing pip.................done. 09:00:07 INFO - Return code: 0 09:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:00:07 INFO - Reading from file tmpfile_stdout 09:00:07 INFO - Output received: 09:00:07 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) 09:00:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:07 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:07 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 09:00:07 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 09:00:07 INFO - Using env: {'DISPLAY': ':0', 09:00:07 INFO - 'HOME': '/home/cltbld', 09:00:07 INFO - 'LANG': 'en_US.UTF-8', 09:00:07 INFO - 'LANGUAGE': 'en_US:en', 09:00:07 INFO - 'LOGNAME': 'cltbld', 09:00:07 INFO - 'MAIL': '/var/mail/cltbld', 09:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:07 INFO - 'MOZ_NO_REMOTE': '1', 09:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:07 INFO - 'NO_EM_RESTART': '1', 09:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:07 INFO - 'PWD': '/builds/slave/test', 09:00:07 INFO - 'SHELL': '/bin/bash', 09:00:07 INFO - 'SHLVL': '1', 09:00:07 INFO - 'TERM': 'linux', 09:00:07 INFO - 'TMOUT': '86400', 09:00:07 INFO - 'USER': 'cltbld', 09:00:07 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:07 INFO - '_': '/tools/buildbot/bin/python'} 09:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:07 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 09:00:07 INFO - Cleaning up... 09:00:07 INFO - Return code: 0 09:00:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:07 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:07 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 09:00:07 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 09:00:07 INFO - Using env: {'DISPLAY': ':0', 09:00:07 INFO - 'HOME': '/home/cltbld', 09:00:07 INFO - 'LANG': 'en_US.UTF-8', 09:00:07 INFO - 'LANGUAGE': 'en_US:en', 09:00:07 INFO - 'LOGNAME': 'cltbld', 09:00:07 INFO - 'MAIL': '/var/mail/cltbld', 09:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:07 INFO - 'MOZ_NO_REMOTE': '1', 09:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:07 INFO - 'NO_EM_RESTART': '1', 09:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:07 INFO - 'PWD': '/builds/slave/test', 09:00:07 INFO - 'SHELL': '/bin/bash', 09:00:07 INFO - 'SHLVL': '1', 09:00:07 INFO - 'TERM': 'linux', 09:00:07 INFO - 'TMOUT': '86400', 09:00:07 INFO - 'USER': 'cltbld', 09:00:07 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:07 INFO - '_': '/tools/buildbot/bin/python'} 09:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:07 INFO - Downloading/unpacking psutil>=3.1.1 09:00:07 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 09:00:07 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 09:00:07 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 09:00:07 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 09:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:09 INFO - Installing collected packages: psutil 09:00:09 INFO - Running setup.py install for psutil 09:00:09 INFO - building 'psutil._psutil_linux' extension 09:00:09 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 09:00:09 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 09:00:09 INFO - building 'psutil._psutil_posix' extension 09:00:09 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 09:00:09 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 09:00:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:09 INFO - Successfully installed psutil 09:00:09 INFO - Cleaning up... 09:00:09 INFO - Return code: 0 09:00:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:09 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:09 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 09:00:09 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 09:00:09 INFO - Using env: {'DISPLAY': ':0', 09:00:09 INFO - 'HOME': '/home/cltbld', 09:00:09 INFO - 'LANG': 'en_US.UTF-8', 09:00:09 INFO - 'LANGUAGE': 'en_US:en', 09:00:09 INFO - 'LOGNAME': 'cltbld', 09:00:09 INFO - 'MAIL': '/var/mail/cltbld', 09:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:09 INFO - 'MOZ_NO_REMOTE': '1', 09:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:09 INFO - 'NO_EM_RESTART': '1', 09:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:09 INFO - 'PWD': '/builds/slave/test', 09:00:09 INFO - 'SHELL': '/bin/bash', 09:00:09 INFO - 'SHLVL': '1', 09:00:09 INFO - 'TERM': 'linux', 09:00:09 INFO - 'TMOUT': '86400', 09:00:09 INFO - 'USER': 'cltbld', 09:00:09 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:09 INFO - '_': '/tools/buildbot/bin/python'} 09:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:00:10 INFO - Installing collected packages: mozsystemmonitor 09:00:10 INFO - Running setup.py install for mozsystemmonitor 09:00:11 INFO - Successfully installed mozsystemmonitor 09:00:11 INFO - Cleaning up... 09:00:11 INFO - Return code: 0 09:00:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:00:11 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')]} 09:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:11 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')]} 09:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:11 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:11 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 09:00:11 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 09:00:11 INFO - Using env: {'DISPLAY': ':0', 09:00:11 INFO - 'HOME': '/home/cltbld', 09:00:11 INFO - 'LANG': 'en_US.UTF-8', 09:00:11 INFO - 'LANGUAGE': 'en_US:en', 09:00:11 INFO - 'LOGNAME': 'cltbld', 09:00:11 INFO - 'MAIL': '/var/mail/cltbld', 09:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:11 INFO - 'MOZ_NO_REMOTE': '1', 09:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:11 INFO - 'NO_EM_RESTART': '1', 09:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:11 INFO - 'PWD': '/builds/slave/test', 09:00:11 INFO - 'SHELL': '/bin/bash', 09:00:11 INFO - 'SHLVL': '1', 09:00:11 INFO - 'TERM': 'linux', 09:00:11 INFO - 'TMOUT': '86400', 09:00:11 INFO - 'USER': 'cltbld', 09:00:11 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:11 INFO - '_': '/tools/buildbot/bin/python'} 09:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:11 INFO - Downloading/unpacking jsonschema==2.5.1 09:00:11 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 09:00:11 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 09:00:11 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 09:00:11 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 09:00:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:12 INFO - warning: no files found matching '*.txt' 09:00:12 INFO - no previously-included directories found matching 'build' 09:00:12 INFO - no previously-included directories found matching 'dist' 09:00:12 INFO - no previously-included directories found matching '.git*' 09:00:12 INFO - Installing collected packages: jsonschema, functools32 09:00:12 INFO - Running setup.py install for functools32 09:00:12 INFO - warning: no files found matching '*.txt' 09:00:12 INFO - no previously-included directories found matching 'build' 09:00:12 INFO - no previously-included directories found matching 'dist' 09:00:12 INFO - no previously-included directories found matching '.git*' 09:00:12 INFO - Successfully installed jsonschema functools32 09:00:12 INFO - Cleaning up... 09:00:12 INFO - Return code: 0 09:00:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:12 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:12 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 09:00:12 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 09:00:12 INFO - Using env: {'DISPLAY': ':0', 09:00:12 INFO - 'HOME': '/home/cltbld', 09:00:12 INFO - 'LANG': 'en_US.UTF-8', 09:00:12 INFO - 'LANGUAGE': 'en_US:en', 09:00:12 INFO - 'LOGNAME': 'cltbld', 09:00:12 INFO - 'MAIL': '/var/mail/cltbld', 09:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:12 INFO - 'MOZ_NO_REMOTE': '1', 09:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:12 INFO - 'NO_EM_RESTART': '1', 09:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:12 INFO - 'PWD': '/builds/slave/test', 09:00:12 INFO - 'SHELL': '/bin/bash', 09:00:12 INFO - 'SHLVL': '1', 09:00:12 INFO - 'TERM': 'linux', 09:00:12 INFO - 'TMOUT': '86400', 09:00:12 INFO - 'USER': 'cltbld', 09:00:12 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:12 INFO - '_': '/tools/buildbot/bin/python'} 09:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:00:13 INFO - Cleaning up... 09:00:13 INFO - Return code: 0 09:00:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:00:13 INFO - Using env: {'DISPLAY': ':0', 09:00:13 INFO - 'HOME': '/home/cltbld', 09:00:13 INFO - 'LANG': 'en_US.UTF-8', 09:00:13 INFO - 'LANGUAGE': 'en_US:en', 09:00:13 INFO - 'LOGNAME': 'cltbld', 09:00:13 INFO - 'MAIL': '/var/mail/cltbld', 09:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:13 INFO - 'MOZ_NO_REMOTE': '1', 09:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:13 INFO - 'NO_EM_RESTART': '1', 09:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:13 INFO - 'PWD': '/builds/slave/test', 09:00:13 INFO - 'SHELL': '/bin/bash', 09:00:13 INFO - 'SHLVL': '1', 09:00:13 INFO - 'TERM': 'linux', 09:00:13 INFO - 'TMOUT': '86400', 09:00:13 INFO - 'USER': 'cltbld', 09:00:13 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:13 INFO - '_': '/tools/buildbot/bin/python'} 09:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:00:13 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 09:00:13 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 09:00:13 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 09:00:13 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 09:00:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:14 INFO - Downloading docopt-0.6.1.tar.gz 09:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:14 INFO - Running setup.py install for blobuploader 09:00:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:15 INFO - Running setup.py install for requests 09:00:15 INFO - Running setup.py install for docopt 09:00:15 INFO - Successfully installed blobuploader requests docopt 09:00:15 INFO - Cleaning up... 09:00:15 INFO - Return code: 0 09:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:15 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')]} 09:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:15 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')]} 09:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:15 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:15 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 09:00:15 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 09:00:15 INFO - Using env: {'DISPLAY': ':0', 09:00:15 INFO - 'HOME': '/home/cltbld', 09:00:15 INFO - 'LANG': 'en_US.UTF-8', 09:00:15 INFO - 'LANGUAGE': 'en_US:en', 09:00:15 INFO - 'LOGNAME': 'cltbld', 09:00:15 INFO - 'MAIL': '/var/mail/cltbld', 09:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:15 INFO - 'MOZ_NO_REMOTE': '1', 09:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:15 INFO - 'NO_EM_RESTART': '1', 09:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:15 INFO - 'PWD': '/builds/slave/test', 09:00:15 INFO - 'SHELL': '/bin/bash', 09:00:15 INFO - 'SHLVL': '1', 09:00:15 INFO - 'TERM': 'linux', 09:00:15 INFO - 'TMOUT': '86400', 09:00:15 INFO - 'USER': 'cltbld', 09:00:15 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:15 INFO - '_': '/tools/buildbot/bin/python'} 09:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:15 INFO - Running setup.py (path:/tmp/pip-DO7chl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:15 INFO - Running setup.py (path:/tmp/pip-HWa49h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:15 INFO - Running setup.py (path:/tmp/pip-DGTxcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:15 INFO - Running setup.py (path:/tmp/pip-44_rl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:16 INFO - Running setup.py (path:/tmp/pip-03T7I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:16 INFO - Running setup.py (path:/tmp/pip-Y0RE4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:16 INFO - Running setup.py (path:/tmp/pip-4Jh2IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:16 INFO - Running setup.py (path:/tmp/pip-RQLPLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:16 INFO - Running setup.py (path:/tmp/pip-FdoLhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:16 INFO - Running setup.py (path:/tmp/pip-QQ75Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:16 INFO - Running setup.py (path:/tmp/pip-rTGPXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:16 INFO - Running setup.py (path:/tmp/pip-RJE3CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:16 INFO - Running setup.py (path:/tmp/pip-yObNVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:16 INFO - Running setup.py (path:/tmp/pip-xrUNEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:16 INFO - Running setup.py (path:/tmp/pip-E457Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:16 INFO - Running setup.py (path:/tmp/pip-HEZCWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:16 INFO - Running setup.py (path:/tmp/pip-TzXfUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:16 INFO - Running setup.py install for manifestparser 09:00:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozcrash 09:00:17 INFO - Running setup.py install for mozdebug 09:00:17 INFO - Running setup.py install for mozdevice 09:00:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozfile 09:00:17 INFO - Running setup.py install for mozhttpd 09:00:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozinfo 09:00:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozInstall 09:00:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:17 INFO - Running setup.py install for mozleak 09:00:17 INFO - Running setup.py install for mozlog 09:00:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for moznetwork 09:00:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozprocess 09:00:18 INFO - Running setup.py install for mozprofile 09:00:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozrunner 09:00:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Running setup.py install for mozscreenshot 09:00:18 INFO - Running setup.py install for moztest 09:00:18 INFO - Running setup.py install for mozversion 09:00:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:18 INFO - Cleaning up... 09:00:18 INFO - Return code: 0 09:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:18 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:18 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 09:00:18 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 09:00:18 INFO - Using env: {'DISPLAY': ':0', 09:00:18 INFO - 'HOME': '/home/cltbld', 09:00:18 INFO - 'LANG': 'en_US.UTF-8', 09:00:18 INFO - 'LANGUAGE': 'en_US:en', 09:00:18 INFO - 'LOGNAME': 'cltbld', 09:00:18 INFO - 'MAIL': '/var/mail/cltbld', 09:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:18 INFO - 'MOZ_NO_REMOTE': '1', 09:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:18 INFO - 'NO_EM_RESTART': '1', 09:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:18 INFO - 'PWD': '/builds/slave/test', 09:00:18 INFO - 'SHELL': '/bin/bash', 09:00:18 INFO - 'SHLVL': '1', 09:00:18 INFO - 'TERM': 'linux', 09:00:18 INFO - 'TMOUT': '86400', 09:00:18 INFO - 'USER': 'cltbld', 09:00:18 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:18 INFO - '_': '/tools/buildbot/bin/python'} 09:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:19 INFO - Running setup.py (path:/tmp/pip-4E2fXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:19 INFO - Running setup.py (path:/tmp/pip-h4JoAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:19 INFO - Running setup.py (path:/tmp/pip-bLaFLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:19 INFO - Running setup.py (path:/tmp/pip-bSHeoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:19 INFO - Running setup.py (path:/tmp/pip-zjHyAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:19 INFO - Running setup.py (path:/tmp/pip-KiVtgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:19 INFO - Running setup.py (path:/tmp/pip-opyg3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:19 INFO - Running setup.py (path:/tmp/pip-oakaed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:19 INFO - Running setup.py (path:/tmp/pip-hrQWtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:19 INFO - Running setup.py (path:/tmp/pip-I6vV1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:19 INFO - Running setup.py (path:/tmp/pip-pA8gIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:19 INFO - Running setup.py (path:/tmp/pip-0LIciS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:19 INFO - Running setup.py (path:/tmp/pip-by9pnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:19 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)) 09:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:19 INFO - Running setup.py (path:/tmp/pip-QllcKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:20 INFO - Running setup.py (path:/tmp/pip-vBKnsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:20 INFO - Running setup.py (path:/tmp/pip-f5ALHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:20 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)) 09:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:20 INFO - Running setup.py (path:/tmp/pip-1lKxHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:20 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)) 09:00:20 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)) 09:00:20 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)) 09:00:20 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)) 09:00:20 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)) 09:00:20 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)) 09:00:20 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)) 09:00:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:21 INFO - Downloading blessings-1.6.tar.gz 09:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:00:21 INFO - Installing collected packages: blessings 09:00:21 INFO - Running setup.py install for blessings 09:00:21 INFO - Successfully installed blessings 09:00:21 INFO - Cleaning up... 09:00:21 INFO - Return code: 0 09:00:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:21 INFO - Reading from file tmpfile_stdout 09:00:21 INFO - Current package versions: 09:00:21 INFO - argparse == 1.2.1 09:00:21 INFO - blessings == 1.6 09:00:21 INFO - blobuploader == 1.2.4 09:00:21 INFO - docopt == 0.6.1 09:00:21 INFO - functools32 == 3.2.3-2 09:00:21 INFO - jsonschema == 2.5.1 09:00:21 INFO - manifestparser == 1.1 09:00:21 INFO - mozInstall == 1.13 09:00:21 INFO - mozcrash == 1.0 09:00:21 INFO - mozdebug == 0.1 09:00:21 INFO - mozdevice == 0.51 09:00:21 INFO - mozfile == 1.2 09:00:21 INFO - mozhttpd == 0.7 09:00:21 INFO - mozinfo == 0.10 09:00:21 INFO - mozleak == 0.1 09:00:21 INFO - mozlog == 3.5 09:00:21 INFO - moznetwork == 0.27 09:00:21 INFO - mozprocess == 0.25 09:00:21 INFO - mozprofile == 0.28 09:00:21 INFO - mozrunner == 6.13 09:00:21 INFO - mozscreenshot == 0.1 09:00:21 INFO - mozsystemmonitor == 0.3 09:00:21 INFO - moztest == 0.8 09:00:21 INFO - mozversion == 1.4 09:00:21 INFO - psutil == 3.1.1 09:00:21 INFO - requests == 1.2.3 09:00:21 INFO - wsgiref == 0.1.2 09:00:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:21 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:21 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 09:00:21 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 09:00:21 INFO - Using env: {'DISPLAY': ':0', 09:00:21 INFO - 'HOME': '/home/cltbld', 09:00:21 INFO - 'LANG': 'en_US.UTF-8', 09:00:21 INFO - 'LANGUAGE': 'en_US:en', 09:00:21 INFO - 'LOGNAME': 'cltbld', 09:00:21 INFO - 'MAIL': '/var/mail/cltbld', 09:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:21 INFO - 'MOZ_NO_REMOTE': '1', 09:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:21 INFO - 'NO_EM_RESTART': '1', 09:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:21 INFO - 'PWD': '/builds/slave/test', 09:00:21 INFO - 'SHELL': '/bin/bash', 09:00:21 INFO - 'SHLVL': '1', 09:00:21 INFO - 'TERM': 'linux', 09:00:21 INFO - 'TMOUT': '86400', 09:00:21 INFO - 'USER': 'cltbld', 09:00:21 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:21 INFO - '_': '/tools/buildbot/bin/python'} 09:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 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)) 09:00:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:00:22 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 09:00:22 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 09:00:22 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 09:00:22 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 09:00:23 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:00:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:00:23 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 09:00:23 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 09:00:23 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 09:00:23 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 09:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:00:23 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)) 09:00:23 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)) 09:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:00:23 INFO - Installing collected packages: marionette-driver, simplejson 09:00:23 INFO - Running setup.py install for marionette-driver 09:00:23 INFO - Running setup.py install for simplejson 09:00:23 INFO - building 'simplejson._speedups' extension 09:00:23 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 09:00:24 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 09:00:24 INFO - Successfully installed marionette-driver simplejson 09:00:24 INFO - Cleaning up... 09:00:24 INFO - Return code: 0 09:00:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00: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')]} 09:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:24 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 0x10091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1378d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', '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 09:00:24 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 09:00:24 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 09:00:24 INFO - Using env: {'DISPLAY': ':0', 09:00:24 INFO - 'HOME': '/home/cltbld', 09:00:24 INFO - 'LANG': 'en_US.UTF-8', 09:00:24 INFO - 'LANGUAGE': 'en_US:en', 09:00:24 INFO - 'LOGNAME': 'cltbld', 09:00:24 INFO - 'MAIL': '/var/mail/cltbld', 09:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:24 INFO - 'MOZ_NO_REMOTE': '1', 09:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:24 INFO - 'NO_EM_RESTART': '1', 09:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:24 INFO - 'PWD': '/builds/slave/test', 09:00:24 INFO - 'SHELL': '/bin/bash', 09:00:24 INFO - 'SHLVL': '1', 09:00:24 INFO - 'TERM': 'linux', 09:00:24 INFO - 'TMOUT': '86400', 09:00:24 INFO - 'USER': 'cltbld', 09:00:24 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:24 INFO - '_': '/tools/buildbot/bin/python'} 09:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:00:24 INFO - Cleaning up... 09:00:24 INFO - Return code: 0 09:00:24 INFO - Running post-action listener: _resource_record_post_action 09:00:24 INFO - Running post-action listener: _start_resource_monitoring 09:00:24 INFO - Starting resource monitoring. 09:00:24 INFO - [mozharness: 2017-07-24 16:00:24.826581Z] Finished create-virtualenv step (success) 09:00:24 INFO - [mozharness: 2017-07-24 16:00:24.827100Z] Running install step. 09:00:24 INFO - Running pre-action listener: _resource_record_pre_action 09:00:24 INFO - Running main action method: install 09:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:00:25 INFO - Reading from file tmpfile_stdout 09:00:25 INFO - Detecting whether we're running mozinstall >=1.0... 09:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:00:25 INFO - Reading from file tmpfile_stdout 09:00:25 INFO - Output received: 09:00:25 INFO - Usage: mozinstall [options] installer 09:00:25 INFO - Options: 09:00:25 INFO - -h, --help show this help message and exit 09:00:25 INFO - -d DEST, --destination=DEST 09:00:25 INFO - Directory to install application into. [default: 09:00:25 INFO - "/builds/slave/test"] 09:00:25 INFO - --app=APP Application being installed. [default: firefox] 09:00:25 INFO - mkdir: /builds/slave/test/build/application 09:00:25 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'] 09:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:00:43 INFO - Reading from file tmpfile_stdout 09:00:43 INFO - Output received: 09:00:43 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:43 INFO - Running post-action listener: _resource_record_post_action 09:00:43 INFO - [mozharness: 2017-07-24 16:00:43.116758Z] Finished install step (success) 09:00:43 INFO - [mozharness: 2017-07-24 16:00:43.117018Z] Running setup-mitmproxy step. 09:00:43 INFO - Running pre-action listener: _resource_record_pre_action 09:00:43 INFO - Running main action method: setup_mitmproxy 09:00:43 INFO - Skipping: mitmproxy is not required 09:00:43 INFO - Running post-action listener: _resource_record_post_action 09:00:43 INFO - [mozharness: 2017-07-24 16:00:43.118206Z] Finished setup-mitmproxy step (success) 09:00:43 INFO - [mozharness: 2017-07-24 16:00:43.118429Z] Running run-tests step. 09:00:43 INFO - Running pre-action listener: _resource_record_pre_action 09:00:43 INFO - Running pre-action listener: _set_gcov_prefix 09:00:43 INFO - Running main action method: run_tests 09:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:43 INFO - Python 2.7.3 09:00:43 INFO - Return code: 0 09:00:43 INFO - grabbing minidump binary from tooltool 09:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:43 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 0x1375eb0>, '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 0x1376db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1377240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:43 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 09:00:43 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 09:00:43 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 09:00:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:43 INFO - Return code: 0 09:00:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:43 INFO - ENV: RUST_BACKTRACE is now 1 09:00:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 09:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --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 09:00:43 INFO - Using env: {'DISPLAY': ':0', 09:00:43 INFO - 'HOME': '/home/cltbld', 09:00:43 INFO - 'LANG': 'en_US.UTF-8', 09:00:43 INFO - 'LANGUAGE': 'en_US:en', 09:00:43 INFO - 'LOGNAME': 'cltbld', 09:00:43 INFO - 'MAIL': '/var/mail/cltbld', 09:00:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:43 INFO - 'MOZ_NO_REMOTE': '1', 09:00:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:43 INFO - 'NO_EM_RESTART': '1', 09:00:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:43 INFO - 'PWD': '/builds/slave/test', 09:00:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:43 INFO - 'RUST_BACKTRACE': '1', 09:00:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:00:43 INFO - 'SHELL': '/bin/bash', 09:00:43 INFO - 'SHLVL': '1', 09:00:43 INFO - 'TERM': 'linux', 09:00:43 INFO - 'TMOUT': '86400', 09:00:43 INFO - 'USER': 'cltbld', 09:00:43 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991', 09:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:43 INFO - '_': '/tools/buildbot/bin/python'} 09:00:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--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 09:00:43 INFO - mozversion application_buildid: 20170724150727 09:00:43 INFO - mozversion application_changeset: 8c6bdb807255b0510591403628fbc30e1645bd0a 09:00:43 INFO - mozversion application_display_name: Nightly 09:00:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:43 INFO - mozversion application_name: Firefox 09:00:43 INFO - mozversion application_remotingname: firefox 09:00:43 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 09:00:43 INFO - mozversion application_vendor: Mozilla 09:00:43 INFO - mozversion application_version: 56.0a1 09:00:43 INFO - mozversion platform_buildid: 20170724150727 09:00:43 INFO - mozversion platform_changeset: 8c6bdb807255b0510591403628fbc30e1645bd0a 09:00:43 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 09:00:43 INFO - mozversion platform_version: 56.0a1 09:00:43 INFO - using testdate: 1500912043 09:00:43 INFO - actual date: 1500912043 09:00:43 INFO - starting webserver on 'localhost:41822' 09:00:43 INFO - SUITE-START | Running 2 tests 09:00:43 INFO - TEST-START | dromaeo_css 09:00:43 INFO - Initialising browser for dromaeo_css test... 09:00:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41822/getInfo.html -profile /tmp/tmpDMhfOZ/profile 09:00:43 INFO - TEST-INFO | started process 29506 (/builds/slave/test/build/application/firefox/firefox http://localhost:41822/getInfo.html) 09:00:49 INFO - TEST-INFO | 29506: exit 0 09:00:49 INFO - Browser initialized. 09:00:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:49 INFO - TEST-INFO | started process 29714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDMhfOZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:00 INFO - PID 29714 | RSS: Main: 176091136 09:01:00 INFO - PID 29714 | 09:04:00 INFO - PID 29714 | Cycle 1(1): loaded http://localhost:41822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41822/tests/dromaeo/cssquery-ext.html) 09:04:01 INFO - PID 29714 | RSS: Main: 179240960 09:04:01 INFO - PID 29714 | 09:07:02 INFO - PID 29714 | Cycle 1(1): loaded http://localhost:41822/tests/dromaeo/cssquery-ext.html (next: http://localhost:41822/tests/dromaeo/cssquery-jquery.html) 09:07:03 INFO - PID 29714 | RSS: Main: 176181248 09:07:03 INFO - PID 29714 | 09:10:05 INFO - PID 29714 | Cycle 1(1): loaded http://localhost:41822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41822/tests/dromaeo/cssquery-mootools.html) 09:10:05 INFO - PID 29714 | RSS: Main: 178225152 09:10:05 INFO - PID 29714 | 09:13:07 INFO - PID 29714 | Cycle 1(1): loaded http://localhost:41822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41822/tests/dromaeo/cssquery-prototype.html) 09:13:08 INFO - PID 29714 | RSS: Main: 176480256 09:13:08 INFO - PID 29714 | 09:16:11 INFO - PID 29714 | Cycle 1(1): loaded http://localhost:41822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41822/tests/dromaeo/cssquery-yui.html) 09:16:12 INFO - PID 29714 | RSS: Main: 178573312 09:16:12 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | Cycle 1(1): loaded http://localhost:41822/tests/dromaeo/cssquery-yui.html (next: http://localhost:41822/tests/dromaeo/cssquery-dojo.html) 09:19:14 INFO - PID 29714 | RSS: Main: 180760576 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | __start_tp_report 09:19:14 INFO - PID 29714 | _x_x_mozilla_page_load 09:19:14 INFO - PID 29714 | _x_x_mozilla_page_load_details 09:19:14 INFO - PID 29714 | |i|pagename|runs| 09:19:14 INFO - PID 29714 | |0;dojo.html;3100.767442441816;3117.4388610050187;3135.9059228223155;3140.842957852107;3181.236503239223;5975.611585246961;6066.120412540179;6096.2074930259005;6130.846728831776;6142.631442113471;5972.19375384323;6073.392660733935;6079.544034197431;6083.391660833914;6098.17674613927;5505.201745746865;5510.614257002001;5544.91682624759;5607.635503692268;5623.128415095646;5528.115501519757;5616.269884914956;5625.353084395286;5649.6327738697055;5673.943260567404;5358.410574836765;5493.890122197574;5510.834674959718;5606.915896261559;5611.579131565108;5494.862628434281;5507.476789704971;5574.275344205268;5582.637128586629;5596.804111856066;5415.160650099241;5481.451854814526;5539.556835453154;5541.307336582927;5543.473370029841;5931.851703707399;5945.851353716192;5976.103584462322;6000.699965001732;6014.097885317194;6441.516886233551;6455.903161452582;6506.902396464056;6545.509086818508;6552;6321.178246827929;6466.805995820133;6604.900926486107;6604.93395066048;6617.834554136185;6055.545834062463;6069.787557435468;6124.969375153185;6153.569250152446;6159.630422174684;6597.076409302702;6624.238212605515;6706.128203333536;6710.127683401127;6714.697838597275;6303.590266632654;6307.180066591313;6376.56527281358;6393;6418.1656384669695;6364.7135878885565;6389.424951754364;6478.838029049217;6479.125318082093;6494.415502604788;6398.456131228804;6460.676966151674;6477.870442591122;6521.217453905561;6554.606723596599;6485.70814313357;6519.445847102955;6569.770058047945;6602.7028783704845;6620.437262832616;5261.421243663194;5304.92042619361;5345.305110335709;5345.705986170798;5355.0360935031285;4548.818047278138;4569.680122391467;4584.701994370355;4612.561806628365;4650.837220697259;5732.742026608813;5770.42295770428;5794.101914203306;5796.710164491758;5800.1589769484035;6522.380373864476;6556.541042127005;6575.967120164369;6628.602283862983;6654;5575.693336866511;5596.524295434933;5646.915296270559;5672.376038635747;5682.289713785777;5764.337101233412;5765.221695071195;5793.420657934173;5806.390329015477;5832.679202643895;6238.064290356483;6254.593451425734;6363.140975968277;6376.33048529907;6386.521010924199;6312.084747711648;6439.388258115471;6456.192975878015;6464.741410343534;6566.343365663395;6266.686665666607;6271.717772700148;6368.745250189941;6391.137196478602;6393.424591786761;6345.016522438845;6397.808065758035;6470.352964703492;6492.480601551959;6496.0255961606135;6495.447886929475;6496;6566.4418524424045;6591.6045037296;6638.5684930479365;6252.5935814171935;6331.240251169889;6337.8732425352155;6360.809175724736;6369.617822930639;6326.493880489642;6333.493320534439;6391.073294372383;6402.711877965409;6406.5515413920575;6245.437910588069;6261.655608941552;6363.3636636336;6372;6385.45723613498;6173.969130154321;6372.840678983062;6511.576747511396;6511.902321465087;6518.250401203923;6153.169322141633;6191.19514463135;6206.049561238416;6273.341299163522;6280.654563999024 09:19:14 INFO - PID 29714 | |1;ext.html;788.4205109244704;811.577979450686;817.2481317188187;852.0457088061372;853.4239388412824;40189.19621607566;41112.38331425027;41121.79439102804;41153.58846411535;41213.793931030305;36764.63235367652;36979.260414791686;37141.25717485649;37151;37249.44125838114;6572.80281591553;6687.130673012502;6689.197296324423;6692.063111164441;6692.899606505906;6567.211934567858;6673.399394054534;6685.0640910272605;6685.899711504307;6690.297518760533;6624.93375066248;6656.068150458916;7311.8537629247385;7520.135184453776;7532.133804612485;7444.478886477948;7482.700691972314;7490.887636685454;7495.625218739041;7495.66269517873;7394.445416593777;7447.329740323397;7472.887906681404;7475.813104672427;7477;37152.25695486102;37253;37530;37552.62447375518;37583.06042348936;3365.478350855621;3408.829558522064;3414.197663549064;3419.196488825124;3419.2990436960363;30531;30566.388672226654;30566.54150187749;30583.847080764677;30607.540886886716;4831.444383895861;4874.122657921573;4903.19097348937;4909.950900490985;4988.276699878497;226169;229066;231232;232470;232487;47630.5236947633;49062;49361.75319123453;49779.75110124426;49813.25280120801;50468.24297635538;50524.74737626362;50600;50617;50683.23975140376;14222.644433889236;14269.714605707828;14289;14360.353784079742;14445.277736113152;11676.649700508999;11744.647660570197;11772.058235341152;11787.823182652268;11864.050875929905;13720.588382348546;13740.10689305192;13753.243571603458;13884.305784710725;13981.440742370394;5493.670379777226;5549.445055494418;5581.637193582485;5632.239647647597;5684.261046063985;964.6575465709712;972.5088830140734;980.2305190425482;1000.5447521377756;1012.1396812709138;22203.333899983027;22269.554608907732;22270.109195631994;22399.880005999636;22401.775982239968;1048.1928914735763;1058.7194393485731;1077.4020418667715;1091.8635170603675;1099.9010089092021;11712.063034957184;11755.588554400554;11778.646640600795;11843.28940263587;11930.463129159036;223998;225203;225668;225934;227441;51112.233316500286;51530.22704659433;51805;52847.73576132172;56691.433085668614;1459.2630721485582;1485.524632117712;1493.4101030093052;1494.6114010357169;1496.738070837599;26039.088631897794;27161.72838271592;27226.72773272242;27479.587806183325;27564.86217568899;37893.24213515769;38228.23543529058;38285.4257186148;38297.61702383052;38300;211056;212588;213241;213820;214019;34667.653323466446;34707.82646086753;35258.8237058813;35666.46500302446;35776.64223357837;43593.78203108964;43646.34530481982;43692.78153609339;44160.33759493675;47365.7631711853;33745;34316.31367372689;35408.29183416369;35788.10529736777;36188.63811361853;34377;34796.47805282872;35679.464808027384;35681.28637427289;35795.46306805452;38761.224775504896;39898.601013989486;40291.798541007105;40389.79805100956;40434.786956391355;33756.66243337633;34522.82738586291;34858.47712284369;35176;35591.46612800862;24768.752312476645;24816.50366992686;24946.37634059163;25010;26018 09:19:14 INFO - PID 29714 | |2;jquery.html;578.9768409263628;580.8460757899155;585.104789671802;588.7468388592903;604.4408921747385;22155;22500.774992250073;23125.19061832834;23156.189533366316;23183.072677092896;26610.201693949162;27106.32234194146;27159;27166.728332716717;27212;6498.935010649904;6655.500837437187;6666.133402657648;6671.532992690513;6677.399034086931;5954.07711804671;6557.409833115019;6613.537052406309;6617.933820661804;6620.933790662104;6482.708278127472;6510.446612037958;6513.934860651404;6524.184476940382;6527.347265273482;6513.185851768529;6518.315576864408;6525.119108920307;6526.738930442777;6531.0856480092825;6021.126936594169;6022.8494287642725;6075.33171351151;6086.573939824214;6093;28553.286167845763;29354.11937641874;29830.508474576185;29937.85031074831;31203.843980780177;1948.0844003318418;1998.270631219609;2002.779694233633;2002.959940801176;2003.8797672139717;18918.432447026473;19394.22423103074;19410.611787764166;19526.31657891981;19650.50873728154;2305.953880922389;2344.120954642009;2400.387901085212;2417.697787776528;2418.504206637635;128043;135787;135918.6408135916;136836;136984;14376.568702938928;15287.388504459697;15445.84554154444;15479;15987.120708360919;23532.176373826835;23632;23769.405764856016;23817.285481435585;23964.24411192735;9878.555465004092;10063.144632706155;10077.899221007696;10083.747906302402;10133;9102.408343457653;9220.53897305132;9241.907580924239;9321.207697345666;9405.43567385959;8961.910380896237;9061.77345566366;9388.483633400228;9773.364731292444;9802.411855288705;2906.2734316420897;2916.1543152485965;2938.3241854373614;2938.9265268368463;2989.1630343503853;946.5409276500892;947.8199142162968;985.1773768902902;986.7582442301682;994.0854413939048;23801.285961421185;25103;25449.36376590563;25504;25525.87237063803;1033.106362996003;1041.1046500009986;1045.8483519889573;1075.6396607136696;1079.9298045627008;11128.276662016942;11172.832407513893;11206.831897521544;11488.597899073493;11719.882801172049;485177;490987;492723;504837;509533;113709;113789;114026.42986785014;114281;114771;1203.18784820246;1288.1240756285629;1302.2772361339357;1304.7455746129413;1317.440087962612;20083.297084601967;20832.687509687064;21418.464538386666;21805.127794888027;22002.339929802132;58460.70769646124;58910;59727.70136149292;60059.69970150296;60761.392386075575;66320;66834.33165668475;66915;67610;67906.32093679198;15050.322735476711;15100.622484437537;15377.154256516;15483.612909677347;15501.224938752792;23883.641745373487;23994.76005239995;24047;24205.75794242035;24416;19002.809971900657;19079.14143863502;19173.61652766965;19192.808071919102;19242.23031078797;15133.924330378277;15316.923415383297;15495;17503.3873814421;17741.201645925707;18602.81397186011;19174;20165.79834201639;20259.79740202638;20361.389158325273;14802.259887005392;15004.249787510798;15058.472953446577;15070.623234419227;15088.773668394764;17899.642007159524;18404.907975460035;18905.432837014912;19234.134463949435;19285.325013625017 09:19:14 INFO - PID 29714 | |3;mootools.html;1334.9733005339892;1371.2389623758809;1383.8131852199956;1383.9446422143114;1391.1513976474355;13646.727065458685;14095.577132686036;14201.360938757742;14244.501442449517;14256.429742810275;14302.141871487693;14652.267386630652;14655.633609159777;14669.339879705412;14689;2511.0960054380407;2626.9605955910724;2690.1526019303956;2690.9730902690917;2692.044324264887;2611.2949503634104;2662.6804783426014;2664.200739778059;2664.2273740615196;2665.626812246287;2594.844309341436;2625.7374262573685;2635.6573645426165;2678.1429942418436;2683.4633073385303;2486.5772818620876;2555.833870798392;2565.6921169459783;2590.507803517335;2618.5941179117267;2548.031747935791;2553.8978440862343;2595.5976823592187;2607.6870775506873;2623.4490756941063;13784.517541885985;13854.376553055137;13881.722365552632;13935.233562154077;13948.511802086878;7507.249275072503;7731.497452665559;7787.766367008999;7808.687652493893;7809.726659566944;4971.701697898137;5070.31550740649;5162.070827251093;5224.268602395668;5243.370795504526;1919.673655478572;1920.4046745508938;1955.6675365187953;1974.3682021753045;1998.2007197121268;22545.210917617806;22785.658215126787;22886;23016.539669206522;23038.193663221708;6364.204474440695;6369.808905732835;6593.175853018372;6659.200895892427;6660.433863121689;15462.072275663497;15652.295646695926;15661.138637374826;15665.373385064699;15668.138252396227;7325.194228634846;7627.809304767315;7629.54222746637;7644.159142494321;7650.885236721454;5550.333959924835;6344.302126766052;7109.964450177819;7171.995920571124;7198.964005179941;4898.828541001048;5026.095302845523;5027.874303142451;5084.669496482791;5111.463296353903;1408.0495665425797;1429.7640889253364;1452.2158034661165;1459.7080583883267;1466.6113479927828;851.3402113362193;867.9175478329548;876.7588913048962;905.8731777551149;921.8985911549725;6961.338672826073;7104;7236.710531578783;7289.854202915912;7312.780616581511;665.9700313485807;697.3758486154863;709.7764204275637;715.1454012455171;731.2102928836844;4263.552327005682;4649.767511624405;4740.597049250852;4748.857534273978;4925.7783399747095;17843.197056132507;18759.718604220947;19192.904035479733;19197.520061998282;19242.807571924383;18925.337613183474;18930.716039259423;19002.42992710221;19046.238150473826;19094.522636934187;9084.954575227082;10302.22733294991;10380.273380863267;10528.736781580521;10560.155187584975;7500.812479688051;7998.800029999296;8019.679212831655;8165.101838797608;8253.917460825314;15911.761323579924;16118.274677639769;16182.67634647324;16369.836301637308;16559.586010349354;16347.754783678016;16691.165441728106;16927.49217523476;16939.661206776043;16972.49082527526;10098.94950525272;10200.285979981627;10202.59189632436;10209.9489502552;10283;12674.809877852023;12763.680907977376;12796.936015319863;12817.743645127232;12823.294718790556;10191.388516689023;10674.57301707923;10759.30064545802;10814.729631759268;11015.063719583604;10049.497525123861;10315.896841031494;10333.173346132142;10747;10815.891841081488;9297.442153470813;9308.720738377859;9424.151826335663;9481.52592370365;9494.762630934281;6721.93278067213;6903.965480172567;7114.110736157981;7144.749933752501;7219.891701624375;6527.379898909596;6857.314268573302;7001.159860816734;7061.540999834994;7119.1457025157315 09:19:14 INFO - PID 29714 | |4;prototype.html;482.9154897892869;490.7251938914206;525.070624993761;528.300002496692;529.2960362717586;6143.477804386627;6232.532560057997;6258.311585725566;6260.499160067189;6268.65522396268;5912.822615321536;6042.425969532898;6056.697165141747;6096.298925623554;6157.538184636148;4906.607471402279;4908.263760435945;4941.431735350427;4983.501649835006;5004.799808007684;4802.615790736732;4874.390701162355;4968.254761785743;4969.900601987958;4981.775820088086;4886.853394398174;4900.411950565937;4915.6313276504225;4920.729359885205;4942.258661200813;4877.122118018755;4930.161872481669;4932.408111026664;4934.40787105546;4941.48114447985;4418.630224630343;4437.112577484484;4444.11117776446;4454.37638730578;4454.398656181439;6074.179985701918;6089.786857459968;6093.908591371133;6094.512439004869;6100.176476175749;5599.440055994409;5636.098224284095;5653.717314134276;5658.207850900877;5698.601097923147;6363.96818015907;6370.840728981766;6387.616742995435;6410.358964103552;6439.5170362223025;4772.117158325686;4789.712617242976;4789.976050119762;4818.879528011793;4825.455854126681;6693.497987650897;6789.15135608049;6814.829629259259;6847.452203823732;6899.551094270159;4873.26900964851;4908.754562271872;4945.7527123644395;4955.306257124005;4966.827864593759;5062.670926389773;5068.391792984792;5076.923846142311;5082.796688132434;5106.183010718341;5590;5604.551635869121;5631.239782629293;5660.518855897295;5709.885802283931;6335.778247761306;6449.871272527289;6484;6503.577267477599;6523.739050438025;1661.1528120658309;1693.6697344017798;1699.37972639988;1706.67573161099;1730.6884760742935;1040.6669865643073;1190.3928996211994;1207.5773479282182;1209.2140108929266;1223.2721530689225;5568.522007706531;5644.266245388156;5680.68756218412;5716.142578613159;5727.05503591911;6603.273639899608;6673.499487538454;6675.532712710064;6717.932820671828;6718.5890962897365;5752.28096487939;5771.163181338682;5811.709414529257;5822.505087067647;5823.563232757476;3542.3623747725655;3552.236269202134;3563.821808909544;3590.797082977232;3596.8561257549927;6399.136656141366;6438.8390290243115;6440.291567927524;6456.288358889277;6576;6615.338466153346;6880.174379074543;6893.862122757517;6911.2397636259975;6933.2720064393525;6352.174217351807;6380.489560835122;6443.871122577616;6448.807405482158;6449.097126402307;6627.403533681992;6635.701393437404;6718.186089755836;6730.528862979544;6738.058235932034;6494.318096599789;6671.39957403836;6672.566283191772;6673.332666733482;6690.19717633887;6447.742090316522;6456.644884531396;6462.773802916875;6470.158879345655;6502.139058814107;4856.955754512796;4885.87785305356;4889.682170658896;4892.559669629751;4957.504249575014;6608.471322294301;6633.170853643294;6670.466362691071;6685.896827023486;6693.564918280296;6406.90389644165;6466.515011374072;6469.547131700924;6498.805035848932;6560.901586476111;6496.895527760386;6512.153420055362;6531.281559028598;6538.607683539003;6552.6068435894;6326;6389.48884089281;6391.96804015977;6408;6519.217693876765;6330.52521060913;6417.647029413427;6424.2933277338525;6528.347165283433;6546.312637173029;5712.371639119777;6200.720967556381;6211.937880621317;6281;6349.809505714836 09:19:14 INFO - PID 29714 | |5;yui.html;901.5312037740371;921.6129225725194;930.2557953637089;932.7015355086376;937.1893312284874;17686.823131768677;18278;18412.9872856993;18438.631227375445;20487.078081486332;16082.552570268674;16123.516294511153;19804.09688263297;21595.892020539915;21616.027278772453;1045.5974449836829;1075.2097208551709;1077.2082519348312;1079.4225089577078;1079.9190060745436;1010.2019404670301;1063.3938654966632;1069.8288273876142;1083.6315652678088;1083.8265877459608;1100.0539535999035;1111.2054880760254;1112.7106952192448;1113.704868209921;1113.7271368514726;1100.5707773968159;1101.1411099342527;1102.7298311913632;1104.8563686720674;1111.9666410007712;804.7304153108657;808.8261023879835;810.295043312322;811.5090370325986;811.7848770075934;18429.723554146698;18478.445646630622;18700.812991870178;18742.718859217122;19918.402447926586;20426.69359959602;20517.281895133747;20882.89558552213;20915.058822353032;20944;16212.83787162125;16591.751123733033;16789.6642067158;16793.748093778602;16802.15989200535;3588.6949609283242;3605.152789094561;3613.728970327236;3617.5839778425557;3619.7104231661406;122341;123814;128120.35939820242;129377.7062229375;131271;15282.465113720966;15474.148921809183;15904.681906361808;15951.920240398724;16077.35690572364;28958.131256062352;30641.540376893918;30727;30789.38421231563;30808.537871931938;8355.665773368997;8554.315654747605;8585.82828343442;8604.139586041345;8623;4041.454403655469;4142.668586513072;4145.730527515762;4172.8122234498915;4175.937360939588;4923.187674033816;5140.511651393112;5164.845054648366;5165.431802501722;5184.429712731597;1032.256775121911;1047.5076713944434;1052.3265110329396;1068.7114479090758;1071.3518321415588;615.2831950777295;639.3670266436287;657.0472814419016;674.7570874485182;687.5840116729406;11318.4906679198;12909.870901290868;13497.257650829299;13755.38100785467;13936.372863221179;657.8618490117034;687.2749249541781;709.2659097833717;709.9858002840018;722.0144502753703;5164.561012313995;5359.249705041298;5361.35663720356;5408.161734931092;5673.517750991129;96675.51662241784;99730.50134749425;102641.48679256556;103161;105501.14242574209;86118.56940715256;91491;92890.53554732318;93425;94743;79939.95401794379;81810;82568.58715706383;83148.58425707833;84337;11876.940615296868;12930.547430839875;12951.676208094495;13047.608571742863;13088.149270297401;36906.26187476182;37837.62162378341;38346;38605.2278954425;39087.6091239084;66741.33258667546;67812.660936695;70211;70384.29615703778;72645;18044.458666240032;18263.45209643713;18543.72184417208;18578.907105464386;18866.622667546297;20258.18967241294;20414.693779593614;20500.07749651299;20585;20712.896435517727;16783.412580559623;17029.31882724677;17164;17280.135993200038;17286.654266914844;18663.906680467055;18833.71749423787;19033.809661903204;19122.139503722086;19212.327568535035;19009.52476188051;19074.904625476785;19078.809211907705;19341.323053693053;19475;13070.215787052808;13608.86391136076;14170.92914535462;14400.711985760436;14486.927565362528;13961.232132232419;13990.510332138327;14067.859321406655;14235.288235587972;14565.708685826436 09:19:14 INFO - PID 29714 | __end_tp_report 09:19:14 INFO - PID 29714 | __start_cc_report 09:19:14 INFO - PID 29714 | _x_x_mozilla_cycle_collect,379 09:19:14 INFO - PID 29714 | __end_cc_report 09:19:14 INFO - PID 29714 | __startTimestamp1500913154637__endTimestamp 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | ------- Summary: start ------- 09:19:14 INFO - PID 29714 | Number of tests: 6 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | [#0] dojo.html Cycles:165 Average:6004.09 Median:6254.59 stddev:692.19 (11.1%) stddev-sans-first:655.78 09:19:14 INFO - PID 29714 | Values: 3100.8 3117.4 3135.9 3140.8 3181.2 5975.6 6066.1 6096.2 6130.8 6142.6 5972.2 6073.4 6079.5 6083.4 6098.2 5505.2 5510.6 5544.9 5607.6 5623.1 5528.1 5616.3 5625.4 5649.6 5673.9 5358.4 5493.9 5510.8 5606.9 5611.6 5494.9 5507.5 5574.3 5582.6 5596.8 5415.2 5481.5 5539.6 5541.3 5543.5 5931.9 5945.9 5976.1 6000.7 6014.1 6441.5 6455.9 6506.9 6545.5 6552.0 6321.2 6466.8 6604.9 6604.9 6617.8 6055.5 6069.8 6125.0 6153.6 6159.6 6597.1 6624.2 6706.1 6710.1 6714.7 6303.6 6307.2 6376.6 6393.0 6418.2 6364.7 6389.4 6478.8 6479.1 6494.4 6398.5 6460.7 6477.9 6521.2 6554.6 6485.7 6519.4 6569.8 6602.7 6620.4 5261.4 5304.9 5345.3 5345.7 5355.0 4548.8 4569.7 4584.7 4612.6 4650.8 5732.7 5770.4 5794.1 5796.7 5800.2 6522.4 6556.5 6576.0 6628.6 6654.0 5575.7 5596.5 5646.9 5672.4 5682.3 5764.3 5765.2 5793.4 5806.4 5832.7 6238.1 6254.6 6363.1 6376.3 6386.5 6312.1 6439.4 6456.2 6464.7 6566.3 6266.7 6271.7 6368.7 6391.1 6393.4 6345.0 6397.8 6470.4 6492.5 6496.0 6495.4 6496.0 6566.4 6591.6 6638.6 6252.6 6331.2 6337.9 6360.8 6369.6 6326.5 6333.5 6391.1 6402.7 6406.6 6245.4 6261.7 6363.4 6372.0 6385.5 6174.0 6372.8 6511.6 6511.9 6518.3 6153.2 6191.2 6206.0 6273.3 6280.7 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | [#1] ext.html Cycles:180 Average:39174.00 Median:35992.05 stddev:57903.38 (160.9%) stddev-sans-first:57994.08 09:19:14 INFO - PID 29714 | Values: 788.4 811.6 817.2 852.0 853.4 40189.2 41112.4 41121.8 41153.6 41213.8 36764.6 36979.3 37141.3 37151.0 37249.4 6572.8 6687.1 6689.2 6692.1 6692.9 6567.2 6673.4 6685.1 6685.9 6690.3 6624.9 6656.1 7311.9 7520.1 7532.1 7444.5 7482.7 7490.9 7495.6 7495.7 7394.4 7447.3 7472.9 7475.8 7477.0 37152.3 37253.0 37530.0 37552.6 37583.1 3365.5 3408.8 3414.2 3419.2 3419.3 30531.0 30566.4 30566.5 30583.8 30607.5 4831.4 4874.1 4903.2 4910.0 4988.3 226169.0 229066.0 231232.0 232470.0 232487.0 47630.5 49062.0 49361.8 49779.8 49813.3 50468.2 50524.7 50600.0 50617.0 50683.2 14222.6 14269.7 14289.0 14360.4 14445.3 11676.6 11744.6 11772.1 11787.8 11864.1 13720.6 13740.1 13753.2 13884.3 13981.4 5493.7 5549.4 5581.6 5632.2 5684.3 964.7 972.5 980.2 1000.5 1012.1 22203.3 22269.6 22270.1 22399.9 22401.8 1048.2 1058.7 1077.4 1091.9 1099.9 11712.1 11755.6 11778.6 11843.3 11930.5 223998.0 225203.0 225668.0 225934.0 227441.0 51112.2 51530.2 51805.0 52847.7 56691.4 1459.3 1485.5 1493.4 1494.6 1496.7 26039.1 27161.7 27226.7 27479.6 27564.9 37893.2 38228.2 38285.4 38297.6 38300.0 211056.0 212588.0 213241.0 213820.0 214019.0 34667.7 34707.8 35258.8 35666.5 35776.6 43593.8 43646.3 43692.8 44160.3 47365.8 33745.0 34316.3 35408.3 35788.1 36188.6 34377.0 34796.5 35679.5 35681.3 35795.5 38761.2 39898.6 40291.8 40389.8 40434.8 33756.7 34522.8 34858.5 35176.0 35591.5 24768.8 24816.5 24946.4 25010.0 26018.0 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | [#2] jquery.html Cycles:180 Average:35229.98 Median:23850.46 stddev:83355.35 (349.5%) stddev-sans-first:83548.58 09:19:14 INFO - PID 29714 | Values: 579.0 580.8 585.1 588.7 604.4 22155.0 22500.8 23125.2 23156.2 23183.1 26610.2 27106.3 27159.0 27166.7 27212.0 6498.9 6655.5 6666.1 6671.5 6677.4 5954.1 6557.4 6613.5 6617.9 6620.9 6482.7 6510.4 6513.9 6524.2 6527.3 6513.2 6518.3 6525.1 6526.7 6531.1 6021.1 6022.8 6075.3 6086.6 6093.0 28553.3 29354.1 29830.5 29937.9 31203.8 1948.1 1998.3 2002.8 2003.0 2003.9 18918.4 19394.2 19410.6 19526.3 19650.5 2306.0 2344.1 2400.4 2417.7 2418.5 128043.0 135787.0 135918.6 136836.0 136984.0 14376.6 15287.4 15445.8 15479.0 15987.1 23532.2 23632.0 23769.4 23817.3 23964.2 9878.6 10063.1 10077.9 10083.7 10133.0 9102.4 9220.5 9241.9 9321.2 9405.4 8961.9 9061.8 9388.5 9773.4 9802.4 2906.3 2916.2 2938.3 2938.9 2989.2 946.5 947.8 985.2 986.8 994.1 23801.3 25103.0 25449.4 25504.0 25525.9 1033.1 1041.1 1045.8 1075.6 1079.9 11128.3 11172.8 11206.8 11488.6 11719.9 485177.0 490987.0 492723.0 504837.0 509533.0 113709.0 113789.0 114026.4 114281.0 114771.0 1203.2 1288.1 1302.3 1304.7 1317.4 20083.3 20832.7 21418.5 21805.1 22002.3 58460.7 58910.0 59727.7 60059.7 60761.4 66320.0 66834.3 66915.0 67610.0 67906.3 15050.3 15100.6 15377.2 15483.6 15501.2 23883.6 23994.8 24047.0 24205.8 24416.0 19002.8 19079.1 19173.6 19192.8 19242.2 15133.9 15316.9 15495.0 17503.4 17741.2 18602.8 19174.0 20165.8 20259.8 20361.4 14802.3 15004.2 15058.5 15070.6 15088.8 17899.6 18404.9 18905.4 19234.1 19285.3 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | [#3] mootools.html Cycles:180 Average:8540.83 Median:2592.68 stddev:5845.54 (225.5%) stddev-sans-first:5836.86 09:19:14 INFO - PID 29714 | Values: 1335.0 1371.2 1383.8 1383.9 1391.2 13646.7 14095.6 14201.4 14244.5 14256.4 14302.1 14652.3 14655.6 14669.3 14689.0 2511.1 2627.0 2690.2 2691.0 2692.0 2611.3 2662.7 2664.2 2664.2 2665.6 2594.8 2625.7 2635.7 2678.1 2683.5 2486.6 2555.8 2565.7 2590.5 2618.6 2548.0 2553.9 2595.6 2607.7 2623.4 13784.5 13854.4 13881.7 13935.2 13948.5 7507.2 7731.5 7787.8 7808.7 7809.7 4971.7 5070.3 5162.1 5224.3 5243.4 1919.7 1920.4 1955.7 1974.4 1998.2 22545.2 22785.7 22886.0 23016.5 23038.2 6364.2 6369.8 6593.2 6659.2 6660.4 15462.1 15652.3 15661.1 15665.4 15668.1 7325.2 7627.8 7629.5 7644.2 7650.9 5550.3 6344.3 7110.0 7172.0 7199.0 4898.8 5026.1 5027.9 5084.7 5111.5 1408.0 1429.8 1452.2 1459.7 1466.6 851.3 867.9 876.8 905.9 921.9 6961.3 7104.0 7236.7 7289.9 7312.8 666.0 697.4 709.8 715.1 731.2 4263.6 4649.8 4740.6 4748.9 4925.8 17843.2 18759.7 19192.9 19197.5 19242.8 18925.3 18930.7 19002.4 19046.2 19094.5 9085.0 10302.2 10380.3 10528.7 10560.2 7500.8 7998.8 8019.7 8165.1 8253.9 15911.8 16118.3 16182.7 16369.8 16559.6 16347.8 16691.2 16927.5 16939.7 16972.5 10098.9 10200.3 10202.6 10209.9 10283.0 12674.8 12763.7 12796.9 12817.7 12823.3 10191.4 10674.6 10759.3 10814.7 11015.1 10049.5 10315.9 10333.2 10747.0 10815.9 9297.4 9308.7 9424.2 9481.5 9494.8 6721.9 6904.0 7114.1 7144.7 7219.9 6527.4 6857.3 7001.2 7061.5 7119.1 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | [#4] prototype.html Cycles:180 Average:5457.45 Median:6091.85 stddev:1536.80 (25.2%) stddev-sans-first:1495.06 09:19:14 INFO - PID 29714 | Values: 482.9 490.7 525.1 528.3 529.3 6143.5 6232.5 6258.3 6260.5 6268.7 5912.8 6042.4 6056.7 6096.3 6157.5 4906.6 4908.3 4941.4 4983.5 5004.8 4802.6 4874.4 4968.3 4969.9 4981.8 4886.9 4900.4 4915.6 4920.7 4942.3 4877.1 4930.2 4932.4 4934.4 4941.5 4418.6 4437.1 4444.1 4454.4 4454.4 6074.2 6089.8 6093.9 6094.5 6100.2 5599.4 5636.1 5653.7 5658.2 5698.6 6364.0 6370.8 6387.6 6410.4 6439.5 4772.1 4789.7 4790.0 4818.9 4825.5 6693.5 6789.2 6814.8 6847.5 6899.6 4873.3 4908.8 4945.8 4955.3 4966.8 5062.7 5068.4 5076.9 5082.8 5106.2 5590.0 5604.6 5631.2 5660.5 5709.9 6335.8 6449.9 6484.0 6503.6 6523.7 1661.2 1693.7 1699.4 1706.7 1730.7 1040.7 1190.4 1207.6 1209.2 1223.3 5568.5 5644.3 5680.7 5716.1 5727.1 6603.3 6673.5 6675.5 6717.9 6718.6 5752.3 5771.2 5811.7 5822.5 5823.6 3542.4 3552.2 3563.8 3590.8 3596.9 6399.1 6438.8 6440.3 6456.3 6576.0 6615.3 6880.2 6893.9 6911.2 6933.3 6352.2 6380.5 6443.9 6448.8 6449.1 6627.4 6635.7 6718.2 6730.5 6738.1 6494.3 6671.4 6672.6 6673.3 6690.2 6447.7 6456.6 6462.8 6470.2 6502.1 4857.0 4885.9 4889.7 4892.6 4957.5 6608.5 6633.2 6670.5 6685.9 6693.6 6406.9 6466.5 6469.5 6498.8 6560.9 6496.9 6512.2 6531.3 6538.6 6552.6 6326.0 6389.5 6392.0 6408.0 6519.2 6330.5 6417.6 6424.3 6528.3 6546.3 5712.4 6200.7 6211.9 6281.0 6349.8 09:19:14 INFO - PID 29714 | 09:19:14 INFO - PID 29714 | [#5] yui.html Cycles:180 Average:23163.52 Median:19276.83 stddev:30944.98 (160.5%) stddev-sans-first:30986.64 09:19:14 INFO - PID 29714 | Values: 901.5 921.6 930.3 932.7 937.2 17686.8 18278.0 18413.0 18438.6 20487.1 16082.6 16123.5 19804.1 21595.9 21616.0 1045.6 1075.2 1077.2 1079.4 1079.9 1010.2 1063.4 1069.8 1083.6 1083.8 1100.1 1111.2 1112.7 1113.7 1113.7 1100.6 1101.1 1102.7 1104.9 1112.0 804.7 808.8 810.3 811.5 811.8 18429.7 18478.4 18700.8 18742.7 19918.4 20426.7 20517.3 20882.9 20915.1 20944.0 16212.8 16591.8 16789.7 16793.7 16802.2 3588.7 3605.2 3613.7 3617.6 3619.7 122341.0 123814.0 128120.4 129377.7 131271.0 15282.5 15474.1 15904.7 15951.9 16077.4 28958.1 30641.5 30727.0 30789.4 30808.5 8355.7 8554.3 8585.8 8604.1 8623.0 4041.5 4142.7 4145.7 4172.8 4175.9 4923.2 5140.5 5164.8 5165.4 5184.4 1032.3 1047.5 1052.3 1068.7 1071.4 615.3 639.4 657.0 674.8 687.6 11318.5 12909.9 13497.3 13755.4 13936.4 657.9 687.3 709.3 710.0 722.0 5164.6 5359.2 5361.4 5408.2 5673.5 96675.5 99730.5 102641.5 103161.0 105501.1 86118.6 91491.0 92890.5 93425.0 94743.0 79940.0 81810.0 82568.6 83148.6 84337.0 11876.9 12930.5 12951.7 13047.6 13088.1 36906.3 37837.6 38346.0 38605.2 39087.6 66741.3 67812.7 70211.0 70384.3 72645.0 18044.5 18263.5 18543.7 18578.9 18866.6 20258.2 20414.7 20500.1 20585.0 20712.9 16783.4 17029.3 17164.0 17280.1 17286.7 18663.9 18833.7 19033.8 19122.1 19212.3 19009.5 19074.9 19078.8 19341.3 19475.0 13070.2 13608.9 14170.9 14400.7 14486.9 13961.2 13990.5 14067.9 14235.3 14565.7 09:19:14 INFO - PID 29714 | -------- Summary: end -------- 09:19:14 INFO - PID 29714 | 09:19:15 INFO - TEST-INFO | 29714: exit 0 09:19:15 INFO - TEST-OK | dromaeo_css | took 1111965ms 09:19:15 INFO - TEST-START | kraken 09:19:15 INFO - Initialising browser for kraken test... 09:19:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41822/getInfo.html -profile /tmp/tmpmLrZz7/profile 09:19:15 INFO - TEST-INFO | started process 30075 (/builds/slave/test/build/application/firefox/firefox http://localhost:41822/getInfo.html) 09:19:21 INFO - TEST-INFO | 30075: exit 0 09:19:21 INFO - Browser initialized. 09:19:21 INFO - Running cycle 1/1 for kraken test... 09:19:21 INFO - TEST-INFO | started process 30285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmLrZz7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:32 INFO - PID 30285 | RSS: Main: 170954752 09:19:32 INFO - PID 30285 | 09:19:35 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41822/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:36 INFO - PID 30285 | RSS: Main: 177184768 09:19:36 INFO - PID 30285 | 09:19:38 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41822/tests/kraken/driver.html?testName=audio-dft) 09:19:39 INFO - PID 30285 | RSS: Main: 177594368 09:19:39 INFO - PID 30285 | 09:19:42 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41822/tests/kraken/driver.html?testName=audio-fft) 09:19:43 INFO - PID 30285 | RSS: Main: 171347968 09:19:43 INFO - PID 30285 | 09:19:45 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41822/tests/kraken/driver.html?testName=audio-oscillator) 09:19:45 INFO - PID 30285 | RSS: Main: 172576768 09:19:45 INFO - PID 30285 | 09:19:48 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:48 INFO - PID 30285 | RSS: Main: 172257280 09:19:48 INFO - PID 30285 | 09:19:51 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41822/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:52 INFO - PID 30285 | RSS: Main: 175120384 09:19:52 INFO - PID 30285 | 09:19:55 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41822/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:56 INFO - PID 30285 | RSS: Main: 175144960 09:19:56 INFO - PID 30285 | 09:19:59 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41822/tests/kraken/driver.html?testName=json-parse-financial) 09:19:59 INFO - PID 30285 | RSS: Main: 175624192 09:19:59 INFO - PID 30285 | 09:20:01 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:20:02 INFO - PID 30285 | RSS: Main: 175767552 09:20:02 INFO - PID 30285 | 09:20:03 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:20:04 INFO - PID 30285 | RSS: Main: 175951872 09:20:04 INFO - PID 30285 | 09:20:06 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:07 INFO - PID 30285 | RSS: Main: 176046080 09:20:07 INFO - PID 30285 | 09:20:10 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:10 INFO - PID 30285 | RSS: Main: 175833088 09:20:10 INFO - PID 30285 | 09:20:13 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:20:14 INFO - PID 30285 | RSS: Main: 175874048 09:20:14 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | Cycle 1(1): loaded http://localhost:41822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41822/tests/kraken/driver.html?testName=ai-astar) 09:20:16 INFO - PID 30285 | RSS: Main: 177737728 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | __start_tp_report 09:20:16 INFO - PID 30285 | _x_x_mozilla_page_load 09:20:16 INFO - PID 30285 | _x_x_mozilla_page_load_details 09:20:16 INFO - PID 30285 | |i|pagename|runs| 09:20:16 INFO - PID 30285 | |0;ai-astar;99;111;101;109;111;113;110;101;109;109 09:20:16 INFO - PID 30285 | |1;audio-beat-detection;149;117;148;176;120;146;149;121;172;119 09:20:16 INFO - PID 30285 | |2;audio-dft;163;165;162;162;163;162;167;165;167;163 09:20:16 INFO - PID 30285 | |3;audio-fft;74;77;75;164;75;74;75;92;96;74 09:20:16 INFO - PID 30285 | |4;audio-oscillator;82;82;136;81;80;81;128;81;81;130 09:20:16 INFO - PID 30285 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;114 09:20:16 INFO - PID 30285 | |6;imaging-darkroom;151;151;151;152;151;150;151;149;151;150 09:20:16 INFO - PID 30285 | |7;imaging-desaturate;95;94;95;94;94;96;94;94;94;93 09:20:16 INFO - PID 30285 | |8;json-parse-financial;56;69;56;56;55;55;57;56;56;56 09:20:16 INFO - PID 30285 | |9;json-stringify-tinderbox;54;54;55;55;54;54;54;55;55;54 09:20:16 INFO - PID 30285 | |10;stanford-crypto-aes;77;86;77;78;77;78;78;87;77;80 09:20:16 INFO - PID 30285 | |11;stanford-crypto-ccm;135;127;126;127;133;125;134;124;123;173 09:20:16 INFO - PID 30285 | |12;stanford-crypto-pbkdf2;181;184;175;182;183;196;190;175;177;177 09:20:16 INFO - PID 30285 | |13;stanford-crypto-sha256-iterative;68;71;66;68;66;68;70;68;67;67 09:20:16 INFO - PID 30285 | __end_tp_report 09:20:16 INFO - PID 30285 | __start_cc_report 09:20:16 INFO - PID 30285 | _x_x_mozilla_cycle_collect,1002 09:20:16 INFO - PID 30285 | __end_cc_report 09:20:16 INFO - PID 30285 | __startTimestamp1500913216591__endTimestamp 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | ------- Summary: start ------- 09:20:16 INFO - PID 30285 | Number of tests: 14 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#0] ai-astar Cycles:10 Average:107.30 Median:110.50 stddev:4.99 (4.5%) stddev-sans-first:4.29 09:20:16 INFO - PID 30285 | Values: 99.0 111.0 101.0 109.0 111.0 113.0 110.0 101.0 109.0 109.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:148.50 stddev:21.82 (14.7%) stddev-sans-first:22.98 09:20:16 INFO - PID 30285 | Values: 149.0 117.0 148.0 176.0 120.0 146.0 149.0 121.0 172.0 119.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.97 (1.2%) stddev-sans-first:2.06 09:20:16 INFO - PID 30285 | Values: 163.0 165.0 162.0 162.0 163.0 162.0 167.0 165.0 167.0 163.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.00 stddev:28.03 (37.4%) stddev-sans-first:29.29 09:20:16 INFO - PID 30285 | Values: 74.0 77.0 75.0 164.0 75.0 74.0 75.0 92.0 96.0 74.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:81.00 stddev:24.33 (30.0%) stddev-sans-first:25.26 09:20:16 INFO - PID 30285 | Values: 82.0 82.0 136.0 81.0 80.0 81.0 128.0 81.0 81.0 130.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:20:16 INFO - PID 30285 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:20:16 INFO - PID 30285 | Values: 151.0 151.0 151.0 152.0 151.0 150.0 151.0 149.0 151.0 150.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 09:20:16 INFO - PID 30285 | Values: 95.0 94.0 95.0 94.0 94.0 96.0 94.0 94.0 94.0 93.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:4.18 (7.5%) stddev-sans-first:4.42 09:20:16 INFO - PID 30285 | Values: 56.0 69.0 56.0 56.0 55.0 55.0 57.0 56.0 56.0 56.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:20:16 INFO - PID 30285 | Values: 54.0 54.0 55.0 55.0 54.0 54.0 54.0 55.0 55.0 54.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.00 stddev:3.81 (4.9%) stddev-sans-first:3.93 09:20:16 INFO - PID 30285 | Values: 77.0 86.0 77.0 78.0 77.0 78.0 78.0 87.0 77.0 80.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:130.00 stddev:14.80 (11.4%) stddev-sans-first:15.67 09:20:16 INFO - PID 30285 | Values: 135.0 127.0 126.0 127.0 133.0 125.0 134.0 124.0 123.0 173.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:182.50 stddev:6.78 (3.7%) stddev-sans-first:7.18 09:20:16 INFO - PID 30285 | Values: 181.0 184.0 175.0 182.0 183.0 196.0 190.0 175.0 177.0 177.0 09:20:16 INFO - PID 30285 | 09:20:16 INFO - PID 30285 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.69 09:20:16 INFO - PID 30285 | Values: 68.0 71.0 66.0 68.0 66.0 68.0 70.0 68.0 67.0 67.0 09:20:16 INFO - PID 30285 | -------- Summary: end -------- 09:20:16 INFO - PID 30285 | 09:20:17 INFO - PID 30285 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:20:17 INFO - TEST-INFO | 30285: exit 0 09:20:17 INFO - TEST-OK | kraken | took 61880ms 09:20:17 INFO - SUITE-END | took 1173s 09:20:17 INFO - Completed test suite (00:19:34) 09:20:17 INFO - javascript benchmark 09:20:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8411.683690757165, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.767442441816, 3117.4388610050187, 3135.9059228223155, 3140.842957852107, 3181.236503239223, 5975.611585246961, 6066.120412540179, 6096.2074930259005, 6130.846728831776, 6142.631442113471, 5972.19375384323, 6073.392660733935, 6079.544034197431, 6083.391660833914, 6098.17674613927, 5505.201745746865, 5510.614257002001, 5544.91682624759, 5607.635503692268, 5623.128415095646, 5528.115501519757, 5616.269884914956, 5625.353084395286, 5649.6327738697055, 5673.943260567404, 5358.410574836765, 5493.890122197574, 5510.834674959718, 5606.915896261559, 5611.579131565108, 5494.862628434281, 5507.476789704971, 5574.275344205268, 5582.637128586629, 5596.804111856066, 5415.160650099241, 5481.451854814526, 5539.556835453154, 5541.307336582927, 5543.473370029841, 5931.851703707399, 5945.851353716192, 5976.103584462322, 6000.699965001732, 6014.097885317194, 6441.516886233551, 6455.903161452582, 6506.902396464056, 6545.509086818508, 6552.0, 6321.178246827929, 6466.805995820133, 6604.900926486107, 6604.93395066048, 6617.834554136185, 6055.545834062463, 6069.787557435468, 6124.969375153185, 6153.569250152446, 6159.630422174684, 6597.076409302702, 6624.238212605515, 6706.128203333536, 6710.127683401127, 6714.697838597275, 6303.590266632654, 6307.180066591313, 6376.56527281358, 6393.0, 6418.1656384669695, 6364.7135878885565, 6389.424951754364, 6478.838029049217, 6479.125318082093, 6494.415502604788, 6398.456131228804, 6460.676966151674, 6477.870442591122, 6521.217453905561, 6554.606723596599, 6485.70814313357, 6519.445847102955, 6569.770058047945, 6602.7028783704845, 6620.437262832616, 5261.421243663194, 5304.92042619361, 5345.305110335709, 5345.705986170798, 5355.0360935031285, 4548.818047278138, 4569.680122391467, 4584.701994370355, 4612.561806628365, 4650.837220697259, 5732.742026608813, 5770.42295770428, 5794.101914203306, 5796.710164491758, 5800.1589769484035, 6522.380373864476, 6556.541042127005, 6575.967120164369, 6628.602283862983, 6654.0, 5575.693336866511, 5596.524295434933, 5646.915296270559, 5672.376038635747, 5682.289713785777, 5764.337101233412, 5765.221695071195, 5793.420657934173, 5806.390329015477, 5832.679202643895, 6238.064290356483, 6254.593451425734, 6363.140975968277, 6376.33048529907, 6386.521010924199, 6312.084747711648, 6439.388258115471, 6456.192975878015, 6464.741410343534, 6566.343365663395, 6266.686665666607, 6271.717772700148, 6368.745250189941, 6391.137196478602, 6393.424591786761, 6345.016522438845, 6397.808065758035, 6470.352964703492, 6492.480601551959, 6496.0255961606135, 6495.447886929475, 6496.0, 6566.4418524424045, 6591.6045037296, 6638.5684930479365, 6252.5935814171935, 6331.240251169889, 6337.8732425352155, 6360.809175724736, 6369.617822930639, 6326.493880489642, 6333.493320534439, 6391.073294372383, 6402.711877965409, 6406.5515413920575, 6245.437910588069, 6261.655608941552, 6363.3636636336, 6372.0, 6385.45723613498, 6173.969130154321, 6372.840678983062, 6511.576747511396, 6511.902321465087, 6518.250401203923, 6153.169322141633, 6191.19514463135, 6206.049561238416, 6273.341299163522, 6280.654563999024], "value": 5953.668955888795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.4205109244704, 811.577979450686, 817.2481317188187, 852.0457088061372, 853.4239388412824, 40189.19621607566, 41112.38331425027, 41121.79439102804, 41153.58846411535, 41213.793931030305, 36764.63235367652, 36979.260414791686, 37141.25717485649, 37151.0, 37249.44125838114, 6572.80281591553, 6687.130673012502, 6689.197296324423, 6692.063111164441, 6692.899606505906, 6567.211934567858, 6673.399394054534, 6685.0640910272605, 6685.899711504307, 6690.297518760533, 6624.93375066248, 6656.068150458916, 7311.8537629247385, 7520.135184453776, 7532.133804612485, 7444.478886477948, 7482.700691972314, 7490.887636685454, 7495.625218739041, 7495.66269517873, 7394.445416593777, 7447.329740323397, 7472.887906681404, 7475.813104672427, 7477.0, 37152.25695486102, 37253.0, 37530.0, 37552.62447375518, 37583.06042348936, 3365.478350855621, 3408.829558522064, 3414.197663549064, 3419.196488825124, 3419.2990436960363, 30531.0, 30566.388672226654, 30566.54150187749, 30583.847080764677, 30607.540886886716, 4831.444383895861, 4874.122657921573, 4903.19097348937, 4909.950900490985, 4988.276699878497, 226169.0, 229066.0, 231232.0, 232470.0, 232487.0, 47630.5236947633, 49062.0, 49361.75319123453, 49779.75110124426, 49813.25280120801, 50468.24297635538, 50524.74737626362, 50600.0, 50617.0, 50683.23975140376, 14222.644433889236, 14269.714605707828, 14289.0, 14360.353784079742, 14445.277736113152, 11676.649700508999, 11744.647660570197, 11772.058235341152, 11787.823182652268, 11864.050875929905, 13720.588382348546, 13740.10689305192, 13753.243571603458, 13884.305784710725, 13981.440742370394, 5493.670379777226, 5549.445055494418, 5581.637193582485, 5632.239647647597, 5684.261046063985, 964.6575465709712, 972.5088830140734, 980.2305190425482, 1000.5447521377756, 1012.1396812709138, 22203.333899983027, 22269.554608907732, 22270.109195631994, 22399.880005999636, 22401.775982239968, 1048.1928914735763, 1058.7194393485731, 1077.4020418667715, 1091.8635170603675, 1099.9010089092021, 11712.063034957184, 11755.588554400554, 11778.646640600795, 11843.28940263587, 11930.463129159036, 223998.0, 225203.0, 225668.0, 225934.0, 227441.0, 51112.233316500286, 51530.22704659433, 51805.0, 52847.73576132172, 56691.433085668614, 1459.2630721485582, 1485.524632117712, 1493.4101030093052, 1494.6114010357169, 1496.738070837599, 26039.088631897794, 27161.72838271592, 27226.72773272242, 27479.587806183325, 27564.86217568899, 37893.24213515769, 38228.23543529058, 38285.4257186148, 38297.61702383052, 38300.0, 211056.0, 212588.0, 213241.0, 213820.0, 214019.0, 34667.653323466446, 34707.82646086753, 35258.8237058813, 35666.46500302446, 35776.64223357837, 43593.78203108964, 43646.34530481982, 43692.78153609339, 44160.33759493675, 47365.7631711853, 33745.0, 34316.31367372689, 35408.29183416369, 35788.10529736777, 36188.63811361853, 34377.0, 34796.47805282872, 35679.464808027384, 35681.28637427289, 35795.46306805452, 38761.224775504896, 39898.601013989486, 40291.798541007105, 40389.79805100956, 40434.786956391355, 33756.66243337633, 34522.82738586291, 34858.47712284369, 35176.0, 35591.46612800862, 24768.752312476645, 24816.50366992686, 24946.37634059163, 25010.0, 26018.0], "value": 17076.21448243685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9768409263628, 580.8460757899155, 585.104789671802, 588.7468388592903, 604.4408921747385, 22155.0, 22500.774992250073, 23125.19061832834, 23156.189533366316, 23183.072677092896, 26610.201693949162, 27106.32234194146, 27159.0, 27166.728332716717, 27212.0, 6498.935010649904, 6655.500837437187, 6666.133402657648, 6671.532992690513, 6677.399034086931, 5954.07711804671, 6557.409833115019, 6613.537052406309, 6617.933820661804, 6620.933790662104, 6482.708278127472, 6510.446612037958, 6513.934860651404, 6524.184476940382, 6527.347265273482, 6513.185851768529, 6518.315576864408, 6525.119108920307, 6526.738930442777, 6531.0856480092825, 6021.126936594169, 6022.8494287642725, 6075.33171351151, 6086.573939824214, 6093.0, 28553.286167845763, 29354.11937641874, 29830.508474576185, 29937.85031074831, 31203.843980780177, 1948.0844003318418, 1998.270631219609, 2002.779694233633, 2002.959940801176, 2003.8797672139717, 18918.432447026473, 19394.22423103074, 19410.611787764166, 19526.31657891981, 19650.50873728154, 2305.953880922389, 2344.120954642009, 2400.387901085212, 2417.697787776528, 2418.504206637635, 128043.0, 135787.0, 135918.6408135916, 136836.0, 136984.0, 14376.568702938928, 15287.388504459697, 15445.84554154444, 15479.0, 15987.120708360919, 23532.176373826835, 23632.0, 23769.405764856016, 23817.285481435585, 23964.24411192735, 9878.555465004092, 10063.144632706155, 10077.899221007696, 10083.747906302402, 10133.0, 9102.408343457653, 9220.53897305132, 9241.907580924239, 9321.207697345666, 9405.43567385959, 8961.910380896237, 9061.77345566366, 9388.483633400228, 9773.364731292444, 9802.411855288705, 2906.2734316420897, 2916.1543152485965, 2938.3241854373614, 2938.9265268368463, 2989.1630343503853, 946.5409276500892, 947.8199142162968, 985.1773768902902, 986.7582442301682, 994.0854413939048, 23801.285961421185, 25103.0, 25449.36376590563, 25504.0, 25525.87237063803, 1033.106362996003, 1041.1046500009986, 1045.8483519889573, 1075.6396607136696, 1079.9298045627008, 11128.276662016942, 11172.832407513893, 11206.831897521544, 11488.597899073493, 11719.882801172049, 485177.0, 490987.0, 492723.0, 504837.0, 509533.0, 113709.0, 113789.0, 114026.42986785014, 114281.0, 114771.0, 1203.18784820246, 1288.1240756285629, 1302.2772361339357, 1304.7455746129413, 1317.440087962612, 20083.297084601967, 20832.687509687064, 21418.464538386666, 21805.127794888027, 22002.339929802132, 58460.70769646124, 58910.0, 59727.70136149292, 60059.69970150296, 60761.392386075575, 66320.0, 66834.33165668475, 66915.0, 67610.0, 67906.32093679198, 15050.322735476711, 15100.622484437537, 15377.154256516, 15483.612909677347, 15501.224938752792, 23883.641745373487, 23994.76005239995, 24047.0, 24205.75794242035, 24416.0, 19002.809971900657, 19079.14143863502, 19173.61652766965, 19192.808071919102, 19242.23031078797, 15133.924330378277, 15316.923415383297, 15495.0, 17503.3873814421, 17741.201645925707, 18602.81397186011, 19174.0, 20165.79834201639, 20259.79740202638, 20361.389158325273, 14802.259887005392, 15004.249787510798, 15058.472953446577, 15070.623234419227, 15088.773668394764, 17899.642007159524, 18404.907975460035, 18905.432837014912, 19234.134463949435, 19285.325013625017], "value": 12271.362481421542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.9733005339892, 1371.2389623758809, 1383.8131852199956, 1383.9446422143114, 1391.1513976474355, 13646.727065458685, 14095.577132686036, 14201.360938757742, 14244.501442449517, 14256.429742810275, 14302.141871487693, 14652.267386630652, 14655.633609159777, 14669.339879705412, 14689.0, 2511.0960054380407, 2626.9605955910724, 2690.1526019303956, 2690.9730902690917, 2692.044324264887, 2611.2949503634104, 2662.6804783426014, 2664.200739778059, 2664.2273740615196, 2665.626812246287, 2594.844309341436, 2625.7374262573685, 2635.6573645426165, 2678.1429942418436, 2683.4633073385303, 2486.5772818620876, 2555.833870798392, 2565.6921169459783, 2590.507803517335, 2618.5941179117267, 2548.031747935791, 2553.8978440862343, 2595.5976823592187, 2607.6870775506873, 2623.4490756941063, 13784.517541885985, 13854.376553055137, 13881.722365552632, 13935.233562154077, 13948.511802086878, 7507.249275072503, 7731.497452665559, 7787.766367008999, 7808.687652493893, 7809.726659566944, 4971.701697898137, 5070.31550740649, 5162.070827251093, 5224.268602395668, 5243.370795504526, 1919.673655478572, 1920.4046745508938, 1955.6675365187953, 1974.3682021753045, 1998.2007197121268, 22545.210917617806, 22785.658215126787, 22886.0, 23016.539669206522, 23038.193663221708, 6364.204474440695, 6369.808905732835, 6593.175853018372, 6659.200895892427, 6660.433863121689, 15462.072275663497, 15652.295646695926, 15661.138637374826, 15665.373385064699, 15668.138252396227, 7325.194228634846, 7627.809304767315, 7629.54222746637, 7644.159142494321, 7650.885236721454, 5550.333959924835, 6344.302126766052, 7109.964450177819, 7171.995920571124, 7198.964005179941, 4898.828541001048, 5026.095302845523, 5027.874303142451, 5084.669496482791, 5111.463296353903, 1408.0495665425797, 1429.7640889253364, 1452.2158034661165, 1459.7080583883267, 1466.6113479927828, 851.3402113362193, 867.9175478329548, 876.7588913048962, 905.8731777551149, 921.8985911549725, 6961.338672826073, 7104.0, 7236.710531578783, 7289.854202915912, 7312.780616581511, 665.9700313485807, 697.3758486154863, 709.7764204275637, 715.1454012455171, 731.2102928836844, 4263.552327005682, 4649.767511624405, 4740.597049250852, 4748.857534273978, 4925.7783399747095, 17843.197056132507, 18759.718604220947, 19192.904035479733, 19197.520061998282, 19242.807571924383, 18925.337613183474, 18930.716039259423, 19002.42992710221, 19046.238150473826, 19094.522636934187, 9084.954575227082, 10302.22733294991, 10380.273380863267, 10528.736781580521, 10560.155187584975, 7500.812479688051, 7998.800029999296, 8019.679212831655, 8165.101838797608, 8253.917460825314, 15911.761323579924, 16118.274677639769, 16182.67634647324, 16369.836301637308, 16559.586010349354, 16347.754783678016, 16691.165441728106, 16927.49217523476, 16939.661206776043, 16972.49082527526, 10098.94950525272, 10200.285979981627, 10202.59189632436, 10209.9489502552, 10283.0, 12674.809877852023, 12763.680907977376, 12796.936015319863, 12817.743645127232, 12823.294718790556, 10191.388516689023, 10674.57301707923, 10759.30064545802, 10814.729631759268, 11015.063719583604, 10049.497525123861, 10315.896841031494, 10333.173346132142, 10747.0, 10815.891841081488, 9297.442153470813, 9308.720738377859, 9424.151826335663, 9481.52592370365, 9494.762630934281, 6721.93278067213, 6903.965480172567, 7114.110736157981, 7144.749933752501, 7219.891701624375, 6527.379898909596, 6857.314268573302, 7001.159860816734, 7061.540999834994, 7119.1457025157315], "value": 6208.070474407078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.9154897892869, 490.7251938914206, 525.070624993761, 528.300002496692, 529.2960362717586, 6143.477804386627, 6232.532560057997, 6258.311585725566, 6260.499160067189, 6268.65522396268, 5912.822615321536, 6042.425969532898, 6056.697165141747, 6096.298925623554, 6157.538184636148, 4906.607471402279, 4908.263760435945, 4941.431735350427, 4983.501649835006, 5004.799808007684, 4802.615790736732, 4874.390701162355, 4968.254761785743, 4969.900601987958, 4981.775820088086, 4886.853394398174, 4900.411950565937, 4915.6313276504225, 4920.729359885205, 4942.258661200813, 4877.122118018755, 4930.161872481669, 4932.408111026664, 4934.40787105546, 4941.48114447985, 4418.630224630343, 4437.112577484484, 4444.11117776446, 4454.37638730578, 4454.398656181439, 6074.179985701918, 6089.786857459968, 6093.908591371133, 6094.512439004869, 6100.176476175749, 5599.440055994409, 5636.098224284095, 5653.717314134276, 5658.207850900877, 5698.601097923147, 6363.96818015907, 6370.840728981766, 6387.616742995435, 6410.358964103552, 6439.5170362223025, 4772.117158325686, 4789.712617242976, 4789.976050119762, 4818.879528011793, 4825.455854126681, 6693.497987650897, 6789.15135608049, 6814.829629259259, 6847.452203823732, 6899.551094270159, 4873.26900964851, 4908.754562271872, 4945.7527123644395, 4955.306257124005, 4966.827864593759, 5062.670926389773, 5068.391792984792, 5076.923846142311, 5082.796688132434, 5106.183010718341, 5590.0, 5604.551635869121, 5631.239782629293, 5660.518855897295, 5709.885802283931, 6335.778247761306, 6449.871272527289, 6484.0, 6503.577267477599, 6523.739050438025, 1661.1528120658309, 1693.6697344017798, 1699.37972639988, 1706.67573161099, 1730.6884760742935, 1040.6669865643073, 1190.3928996211994, 1207.5773479282182, 1209.2140108929266, 1223.2721530689225, 5568.522007706531, 5644.266245388156, 5680.68756218412, 5716.142578613159, 5727.05503591911, 6603.273639899608, 6673.499487538454, 6675.532712710064, 6717.932820671828, 6718.5890962897365, 5752.28096487939, 5771.163181338682, 5811.709414529257, 5822.505087067647, 5823.563232757476, 3542.3623747725655, 3552.236269202134, 3563.821808909544, 3590.797082977232, 3596.8561257549927, 6399.136656141366, 6438.8390290243115, 6440.291567927524, 6456.288358889277, 6576.0, 6615.338466153346, 6880.174379074543, 6893.862122757517, 6911.2397636259975, 6933.2720064393525, 6352.174217351807, 6380.489560835122, 6443.871122577616, 6448.807405482158, 6449.097126402307, 6627.403533681992, 6635.701393437404, 6718.186089755836, 6730.528862979544, 6738.058235932034, 6494.318096599789, 6671.39957403836, 6672.566283191772, 6673.332666733482, 6690.19717633887, 6447.742090316522, 6456.644884531396, 6462.773802916875, 6470.158879345655, 6502.139058814107, 4856.955754512796, 4885.87785305356, 4889.682170658896, 4892.559669629751, 4957.504249575014, 6608.471322294301, 6633.170853643294, 6670.466362691071, 6685.896827023486, 6693.564918280296, 6406.90389644165, 6466.515011374072, 6469.547131700924, 6498.805035848932, 6560.901586476111, 6496.895527760386, 6512.153420055362, 6531.281559028598, 6538.607683539003, 6552.6068435894, 6326.0, 6389.48884089281, 6391.96804015977, 6408.0, 6519.217693876765, 6330.52521060913, 6417.647029413427, 6424.2933277338525, 6528.347165283433, 6546.312637173029, 5712.371639119777, 6200.720967556381, 6211.937880621317, 6281.0, 6349.809505714836], "value": 5002.290852443298, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.5312037740371, 921.6129225725194, 930.2557953637089, 932.7015355086376, 937.1893312284874, 17686.823131768677, 18278.0, 18412.9872856993, 18438.631227375445, 20487.078081486332, 16082.552570268674, 16123.516294511153, 19804.09688263297, 21595.892020539915, 21616.027278772453, 1045.5974449836829, 1075.2097208551709, 1077.2082519348312, 1079.4225089577078, 1079.9190060745436, 1010.2019404670301, 1063.3938654966632, 1069.8288273876142, 1083.6315652678088, 1083.8265877459608, 1100.0539535999035, 1111.2054880760254, 1112.7106952192448, 1113.704868209921, 1113.7271368514726, 1100.5707773968159, 1101.1411099342527, 1102.7298311913632, 1104.8563686720674, 1111.9666410007712, 804.7304153108657, 808.8261023879835, 810.295043312322, 811.5090370325986, 811.7848770075934, 18429.723554146698, 18478.445646630622, 18700.812991870178, 18742.718859217122, 19918.402447926586, 20426.69359959602, 20517.281895133747, 20882.89558552213, 20915.058822353032, 20944.0, 16212.83787162125, 16591.751123733033, 16789.6642067158, 16793.748093778602, 16802.15989200535, 3588.6949609283242, 3605.152789094561, 3613.728970327236, 3617.5839778425557, 3619.7104231661406, 122341.0, 123814.0, 128120.35939820242, 129377.7062229375, 131271.0, 15282.465113720966, 15474.148921809183, 15904.681906361808, 15951.920240398724, 16077.35690572364, 28958.131256062352, 30641.540376893918, 30727.0, 30789.38421231563, 30808.537871931938, 8355.665773368997, 8554.315654747605, 8585.82828343442, 8604.139586041345, 8623.0, 4041.454403655469, 4142.668586513072, 4145.730527515762, 4172.8122234498915, 4175.937360939588, 4923.187674033816, 5140.511651393112, 5164.845054648366, 5165.431802501722, 5184.429712731597, 1032.256775121911, 1047.5076713944434, 1052.3265110329396, 1068.7114479090758, 1071.3518321415588, 615.2831950777295, 639.3670266436287, 657.0472814419016, 674.7570874485182, 687.5840116729406, 11318.4906679198, 12909.870901290868, 13497.257650829299, 13755.38100785467, 13936.372863221179, 657.8618490117034, 687.2749249541781, 709.2659097833717, 709.9858002840018, 722.0144502753703, 5164.561012313995, 5359.249705041298, 5361.35663720356, 5408.161734931092, 5673.517750991129, 96675.51662241784, 99730.50134749425, 102641.48679256556, 103161.0, 105501.14242574209, 86118.56940715256, 91491.0, 92890.53554732318, 93425.0, 94743.0, 79939.95401794379, 81810.0, 82568.58715706383, 83148.58425707833, 84337.0, 11876.940615296868, 12930.547430839875, 12951.676208094495, 13047.608571742863, 13088.149270297401, 36906.26187476182, 37837.62162378341, 38346.0, 38605.2278954425, 39087.6091239084, 66741.33258667546, 67812.660936695, 70211.0, 70384.29615703778, 72645.0, 18044.458666240032, 18263.45209643713, 18543.72184417208, 18578.907105464386, 18866.622667546297, 20258.18967241294, 20414.693779593614, 20500.07749651299, 20585.0, 20712.896435517727, 16783.412580559623, 17029.31882724677, 17164.0, 17280.135993200038, 17286.654266914844, 18663.906680467055, 18833.71749423787, 19033.809661903204, 19122.139503722086, 19212.327568535035, 19009.52476188051, 19074.904625476785, 19078.809211907705, 19341.323053693053, 19475.0, 13070.215787052808, 13608.86391136076, 14170.92914535462, 14400.711985760436, 14486.927565362528, 13961.232132232419, 13990.510332138327, 14067.859321406655, 14235.288235587972, 14565.708685826436], "value": 9142.704701075638, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 101.0, 109.0, 111.0, 113.0, 110.0, 101.0, 109.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 148.0, 176.0, 120.0, 146.0, 149.0, 121.0, 172.0, 119.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 162.0, 163.0, 162.0, 167.0, 165.0, 167.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 164.0, 75.0, 74.0, 75.0, 92.0, 96.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 136.0, 81.0, 80.0, 81.0, 128.0, 81.0, 81.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 152.0, 151.0, 150.0, 151.0, 149.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 96.0, 94.0, 94.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 69.0, 56.0, 56.0, 55.0, 55.0, 57.0, 56.0, 56.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 77.0, 78.0, 77.0, 78.0, 78.0, 87.0, 77.0, 80.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 126.0, 127.0, 133.0, 125.0, 134.0, 124.0, 123.0, 173.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 175.0, 182.0, 183.0, 196.0, 190.0, 175.0, 177.0, 177.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 66.0, 68.0, 66.0, 68.0, 70.0, 68.0, 67.0, 67.0], "value": 67.9, "unit": "score"}]}]} 09:20:17 INFO - Return code: 0 09:20:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:20:17 INFO - # TBPL SUCCESS # 09:20:17 INFO - Running post-action listener: _package_coverage_data 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - [mozharness: 2017-07-24 16:20:17.917461Z] Finished run-tests step (success) 09:20:17 INFO - Running post-run listener: _resource_record_post_run 09:20:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 437698560; Read time: 0; Write time: 313656 09:20:17 INFO - TinderboxPrint: CPU usage
13.1% 09:20:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:20:17 INFO - TinderboxPrint: I/O write bytes / time
437,698,560 / 313,656 09:20:17 INFO - TinderboxPrint: CPU idle
8,262.0 (86.9%) 09:20:17 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 09:20:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:20:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107388928; Read time: 0; Write time: 88960 09:20:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:20:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 330309632; Read time: 0; Write time: 224696 09:20:18 INFO - Running post-run listener: _upload_blobber_files 09:20:18 INFO - Blob upload gear active. 09:20:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:20:18 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 09:20:18 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:20:18 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:20:19 INFO - (blobuploader) - INFO - Open directory for files ... 09:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:20:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:25 INFO - (blobuploader) - INFO - Done attempting. 09:20:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:20:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:20:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:26 INFO - (blobuploader) - INFO - Done attempting. 09:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:20:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:26 INFO - (blobuploader) - INFO - Done attempting. 09:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:20:27 INFO - (blobuploader) - INFO - Done attempting. 09:20:27 INFO - (blobuploader) - INFO - Iteration through files over. 09:20:27 INFO - Return code: 0 09:20:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:20:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:20:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ccd866bc2805807aa4e7735400eb7ca64ad8f5fa8fa187eddd3bff1c10608d0c856bf4454d46cc0bde729ec4d6d59d2b4d0269308916645dcd4d86b18a48319d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/479e89d1ceb460aaf9e57df3679fcddd23844ff3eed2fcb1661c0270ddf2dd8141dd2e459d2a8815cfe42f8489d318edff69b9892a77fb40d2fb23469a66209d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8a0779262acb088f9eff6b4bbc0cdfa7049d334fe632b271075eab22fc89ac8715b0a7d1a43e05939fc18569c77771b32734d6b2de98f6e8bdad8183b756cd63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/953c9e3b494beda33113df0dae7eaf3b4306f22bdea587375999b67309f240c1d60d7649753553dcf80a538975360b11e6f055435eb851a1402f11180fa06043"} 09:20:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:20:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:20:27 INFO - Contents: 09:20:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ccd866bc2805807aa4e7735400eb7ca64ad8f5fa8fa187eddd3bff1c10608d0c856bf4454d46cc0bde729ec4d6d59d2b4d0269308916645dcd4d86b18a48319d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/479e89d1ceb460aaf9e57df3679fcddd23844ff3eed2fcb1661c0270ddf2dd8141dd2e459d2a8815cfe42f8489d318edff69b9892a77fb40d2fb23469a66209d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8a0779262acb088f9eff6b4bbc0cdfa7049d334fe632b271075eab22fc89ac8715b0a7d1a43e05939fc18569c77771b32734d6b2de98f6e8bdad8183b756cd63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/953c9e3b494beda33113df0dae7eaf3b4306f22bdea587375999b67309f240c1d60d7649753553dcf80a538975360b11e6f055435eb851a1402f11180fa06043"} 09:20:27 INFO - Running post-run listener: copy_logs_to_upload_dir 09:20:27 INFO - Copying logs to upload dir... 09:20:27 INFO - mkdir: /builds/slave/test/build/upload/logs 09:20:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.549883 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-24 09:20:26.797976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 09:20:26.801389) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ccd866bc2805807aa4e7735400eb7ca64ad8f5fa8fa187eddd3bff1c10608d0c856bf4454d46cc0bde729ec4d6d59d2b4d0269308916645dcd4d86b18a48319d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/479e89d1ceb460aaf9e57df3679fcddd23844ff3eed2fcb1661c0270ddf2dd8141dd2e459d2a8815cfe42f8489d318edff69b9892a77fb40d2fb23469a66209d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8a0779262acb088f9eff6b4bbc0cdfa7049d334fe632b271075eab22fc89ac8715b0a7d1a43e05939fc18569c77771b32734d6b2de98f6e8bdad8183b756cd63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/953c9e3b494beda33113df0dae7eaf3b4306f22bdea587375999b67309f240c1d60d7649753553dcf80a538975360b11e6f055435eb851a1402f11180fa06043"} build_url:https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/FBg96DS-TD678fjR-8rJQw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/ccd866bc2805807aa4e7735400eb7ca64ad8f5fa8fa187eddd3bff1c10608d0c856bf4454d46cc0bde729ec4d6d59d2b4d0269308916645dcd4d86b18a48319d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/479e89d1ceb460aaf9e57df3679fcddd23844ff3eed2fcb1661c0270ddf2dd8141dd2e459d2a8815cfe42f8489d318edff69b9892a77fb40d2fb23469a66209d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8a0779262acb088f9eff6b4bbc0cdfa7049d334fe632b271075eab22fc89ac8715b0a7d1a43e05939fc18569c77771b32734d6b2de98f6e8bdad8183b756cd63", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/953c9e3b494beda33113df0dae7eaf3b4306f22bdea587375999b67309f240c1d60d7649753553dcf80a538975360b11e6f055435eb851a1402f11180fa06043"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 09:20:26.825471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 09:20:26.825773) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1500902890.932968-625624991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 09:20:26.911974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 09:20:26.913663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 09:20:26.913974) ========= ========= Total master_lag: 0.15 =========