builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1502750840.25 results: success (0) revision: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.247695) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.248483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.250746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.267931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.268378) ========= 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=1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 15:47:22-- 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% 223M=0s 2017-08-14 15:47:22 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.365534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.366023) ========= 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=1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018772 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:20.425284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 15:47:20.425618) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 --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=1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 15:47:22,318 truncating revision to first 12 chars 2017-08-14 15:47:22,319 Setting DEBUG logging. 2017-08-14 15:47:22,319 attempt 1/10 2017-08-14 15:47:22,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/824d4f269c63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 15:47:23,276 unpacking tar archive at: mozilla-central-824d4f269c63/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 15:47:21.708785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:21.709090) ========= script_repo_revision: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:21.709445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:21.712874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 15:47:21.729221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-08-14 15:47:21.729781) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:23 INFO - MultiFileLogger online at 20170814 15:47:23 in /builds/slave/test 15:47:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:47:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:23 INFO - {'append_to_log': False, 15:47:23 INFO - 'base_work_dir': '/builds/slave/test', 15:47:23 INFO - 'blob_upload_branch': 'Firefox', 15:47:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:23 INFO - 'branch': 'Firefox', 15:47:23 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:23 INFO - 'code_coverage': False, 15:47:23 INFO - 'config_files': ('talos/linux_config.py',), 15:47:23 INFO - 'default_actions': ('clobber', 15:47:23 INFO - 'read-buildbot-config', 15:47:23 INFO - 'download-and-extract', 15:47:23 INFO - 'populate-webroot', 15:47:23 INFO - 'create-virtualenv', 15:47:23 INFO - 'install', 15:47:23 INFO - 'setup-mitmproxy', 15:47:23 INFO - 'run-tests'), 15:47:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:23 INFO - 'disable_ccov_upload': False, 15:47:23 INFO - 'download_minidump_stackwalk': True, 15:47:23 INFO - 'download_symbols': 'ondemand', 15:47:23 INFO - 'enable_stylo': False, 15:47:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:23 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:23 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:23 INFO - 'gecko_profile': False, 15:47:23 INFO - 'gecko_profile_interval': 0, 15:47:23 INFO - 'installer_path': 'installer.exe', 15:47:23 INFO - 'log_level': 'info', 15:47:23 INFO - 'log_name': 'talos', 15:47:23 INFO - 'log_to_console': True, 15:47:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:23 INFO - 'opt_config_files': (), 15:47:23 INFO - 'pip_index': False, 15:47:23 INFO - 'suite': 'dromaeojs-e10s', 15:47:23 INFO - 'system_bits': '32', 15:47:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:23 INFO - 'title': 'talos-linux64-ix-079', 15:47:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:23 INFO - 'use_talos_json': True, 15:47:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:23 INFO - 'work_dir': 'build'} 15:47:23 INFO - [mozharness: 2017-08-14 22:47:23.727613Z] Running clobber step. 15:47:23 INFO - Running pre-action listener: _resource_record_pre_action 15:47:23 INFO - Running main action method: clobber 15:47:23 INFO - rmtree: /builds/slave/test/build 15:47:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:25 INFO - Running post-action listener: _resource_record_post_action 15:47:25 INFO - [mozharness: 2017-08-14 22:47:25.283407Z] Finished clobber step (success) 15:47:25 INFO - [mozharness: 2017-08-14 22:47:25.283509Z] Running read-buildbot-config step. 15:47:25 INFO - Running pre-action listener: _resource_record_pre_action 15:47:25 INFO - Running main action method: read_buildbot_config 15:47:25 INFO - Using buildbot properties: 15:47:25 INFO - { 15:47:25 INFO - "project": "", 15:47:25 INFO - "product": "firefox", 15:47:25 INFO - "who": "kwierso@gmail.com", 15:47:25 INFO - "installer_path": "public/build/target.tar.bz2", 15:47:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:47:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:47:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:47:25 INFO - "stage_platform": "linux64-stylosequential", 15:47:25 INFO - "basedir": "/builds/slave/test", 15:47:25 INFO - "buildnumber": 190, 15:47:25 INFO - "platform": "ubuntu64_hw_styloseq", 15:47:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:47:25 INFO - "slavebuilddir": "test", 15:47:25 INFO - "taskId": "cc3KW_BvRaWRWtW723vyhg", 15:47:25 INFO - "branch": "mozilla-central", 15:47:25 INFO - "script_repo_revision": "production", 15:47:25 INFO - "revision": "824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5", 15:47:25 INFO - "slavename": "talos-linux64-ix-079", 15:47:25 INFO - "repo_path": "mozilla-central" 15:47:25 INFO - } 15:47:25 INFO - Finding installer, test and symbols from parent task. 15:47:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cc3KW_BvRaWRWtW723vyhg'}, attempt #1 15:47:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cc3KW_BvRaWRWtW723vyhg'}, attempt #1 15:47:26 INFO - Task dependencies: D65EYMoBSGC1-IshLAOwxA 15:47:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA'}, attempt #1 15:47:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:47:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json 15:47:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip 15:47:26 INFO - Running post-action listener: _resource_record_post_action 15:47:26 INFO - [mozharness: 2017-08-14 22:47:26.642333Z] Finished read-buildbot-config step (success) 15:47:26 INFO - [mozharness: 2017-08-14 22:47:26.642558Z] Running download-and-extract step. 15:47:26 INFO - Running pre-action listener: _resource_record_pre_action 15:47:26 INFO - Running main action method: download_and_extract 15:47:26 INFO - mkdir: /builds/slave/test/build/tests 15:47:26 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')]} 15:47:26 INFO - trying https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json 15:47:26 INFO - Downloading https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:47:58 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json: The read operation timed out 15:47:58 INFO - retry: attempt #1 caught SSLError exception: The read operation timed out 15:47:58 INFO - retry: Failed, sleeping 30 seconds before retrying 15:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #2 15:48:29 INFO - Downloaded 989 bytes. 15:48:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:48:29 INFO - Using the following test package requirements: 15:48:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:48:29 INFO - u'common': [u'target.common.tests.zip'], 15:48:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:48:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:48:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:48:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:48:29 INFO - u'mozbase': [u'target.common.tests.zip'], 15:48:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:48:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:48:29 INFO - u'web-platform': [u'target.common.tests.zip', 15:48:29 INFO - u'target.web-platform.tests.tar.gz'], 15:48:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:48:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:48:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip 15:48:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:48:29 INFO - Fetch https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip into memory 15:48:31 INFO - Content-Length response header: 54034241 15:48:31 INFO - Bytes received: 54034241 15:48:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:48:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip 15:48:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:48:42 INFO - Fetch https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.common.tests.zip into memory 15:48:43 INFO - Content-Length response header: 54034241 15:48:43 INFO - Bytes received: 54034241 15:48:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.talos.tests.zip 15:48:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:48:55 INFO - Fetch https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.talos.tests.zip into memory 15:48:56 INFO - Content-Length response header: 14496050 15:48:56 INFO - Bytes received: 14496050 15:48:56 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')]} 15:48:56 INFO - trying https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:48:56 INFO - Downloading https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:48:58 INFO - Downloaded 61711460 bytes. 15:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:48:58 INFO - mkdir: /builds/slave/test/properties 15:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:58 INFO - Contents: 15:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 15:48:58 INFO - Running post-action listener: _resource_record_post_action 15:48:58 INFO - Running post-action listener: set_extra_try_arguments 15:48:58 INFO - [mozharness: 2017-08-14 22:48:58.017657Z] Finished download-and-extract step (success) 15:48:58 INFO - [mozharness: 2017-08-14 22:48:58.017756Z] Running populate-webroot step. 15:48:58 INFO - Running pre-action listener: _resource_record_pre_action 15:48:58 INFO - Running main action method: populate_webroot 15:48:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:48:58 INFO - 'tests': ['damp', 'tps']}, 15:48:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:48:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:48:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:48:58 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:58 INFO - 'ts_paint', 15:48:58 INFO - 'tpaint', 15:48:58 INFO - 'sessionrestore', 15:48:58 INFO - 'sessionrestore_many_windows', 15:48:58 INFO - 'sessionrestore_no_auto_restore', 15:48:58 INFO - 'tabpaint']}, 15:48:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:48:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:48:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:58 INFO - 'tsvgr_opacity', 15:48:58 INFO - 'tart', 15:48:58 INFO - 'tscrollx', 15:48:58 INFO - 'tsvg_static']}, 15:48:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:48:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:58 INFO - 'talos_options': ['--mitmproxy', 15:48:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:58 INFO - '--firstNonBlankPaint'], 15:48:58 INFO - 'tests': ['tp6_google', 15:48:58 INFO - 'tp6_youtube', 15:48:58 INFO - 'tp6_amazon', 15:48:58 INFO - 'tp6_facebook']}, 15:48:58 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:58 INFO - 'talos_options': ['--stylo', 15:48:58 INFO - '--mitmproxy', 15:48:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:58 INFO - '--firstNonBlankPaint'], 15:48:58 INFO - 'tests': ['tp6_google', 15:48:58 INFO - 'tp6_youtube', 15:48:58 INFO - 'tp6_amazon', 15:48:58 INFO - 'tp6_facebook']}, 15:48:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:58 INFO - 'talos_options': ['--stylo', 15:48:58 INFO - '--stylo-threads=1', 15:48:58 INFO - '--mitmproxy', 15:48:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:58 INFO - '--firstNonBlankPaint'], 15:48:58 INFO - 'tests': ['tp6_google', 15:48:58 INFO - 'tp6_youtube', 15:48:58 INFO - 'tp6_amazon', 15:48:58 INFO - 'tp6_facebook']}, 15:48:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:48:58 INFO - 'talos_options': ['--xperf_path', 15:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:58 INFO - 'tests': ['tp5n']}}} 15:48:58 INFO - Running post-action listener: _resource_record_post_action 15:48:58 INFO - [mozharness: 2017-08-14 22:48:58.026344Z] Finished populate-webroot step (success) 15:48:58 INFO - [mozharness: 2017-08-14 22:48:58.026437Z] Running create-virtualenv step. 15:48:58 INFO - Running pre-action listener: _resource_record_pre_action 15:48:58 INFO - Running main action method: create_virtualenv 15:48:58 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:58 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 15:48:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:48:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:58 INFO - Using real prefix '/usr' 15:48:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:58 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:00 INFO - Installing pip.................done. 15:49:00 INFO - Return code: 0 15:49:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:00 INFO - Reading from file tmpfile_stdout 15:49:00 INFO - Output received: 15:49:00 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) 15:49:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:00 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:00 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 15:49:00 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 15:49:00 INFO - Using env: {'DISPLAY': ':0', 15:49:00 INFO - 'HOME': '/home/cltbld', 15:49:00 INFO - 'LANG': 'en_US.UTF-8', 15:49:00 INFO - 'LANGUAGE': 'en_US:en', 15:49:00 INFO - 'LOGNAME': 'cltbld', 15:49:00 INFO - 'MAIL': '/var/mail/cltbld', 15:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:00 INFO - 'MOZ_NO_REMOTE': '1', 15:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:00 INFO - 'NO_EM_RESTART': '1', 15:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:00 INFO - 'PWD': '/builds/slave/test', 15:49:00 INFO - 'SHELL': '/bin/bash', 15:49:00 INFO - 'SHLVL': '1', 15:49:00 INFO - 'TERM': 'linux', 15:49:00 INFO - 'TMOUT': '86400', 15:49:00 INFO - 'USER': 'cltbld', 15:49:00 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:00 INFO - '_': '/tools/buildbot/bin/python'} 15:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:01 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 15:49:01 INFO - Cleaning up... 15:49:01 INFO - Return code: 0 15:49:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:49:01 INFO - Using env: {'DISPLAY': ':0', 15:49:01 INFO - 'HOME': '/home/cltbld', 15:49:01 INFO - 'LANG': 'en_US.UTF-8', 15:49:01 INFO - 'LANGUAGE': 'en_US:en', 15:49:01 INFO - 'LOGNAME': 'cltbld', 15:49:01 INFO - 'MAIL': '/var/mail/cltbld', 15:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:01 INFO - 'MOZ_NO_REMOTE': '1', 15:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:01 INFO - 'NO_EM_RESTART': '1', 15:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:01 INFO - 'PWD': '/builds/slave/test', 15:49:01 INFO - 'SHELL': '/bin/bash', 15:49:01 INFO - 'SHLVL': '1', 15:49:01 INFO - 'TERM': 'linux', 15:49:01 INFO - 'TMOUT': '86400', 15:49:01 INFO - 'USER': 'cltbld', 15:49:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:01 INFO - '_': '/tools/buildbot/bin/python'} 15:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:01 INFO - Downloading/unpacking psutil>=3.1.1 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:02 INFO - Installing collected packages: psutil 15:49:02 INFO - Running setup.py install for psutil 15:49:02 INFO - building 'psutil._psutil_linux' extension 15:49:02 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 15:49:02 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 15:49:02 INFO - building 'psutil._psutil_posix' extension 15:49:02 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 15:49:02 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 15:49:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:02 INFO - Successfully installed psutil 15:49:02 INFO - Cleaning up... 15:49:02 INFO - Return code: 0 15:49:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49: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')]} 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:03 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:03 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 15:49:03 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 15:49:03 INFO - Using env: {'DISPLAY': ':0', 15:49:03 INFO - 'HOME': '/home/cltbld', 15:49:03 INFO - 'LANG': 'en_US.UTF-8', 15:49:03 INFO - 'LANGUAGE': 'en_US:en', 15:49:03 INFO - 'LOGNAME': 'cltbld', 15:49:03 INFO - 'MAIL': '/var/mail/cltbld', 15:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:03 INFO - 'MOZ_NO_REMOTE': '1', 15:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:03 INFO - 'NO_EM_RESTART': '1', 15:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:03 INFO - 'PWD': '/builds/slave/test', 15:49:03 INFO - 'SHELL': '/bin/bash', 15:49:03 INFO - 'SHLVL': '1', 15:49:03 INFO - 'TERM': 'linux', 15:49:03 INFO - 'TMOUT': '86400', 15:49:03 INFO - 'USER': 'cltbld', 15:49:03 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:03 INFO - '_': '/tools/buildbot/bin/python'} 15:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:04 INFO - Installing collected packages: mozsystemmonitor 15:49:04 INFO - Running setup.py install for mozsystemmonitor 15:49:04 INFO - Successfully installed mozsystemmonitor 15:49:04 INFO - Cleaning up... 15:49:04 INFO - Return code: 0 15:49:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:04 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:04 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 15:49:04 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 15:49:04 INFO - Using env: {'DISPLAY': ':0', 15:49:04 INFO - 'HOME': '/home/cltbld', 15:49:04 INFO - 'LANG': 'en_US.UTF-8', 15:49:04 INFO - 'LANGUAGE': 'en_US:en', 15:49:04 INFO - 'LOGNAME': 'cltbld', 15:49:04 INFO - 'MAIL': '/var/mail/cltbld', 15:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:04 INFO - 'MOZ_NO_REMOTE': '1', 15:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:04 INFO - 'NO_EM_RESTART': '1', 15:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:04 INFO - 'PWD': '/builds/slave/test', 15:49:04 INFO - 'SHELL': '/bin/bash', 15:49:04 INFO - 'SHLVL': '1', 15:49:04 INFO - 'TERM': 'linux', 15:49:04 INFO - 'TMOUT': '86400', 15:49:04 INFO - 'USER': 'cltbld', 15:49:04 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:04 INFO - '_': '/tools/buildbot/bin/python'} 15:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:04 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:04 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 15:49:04 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 15:49:04 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 15:49:04 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 15:49:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:05 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 15:49:05 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 15:49:05 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 15:49:05 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 15:49:05 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:06 INFO - warning: no files found matching '*.txt' 15:49:06 INFO - no previously-included directories found matching 'build' 15:49:06 INFO - no previously-included directories found matching 'dist' 15:49:06 INFO - no previously-included directories found matching '.git*' 15:49:06 INFO - Installing collected packages: jsonschema, functools32 15:49:06 INFO - Running setup.py install for functools32 15:49:06 INFO - warning: no files found matching '*.txt' 15:49:06 INFO - no previously-included directories found matching 'build' 15:49:06 INFO - no previously-included directories found matching 'dist' 15:49:06 INFO - no previously-included directories found matching '.git*' 15:49:06 INFO - Successfully installed jsonschema functools32 15:49:06 INFO - Cleaning up... 15:49:06 INFO - Return code: 0 15:49:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:06 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')]} 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:06 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')]} 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:06 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:06 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 15:49:06 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 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:06 INFO - Cleaning up... 15:49:06 INFO - Return code: 0 15:49:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:06 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')]} 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:06 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')]} 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:06 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:06 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 15:49:06 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 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:06 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 15:49:06 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 15:49:06 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 15:49:06 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 15:49:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49: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 15:49: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 15:49: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 15:49: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 15:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:08 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 15:49:08 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 15:49:08 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 15:49:08 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 15:49:08 INFO - Downloading docopt-0.6.1.tar.gz 15:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:08 INFO - Running setup.py install for blobuploader 15:49:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:08 INFO - Running setup.py install for requests 15:49:08 INFO - Running setup.py install for docopt 15:49:08 INFO - Successfully installed blobuploader requests docopt 15:49:08 INFO - Cleaning up... 15:49:08 INFO - Return code: 0 15:49:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:08 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')]} 15:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:08 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')]} 15:49:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:08 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:08 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 15:49:08 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 15:49:08 INFO - Using env: {'DISPLAY': ':0', 15:49:08 INFO - 'HOME': '/home/cltbld', 15:49:08 INFO - 'LANG': 'en_US.UTF-8', 15:49:08 INFO - 'LANGUAGE': 'en_US:en', 15:49:08 INFO - 'LOGNAME': 'cltbld', 15:49:08 INFO - 'MAIL': '/var/mail/cltbld', 15:49:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:08 INFO - 'MOZ_NO_REMOTE': '1', 15:49:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:08 INFO - 'NO_EM_RESTART': '1', 15:49:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:08 INFO - 'PWD': '/builds/slave/test', 15:49:08 INFO - 'SHELL': '/bin/bash', 15:49:08 INFO - 'SHLVL': '1', 15:49:08 INFO - 'TERM': 'linux', 15:49:08 INFO - 'TMOUT': '86400', 15:49:08 INFO - 'USER': 'cltbld', 15:49:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:08 INFO - '_': '/tools/buildbot/bin/python'} 15:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:09 INFO - Running setup.py (path:/tmp/pip-vUxaxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:09 INFO - Running setup.py (path:/tmp/pip-T35UZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:09 INFO - Running setup.py (path:/tmp/pip-Mxz5D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:09 INFO - Running setup.py (path:/tmp/pip-MIBeKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:09 INFO - Running setup.py (path:/tmp/pip-8uqIEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:09 INFO - Running setup.py (path:/tmp/pip-YrFio_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:09 INFO - Running setup.py (path:/tmp/pip-4lQDnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:09 INFO - Running setup.py (path:/tmp/pip-gEaqWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:09 INFO - Running setup.py (path:/tmp/pip-wKNRyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:09 INFO - Running setup.py (path:/tmp/pip-on0oi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:09 INFO - Running setup.py (path:/tmp/pip-HtrQoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:09 INFO - Running setup.py (path:/tmp/pip-zPd9by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:10 INFO - Running setup.py (path:/tmp/pip-mP1kzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:10 INFO - Running setup.py (path:/tmp/pip-cIFiRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:10 INFO - Running setup.py (path:/tmp/pip-cQTtQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:10 INFO - Running setup.py (path:/tmp/pip-UzMZXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:10 INFO - Running setup.py (path:/tmp/pip-NYYPn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:10 INFO - Running setup.py install for manifestparser 15:49:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:10 INFO - Running setup.py install for mozcrash 15:49:10 INFO - Running setup.py install for mozdebug 15:49:10 INFO - Running setup.py install for mozdevice 15:49:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:10 INFO - Running setup.py install for mozfile 15:49:10 INFO - Running setup.py install for mozhttpd 15:49:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:10 INFO - Running setup.py install for mozinfo 15:49:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Running setup.py install for mozInstall 15:49:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Running setup.py install for mozleak 15:49:11 INFO - Running setup.py install for mozlog 15:49:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Running setup.py install for moznetwork 15:49:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Running setup.py install for mozprocess 15:49:11 INFO - Running setup.py install for mozprofile 15:49:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Running setup.py install for mozrunner 15:49:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:11 INFO - Running setup.py install for mozscreenshot 15:49:11 INFO - Running setup.py install for moztest 15:49:12 INFO - Running setup.py install for mozversion 15:49:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:12 INFO - Cleaning up... 15:49:12 INFO - Return code: 0 15:49:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49: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')]} 15:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:12 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:12 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 15:49:12 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 15:49:12 INFO - Using env: {'DISPLAY': ':0', 15:49:12 INFO - 'HOME': '/home/cltbld', 15:49:12 INFO - 'LANG': 'en_US.UTF-8', 15:49:12 INFO - 'LANGUAGE': 'en_US:en', 15:49:12 INFO - 'LOGNAME': 'cltbld', 15:49:12 INFO - 'MAIL': '/var/mail/cltbld', 15:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:12 INFO - 'MOZ_NO_REMOTE': '1', 15:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:12 INFO - 'NO_EM_RESTART': '1', 15:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:12 INFO - 'PWD': '/builds/slave/test', 15:49:12 INFO - 'SHELL': '/bin/bash', 15:49:12 INFO - 'SHLVL': '1', 15:49:12 INFO - 'TERM': 'linux', 15:49:12 INFO - 'TMOUT': '86400', 15:49:12 INFO - 'USER': 'cltbld', 15:49:12 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:12 INFO - '_': '/tools/buildbot/bin/python'} 15:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:12 INFO - Running setup.py (path:/tmp/pip-ITb_qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:12 INFO - Running setup.py (path:/tmp/pip-ZQNTVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:12 INFO - Running setup.py (path:/tmp/pip-yhXQow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:12 INFO - Running setup.py (path:/tmp/pip-KU8Hso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:12 INFO - Running setup.py (path:/tmp/pip-Cmbx9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:12 INFO - Running setup.py (path:/tmp/pip-KaXB1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:12 INFO - Running setup.py (path:/tmp/pip-y2ISY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:12 INFO - Running setup.py (path:/tmp/pip-x2mqgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:12 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)) 15:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:12 INFO - Running setup.py (path:/tmp/pip-JL7bC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:13 INFO - Running setup.py (path:/tmp/pip-EOBPjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:13 INFO - Running setup.py (path:/tmp/pip-4u8yxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:13 INFO - Running setup.py (path:/tmp/pip-GL3AAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:13 INFO - Running setup.py (path:/tmp/pip-Z9IRnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:13 INFO - Running setup.py (path:/tmp/pip-jx0mca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:13 INFO - Running setup.py (path:/tmp/pip-WsigOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:13 INFO - Running setup.py (path:/tmp/pip-BHpjvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:13 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)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:13 INFO - Running setup.py (path:/tmp/pip-yIYGAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:13 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)) 15:49:13 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)) 15:49:13 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)) 15:49:13 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)) 15:49:13 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)) 15:49:13 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)) 15:49:13 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)) 15:49:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49: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 15:49: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 15:49: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 15:49: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 15:49:14 INFO - Downloading blessings-1.6.tar.gz 15:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:14 INFO - Installing collected packages: blessings 15:49:14 INFO - Running setup.py install for blessings 15:49:14 INFO - Successfully installed blessings 15:49:14 INFO - Cleaning up... 15:49:14 INFO - Return code: 0 15:49:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:15 INFO - Reading from file tmpfile_stdout 15:49:15 INFO - Current package versions: 15:49:15 INFO - argparse == 1.2.1 15:49:15 INFO - blessings == 1.6 15:49:15 INFO - blobuploader == 1.2.4 15:49:15 INFO - docopt == 0.6.1 15:49:15 INFO - functools32 == 3.2.3-2 15:49:15 INFO - jsonschema == 2.5.1 15:49:15 INFO - manifestparser == 1.1 15:49:15 INFO - mozInstall == 1.13 15:49:15 INFO - mozcrash == 1.0 15:49:15 INFO - mozdebug == 0.1 15:49:15 INFO - mozdevice == 0.51 15:49:15 INFO - mozfile == 1.2 15:49:15 INFO - mozhttpd == 0.7 15:49:15 INFO - mozinfo == 0.10 15:49:15 INFO - mozleak == 0.1 15:49:15 INFO - mozlog == 3.5 15:49:15 INFO - moznetwork == 0.27 15:49:15 INFO - mozprocess == 0.25 15:49:15 INFO - mozprofile == 0.28 15:49:15 INFO - mozrunner == 6.13 15:49:15 INFO - mozscreenshot == 0.1 15:49:15 INFO - mozsystemmonitor == 0.3 15:49:15 INFO - moztest == 0.8 15:49:15 INFO - mozversion == 1.4 15:49:15 INFO - psutil == 3.1.1 15:49:15 INFO - requests == 1.2.3 15:49:15 INFO - wsgiref == 0.1.2 15:49:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49: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')]} 15:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:15 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:15 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 15:49:15 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 15:49:15 INFO - Using env: {'DISPLAY': ':0', 15:49:15 INFO - 'HOME': '/home/cltbld', 15:49:15 INFO - 'LANG': 'en_US.UTF-8', 15:49:15 INFO - 'LANGUAGE': 'en_US:en', 15:49:15 INFO - 'LOGNAME': 'cltbld', 15:49:15 INFO - 'MAIL': '/var/mail/cltbld', 15:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:15 INFO - 'MOZ_NO_REMOTE': '1', 15:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:15 INFO - 'NO_EM_RESTART': '1', 15:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:15 INFO - 'PWD': '/builds/slave/test', 15:49:15 INFO - 'SHELL': '/bin/bash', 15:49:15 INFO - 'SHLVL': '1', 15:49:15 INFO - 'TERM': 'linux', 15:49:15 INFO - 'TMOUT': '86400', 15:49:15 INFO - 'USER': 'cltbld', 15:49:15 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:15 INFO - '_': '/tools/buildbot/bin/python'} 15:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 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)) 15:49:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:49:15 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 15:49:15 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 15:49:15 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 15:49:15 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 15:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:49:16 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)) 15:49:16 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)) 15:49:16 INFO - Installing collected packages: simplejson 15:49:16 INFO - Running setup.py install for simplejson 15:49:16 INFO - building 'simplejson._speedups' extension 15:49:16 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 15:49:17 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 15:49:17 INFO - Successfully installed simplejson 15:49:17 INFO - Cleaning up... 15:49:17 INFO - Return code: 0 15:49:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:17 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')]} 15:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:17 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')]} 15:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:17 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 0x1c361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa3b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, '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': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', '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 15:49:17 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 15:49:17 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 15:49:17 INFO - Using env: {'DISPLAY': ':0', 15:49:17 INFO - 'HOME': '/home/cltbld', 15:49:17 INFO - 'LANG': 'en_US.UTF-8', 15:49:17 INFO - 'LANGUAGE': 'en_US:en', 15:49:17 INFO - 'LOGNAME': 'cltbld', 15:49:17 INFO - 'MAIL': '/var/mail/cltbld', 15:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:17 INFO - 'MOZ_NO_REMOTE': '1', 15:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:17 INFO - 'NO_EM_RESTART': '1', 15:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:17 INFO - 'PWD': '/builds/slave/test', 15:49:17 INFO - 'SHELL': '/bin/bash', 15:49:17 INFO - 'SHLVL': '1', 15:49:17 INFO - 'TERM': 'linux', 15:49:17 INFO - 'TMOUT': '86400', 15:49:17 INFO - 'USER': 'cltbld', 15:49:17 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:17 INFO - '_': '/tools/buildbot/bin/python'} 15:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:17 INFO - Cleaning up... 15:49:17 INFO - Return code: 0 15:49:17 INFO - Running post-action listener: _resource_record_post_action 15:49:17 INFO - Running post-action listener: _start_resource_monitoring 15:49:17 INFO - Starting resource monitoring. 15:49:17 INFO - [mozharness: 2017-08-14 22:49:17.895265Z] Finished create-virtualenv step (success) 15:49:17 INFO - [mozharness: 2017-08-14 22:49:17.895790Z] Running install step. 15:49:17 INFO - Running pre-action listener: _resource_record_pre_action 15:49:17 INFO - Running main action method: install 15:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:18 INFO - Reading from file tmpfile_stdout 15:49:18 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:18 INFO - Reading from file tmpfile_stdout 15:49:18 INFO - Output received: 15:49:18 INFO - Usage: mozinstall [options] installer 15:49:18 INFO - Options: 15:49:18 INFO - -h, --help show this help message and exit 15:49:18 INFO - -d DEST, --destination=DEST 15:49:18 INFO - Directory to install application into. [default: 15:49:18 INFO - "/builds/slave/test"] 15:49:18 INFO - --app=APP Application being installed. [default: firefox] 15:49:18 INFO - mkdir: /builds/slave/test/build/application 15:49:18 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'] 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:49:36 INFO - Reading from file tmpfile_stdout 15:49:36 INFO - Output received: 15:49:36 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:36 INFO - Running post-action listener: _resource_record_post_action 15:49:36 INFO - [mozharness: 2017-08-14 22:49:36.134225Z] Finished install step (success) 15:49:36 INFO - [mozharness: 2017-08-14 22:49:36.134479Z] Running setup-mitmproxy step. 15:49:36 INFO - Running pre-action listener: _resource_record_pre_action 15:49:36 INFO - Running main action method: setup_mitmproxy 15:49:36 INFO - Skipping: mitmproxy is not required 15:49:36 INFO - Running post-action listener: _resource_record_post_action 15:49:36 INFO - [mozharness: 2017-08-14 22:49:36.135626Z] Finished setup-mitmproxy step (success) 15:49:36 INFO - [mozharness: 2017-08-14 22:49:36.135848Z] Running run-tests step. 15:49:36 INFO - Running pre-action listener: _resource_record_pre_action 15:49:36 INFO - Running pre-action listener: _set_gcov_prefix 15:49:36 INFO - Running main action method: run_tests 15:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:36 INFO - Python 2.7.3 15:49:36 INFO - Return code: 0 15:49:36 INFO - grabbing minidump binary from tooltool 15:49:36 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')]} 15:49:36 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 0x1fa6f00>, '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 0x1fa1ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa2050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:36 INFO - Return code: 0 15:49:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:36 INFO - ENV: RUST_BACKTRACE is now full 15:49:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 15:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 15:49:36 INFO - Using env: {'DISPLAY': ':0', 15:49:36 INFO - 'HOME': '/home/cltbld', 15:49:36 INFO - 'LANG': 'en_US.UTF-8', 15:49:36 INFO - 'LANGUAGE': 'en_US:en', 15:49:36 INFO - 'LOGNAME': 'cltbld', 15:49:36 INFO - 'MAIL': '/var/mail/cltbld', 15:49:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:36 INFO - 'MOZ_NO_REMOTE': '1', 15:49:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:36 INFO - 'NO_EM_RESTART': '1', 15:49:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:36 INFO - 'PWD': '/builds/slave/test', 15:49:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:36 INFO - 'RUST_BACKTRACE': 'full', 15:49:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:49:36 INFO - 'SHELL': '/bin/bash', 15:49:36 INFO - 'SHLVL': '1', 15:49:36 INFO - 'STYLO_FORCE_ENABLED': '1', 15:49:36 INFO - 'TERM': 'linux', 15:49:36 INFO - 'TMOUT': '86400', 15:49:36 INFO - 'USER': 'cltbld', 15:49:36 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770', 15:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:36 INFO - '_': '/tools/buildbot/bin/python'} 15:49:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 15:49:36 INFO - mozversion application_buildid: 20170814214233 15:49:36 INFO - mozversion application_changeset: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 15:49:36 INFO - mozversion application_display_name: Nightly 15:49:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:36 INFO - mozversion application_name: Firefox 15:49:36 INFO - mozversion application_remotingname: firefox 15:49:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:49:36 INFO - mozversion application_vendor: Mozilla 15:49:36 INFO - mozversion application_version: 57.0a1 15:49:36 INFO - mozversion platform_buildid: 20170814214233 15:49:36 INFO - mozversion platform_changeset: 824d4f269c6323e1ad2bd8ebeb6496d60b8ba3e5 15:49:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:49:36 INFO - mozversion platform_version: 57.0a1 15:49:36 INFO - using testdate: 1502750976 15:49:36 INFO - actual date: 1502750976 15:49:36 INFO - starting webserver on 'localhost:48265' 15:49:36 INFO - SUITE-START | Running 2 tests 15:49:36 INFO - TEST-START | dromaeo_css 15:49:36 INFO - Initialising browser for dromaeo_css test... 15:49:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48265/getInfo.html -profile /tmp/tmpsTKnPo/profile 15:49:36 INFO - TEST-INFO | started process 29229 (/builds/slave/test/build/application/firefox/firefox http://localhost:48265/getInfo.html) 15:49:42 INFO - TEST-INFO | 29229: exit 0 15:49:42 INFO - Browser initialized. 15:49:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:42 INFO - TEST-INFO | started process 29463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsTKnPo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:43 INFO - PID 29463 | 15:49:43 INFO - PID 29463 | (/builds/slave/test/build/application/firefox/firefox:29517): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:49:43 INFO - PID 29463 | 15:49:54 INFO - PID 29463 | RSS: Main: 168357888 15:49:54 INFO - PID 29463 | 15:52:53 INFO - PID 29463 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48265/tests/dromaeo/cssquery-ext.html) 15:52:55 INFO - PID 29463 | RSS: Main: 175554560 15:52:55 INFO - PID 29463 | 15:55:57 INFO - PID 29463 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-ext.html (next: http://localhost:48265/tests/dromaeo/cssquery-jquery.html) 15:55:57 INFO - PID 29463 | RSS: Main: 172724224 15:55:57 INFO - PID 29463 | 15:58:59 INFO - PID 29463 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48265/tests/dromaeo/cssquery-mootools.html) 15:59:00 INFO - PID 29463 | RSS: Main: 173907968 15:59:00 INFO - PID 29463 | 16:02:01 INFO - PID 29463 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48265/tests/dromaeo/cssquery-prototype.html) 16:02:02 INFO - PID 29463 | RSS: Main: 173182976 16:02:02 INFO - PID 29463 | 16:05:06 INFO - PID 29463 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48265/tests/dromaeo/cssquery-yui.html) 16:05:07 INFO - PID 29463 | RSS: Main: 176508928 16:05:07 INFO - PID 29463 | 16:08:08 INFO - PID 29463 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-yui.html (next: http://localhost:48265/tests/dromaeo/cssquery-dojo.html) 16:08:09 INFO - PID 29463 | RSS: Main: 177303552 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | __start_tp_report 16:08:09 INFO - PID 29463 | _x_x_mozilla_page_load 16:08:09 INFO - PID 29463 | _x_x_mozilla_page_load_details 16:08:09 INFO - PID 29463 | |i|pagename|runs| 16:08:09 INFO - PID 29463 | |0;dojo.html;3131.045031265463;3159.731422829059;3177.666345033773;3182.347618738158;3196.280836811716;6105.053716673911;6133.907991380132;6147.231596050494;6193.597416167957;6201.255849298085;6013.969930150343;6103.389661033894;6126.571140020201;6134.018557030876;6146;5585.888282234353;5626.437356264381;5635.3237611486675;5645.830625081254;5757.625754325955;5585.609007369486;5657.9434205658035;5728.856778580527;5745.396733343002;5769.1923130761725;5514.531264842493;5613.4386561343945;5615.438456154393;5694.857628559278;5695.914561281584;5632.2678051853;5670.829875103754;5704.942950570483;5713.628614140068;5728.856778580527;5580.944190558083;5618.185363122325;5670.971645141748;5676.517496012844;5702.429757024306;5981.282246130449;6062.575619706622;6064.96967515164;6067.24159480065;6106.542009349317;6532;6541.672916354163;6609.6695165241545;6627.204735431731;6627.801165965029;6589.802305930782;6613.4709223262025;6624.138861947916;6700.631465269408;6715.865682686319;6182.258129024501;6185.319614842364;6185.6597887116195;6200.286966998763;6207.099970504251;6708.161479815023;6752.662366881636;6762.932370676329;6833.940739185434;6839.794806155824;6315.273743519462;6440;6512.283648798629;6519.478441724651;6538.051982462516;6528.412442880069;6536.3136870627895;6543.738250470023;6544.0183972403565;6556.8360790980605;6456.644884531396;6495.7401703932255;6503.8699226015215;6505.7397704092255;6512.967435162794;6458.12815269942;6534.607923524603;6538.051982462516;6540.803775886731;6541.542092053511;5280.630355875129;5332.253484512172;5344.305240318734;5367.382750983609;5379.892402151935;4568.360429539867;4591.334256532784;4623.768811559408;4624.190766615829;4624.95375046252;5692.9146062809095;5769.307683078057;5769.9711501442225;5777.220075289866;5872.324682661463;6582.736690532421;6584.572002819801;6585;6595.340465953366;6601.735930562723;5732.971335143297;5760.855978600484;5764.682942438122;5766.88466230673;5769.07694768835;5824.097264923944;5846.210761547137;5857.414258574108;5887.735051922674;5894.381089985575;6415.743370265231;6463.321351258144;6500.837479063061;6509.934900651027;6515.51133664977;6595.703193356215;6603.339666033455;6639.402453779183;6707;6709.094272273181;6285.685715714288;6358.459530939922;6373.904391434039;6420.6789660517725;6456.418922297016;6424.698780239689;6451.3226111257645;6478.481721462366;6503.284638689645;6507.642079685663;5703.914441283467;6595.142631457879;6650.268470468148;6710.16122984627;6728.158980127484;6407.167068281094;6414.839629009312;6498.285188629153;6519.576227545194;6524.575902566318;6290.119383286252;6365.777197798055;6367.936320636734;6376.330485299162;6380.298167201511;6343.777967771106;6372.808815735535;6385;6385.297617262005;6387.265464471459;5904.940950590611;6347.492200623847;6401.64790936503;6419.005054216604;6457.870842583216;6265.624062556261;6271.686415679106;6280.842978925563;6285.59143655661;6294.685265736786 16:08:09 INFO - PID 29463 | |1;ext.html;778.2256654628645;862.6118246788944;891.0777345447464;894.1639567004851;1172.8064869296566;30694.53958190626;41910.7904460478;42701.57298427015;42712;42905.57094429055;44128;44323;44540.55459445413;44558.331625025654;44595.33107003398;7214.494985351028;7625.046869141372;7847;7850.214978502133;7855.293023627873;7632.122305934805;7747.845043099134;7756.3794896408435;7763.456558040939;7768.805779855492;7653.31120199182;7723.575203363813;7723.652435640382;7724.343430808388;7729.53622782632;7663.731769388072;7682.923170768277;7685.116211635677;7747.96126019372;7748.767536973844;7654.387648988068;7684.385249180108;7689.884651730228;7699.807504812425;7722;39003.8049809752;39339.606603933884;39363.606363936284;39390;39480.80259598712;3498.8425520851624;3545.769524980868;3548.1307079765365;3552.662497062775;3565.554305711786;32189.1952701182;32193.839030804695;32209.677903221138;32234.838825805957;32236;5027.893863350094;5087.211482220262;5106.285120083191;5133;5136.486351364871;199059;199504;199524;200059;200165;50063;50354;50403;50411;50431.747841260556;52598;52616.47383526116;52754.20868686973;52913.47086529162;52918.47081529212;13621.727565448635;16203;16637.91681041587;16681.83318166827;16752.91623541899;11259.774804503864;12119.333436660892;12159.270443773403;12236.877631223751;12245.510179592895;14102.506412275521;14232.715345693028;14249;14300.570982870531;14456.710865782625;5631.915521267184;5680.318361796528;5806.79676211339;5833.7374818133285;5873.853153671193;1013.9594416223268;1036.5387402605768;1037.071820720451;1039.6465201831413;1042.5464922758472;23313.650295245585;23346.2996110117;23424.765752342257;23464.296071117893;23592;1124.668222874254;1133.5773604126769;1140.5551834784442;1154.9538018479166;1160.4719852467108;12267.202631828903;12290.569830055905;16020.279087441093;16037.839621603634;16693.415730449375;246743;249513;250493;250611;250980;57795;58355;58372.70813645905;58772;58839.70580147072;1452.556970124101;1504.7818066380314;1512.8638422542024;1514.681916797463;1520.3842443810274;27371.45257094807;27673.44653106967;28175.43649127047;28296.292592685346;28424.147275581767;38758.80620596879;39000.414993774546;39016.41475377815;39028.6097139025;39108.2178356437;210963;212050;212284;212294;212677;32124.678753213102;35071.824640876635;35442.64557354394;35894.8205258972;35897.46153807643;42701.35947960721;43663.345049824915;44395;44512.55487445214;45272.547274526834;31824.204394889388;32032.199195019377;32217.35565288728;32586.53360598826;32630.83684581562;31798.841005795748;32053.51919721253;32527.34945301128;32737.836310818293;32964.67035329616;35560.288794224485;35585.64414355927;35889.64110358863;35992.820035899655;36210.45684314684;33617.15957101092;33720.49419258664;34236.657633424344;34442.655573443946;34695.13262168466;24687.62968555509;25084.99660013652;25122.86947087422;25152.874235628704;25732.61401078948 16:08:09 INFO - PID 29463 | |2;jquery.html;575.7063897412321;575.9884802303957;584.5352944409194;588.1471865794599;596.8507873031742;21976;22775;22776.43058923528;22781;23369.298921032354;27018.324541886464;27774.861125694395;27833.582496262574;27852;27977.580336294974;6383.840403989902;6527.151470308853;6554.213494380657;6569;6587.176602924635;5966;6490.772822951198;6526.869462610745;6540.051692504584;6547.9017814732815;6503.674816259168;6509.609423434586;6510.056041873925;6510.609363438209;6512.185976752906;6453.451456626192;6486.935130648704;6491.480681545489;6493.058506516529;6495.447886929616;6001.369856165084;6046.183765191687;6053.092036194562;6053.757849686007;6054;29290.85354573235;29823.850880745675;30605.540916886264;31120.221994450094;31224.8438757807;1946.581484980736;1979.30724246514;1987.9503012424661;1988.562516246438;1991.0940522062426;18791.81208187928;19264.614707705907;20357.694634580494;20375.694364584542;20477;2363.5627408929404;2374.905003799846;2425.175440350272;2436.8537887726616;2437.049550675238;125483.37258313742;126523;127339;137702.31148844192;139021.99999999898;14901.627459313388;15267.236638168048;15373.846261537241;15444.382224711111;15529.378824846879;23654.172103976278;23712.40718982039;23744.64383034256;23749;23776.40558986039;10570.15438764897;10645.414502202299;10667.51996160159;10709;10773.030427261427;10004.149647279917;10013.249006324555;10013.949930250303;10018.098371146632;10038.749031274276;8093.473924194908;9522.00018998009;9683.90316096844;9755.756106097404;9786.5596048178;2765.2119146043283;2778.2220978126156;2784.136917555564;2822.3649678822103;2882.827030378184;935.7192842147329;963.9710808675611;985.7239972807625;998.2762497189625;998.6604554451376;19776.20895164206;19805.40583782489;19934.70097948532;20086.292665123336;20629;1039.6517166749072;1045.5033858917106;1046.3460337289193;1047.418682631147;1061.1722856172198;11095.44522773858;11114.833277500844;11121.165912556591;11270.94364528172;11304.886951130547;483765;489040;564264;565366;573438;123951;129039;131807.34096329458;131881;134344;1269.1813780111777;1283.403217503865;1303.947842086325;1323.305264736002;1326.9867301327056;20903.8954805225;21132.78867211308;21179.364619061453;21312.36062918115;22648;63135.36864631295;63527;64791.177218788886;65071;65399;82245;83513.16486835053;83624.16375836164;87236.5638171805;87620.56189719011;21797.455063623536;22168.55662886701;22343.888280558494;22476.438089047904;22876.4280892979;24091.63862542028;24510.387240319134;24934.50130997406;25140.24579262625;25243.87378063098;19092.713609295595;19726.40820775379;19738.60522789565;19747.703784442958;19925.900370498053;17417.216225270146;17742.29030838752;17926.5518362042;17953.102344882966;18431.539211519284;18728.906355468134;19790.406287810813;19820.801791982474;20249.595008100052;20252.898735506227;21354.78645213528;21501.6774748382;21524.354269371943;21609;21714.89142554277;18853.5859810512;19467.026648667226;19652.41042768719;19666.90166549158;19685.606287873878 16:08:09 INFO - PID 29463 | |3;mootools.html;1377.972440551189;1405.2201028429217;1406.1000959385992;1420.2188796162109;1423.8291405031398;13257.801132983013;13917.582472525815;13951.511697090604;13965.092269002533;13989.230592317419;14351.425942962294;14540.927295363535;14607;14655.487057952974;14674.779878301833;2649.1655128634466;2727.2091093582935;2731.4400547887735;2732.180345896233;2733.289344770354;2618.2145356393103;2677;2706.715794841543;2719.3473566344132;2720.469508445854;2615.738426157388;2662.840229586231;2666.013574977261;2709.2549548874117;2711.620373147761;2618.188361607898;2641.5905534642066;2643.127767836609;2644.854533000684;2648.6424332715223;2500.0749722602754;2518.659980902573;2519.5590771614893;2523.7728604425506;2534.2650631316897;13513.391897364641;13732.588022359345;13740.244286564335;13761.17432954026;13775.655608609764;7292.489525733201;7563.168051514329;7563.7352692655495;7567.583782891938;7586.279303466162;5051.646384753069;5093.490650934914;5138.948610513922;5247.10799164143;5252.921206181911;1762.7179651255738;1781.3141940352928;1784.1703607822294;1813.8186181381889;1824.2885274742862;21976.230831920806;22141.778582214294;22185.889070554706;22192.667109993203;22192.778072219393;6271.122042913996;6498;6593.670316484253;6697.564658297292;6748.177991942148;15697.843021569639;15730.764038539432;15757.921210394104;15759.212039397984;15774.0535567864;7297.197308296083;7447.515911465737;7506.24937506245;7514.699412023567;7534.736284230025;5697.287839020122;6044.214252147192;6060.696965151725;6063.302720187146;6997.685104170325;4957.975210123926;5140.871478213;5160.277561141368;5201.843944681666;5215.452377500384;1498.5129832804382;1513.9772903406458;1518.32434566619;1530.3419529602156;1544.9150296733562;878.7934835313696;898.6135961536602;902.7111324376136;904.380499357942;907.0158877617727;7049.330313620198;7184.748533801397;8770.166834150745;8906.59920303588;8912.242459391024;973.8636590877283;995.9601615935426;1011.8431643095332;1017.2624846985876;1031.6750223679517;4847.733374664357;5690.2887139107615;5704.3154821421695;5749.9425005750245;5914.201582786269;19250.903745481184;19564.804351956584;19648.60702785936;19688.803111968984;19735.40793776189;18951.81048189528;19028.429147125607;19181.520461988563;19191.616167676846;19245.80754192468;9994;10861.294015888941;10873;10891.945540272249;10960.616378426717;8145.144759800372;8579.485230886166;8662.35032372562;8750.51872147038;8907;16729.83270167283;16871.156442178086;16940.237689303765;16946.152692365085;17002.574935626708;17141.14294285256;17177.484675459757;17196.39812606603;17324.480265592054;17333.653326933138;10735.355878647306;11057.723556911142;11060.281081729661;11063.170262230526;11077.169212308949;12701.301428421157;12765.234085954873;12822.422990965615;12858;12919.741605168032;10791.946040269748;10860.565577376816;10873.075788557744;10907.345559266469;10943.069839063768;10331.535080921227;10346.172306215334;10408.271421000458;10433;10580.36517808934;9302.720918372459;9479;9479.526023698925;9480.051994800464;9489.66786162481;7124.358807707331;7125.216226215009;7184.353408193288;7229.204787473479;7229.457790665616;7190.245024272376;7216.96391518039;7267.491275610657;7269.382102521134;7299.197088320387 16:08:09 INFO - PID 29463 | |4;prototype.html;505.5702652745167;505.9620528460364;517.9456157103504;532.2282690099357;541.7995341723561;6212.565120441571;6235.536962899652;6265.530085243614;6340.714667839947;6347.904781428282;5933.3176684681275;6105.633661980273;6107.572469927107;6154;6228.314885362606;4927.162382395001;4940.777665005084;4945.23348880924;4986.127427700156;4988.775505102279;4820.783064762094;4972.70163790172;4977.178765503688;4985.526374994388;4998.5501304882555;4890;4958.305837182797;4973.776180071887;4976.975115124437;4988.301637770715;4878.634102442314;4889.951100489021;4914.582260507861;4930.3344048553345;4960.503949605047;4444.488883778375;4459.130469558438;4471.2845944649025;4475.865724028252;4489.932651010237;6060.545459090542;6080.543959203033;6090.634561926298;6135.141080248769;6153.784617538365;5691.8292451226525;5701.857453563653;5721.456461636138;5729.856753581152;5744.195812586241;6468.482521398277;6517.934820651828;6535.411812936811;6539.93460065398;6570.967145164243;4787.593054590364;4851.951480485221;4874.46380898101;4908.680935739166;4921.827736029221;6806.523543351967;6862.730394876964;6900.2064762552445;6936.751384750743;6980.16238051432;4942.579880710108;4944.728039957837;4966.652334336634;4992;5002.774875130628;5028.421731500851;5075.187969924795;5078.162103252996;5103.923441148386;5132.868041226774;5669.574781891292;5701.173329867146;5724.284464441945;5727.570432217517;5741.282339707536;6613.867722645617;6633.402993730588;6638.336166383323;6679.432248258952;6689.698963546554;1673.5983363992555;1676.740105283683;1699.609089909303;1711.7517959895745;1733.202726745711;1202.7955247607927;1212.5089338817793;1217.8782121787751;1224.8547607986561;1229.471327329239;5664.716764161775;5719.370869204384;5805.187273781674;5811.912821307684;5839.270091238595;6703.765368212089;6728.327167283331;6751.56114852533;6775.762848300285;6848.589084654936;5820.748539064037;5850.5612079094235;5886;5906.9537366903805;5911.733971971185;3564.982175089108;3588.4258518637416;3595.94606080909;3614.8915532534065;3648.175912043978;6541.901871471931;6562.326606715353;6597.47220222381;6608.702608382634;6653;6853.760118395832;6912.55068420551;6920.619365934821;6963.6866341013765;6969.965150174216;6451.774187903401;6517.110038088996;6567.474602031826;6588.011798230208;6601.3728695773825;6727.327267273234;6729.932700673126;6773;6800.591964482147;6837.863242735018;6664.266930637723;6720.420701135327;6736.898946515708;6768.4585233182215;6788.151481064867;6352.714127864165;6489.528102465159;6509.479241660751;6592.307807680125;6644.235912870082;4956.72737999399;4977.776000079933;5004.47453017428;5006.774695138654;5038.496150384932;6597.769078082244;6630.46956243509;6788.015737717905;6797.524173307821;6876.381125698511;6189.843179978154;6353.396427339396;6383.457406120346;6435.613863168225;6459.321771213955;6376.617402955838;6422.614643121427;6428.453581445442;6473.287938326875;6507.446867016357;6309.264952138199;6391.137196478416;6409.230892292955;6414.230292364946;6453.9354606453335;6405.423511883766;6459.224893012869;6482.254540727877;6510.967445162744;6550.639714815731;6271.965125754382;6308.306086330408;6358.834963099177;6362.809115726535;6368.808935731936 16:08:09 INFO - PID 29463 | |5;yui.html;918.3709159225934;931.3573634192406;948.6489998700482;948.7296120605624;953.7091187187905;18566.814331856676;19460.318888838876;19475;19599.314024009163;21538.784612153875;20878.164873405083;21146.57706845862;21308;21528.8923555382;21571.56856862862;1013.579364563707;1058.30680904008;1058.7353161709573;1061.8778840433333;1063.420435862453;954.2413781044052;1031.7317497450642;1047.5233768635253;1047.596675280015;1048.937063776172;1118.1166878166239;1118.9552417903315;1119.28925132541;1119.4738472917757;1119.8096323625002;1105.4804242006244;1118.8433619293305;1119.1158984402311;1119.658504156232;1121.4336759936261;816.6325153680867;817.0930267403178;818.0592318833329;820.0487434575863;821.1706176761454;17881.46355609334;17982.460526184237;18080.367187148386;18840.246390144515;20907.790922090888;21539.784602153934;21830.781692183034;22271.665925011137;22275.331740047663;22276.220332288452;16899.23953422099;17052.48842534726;17228.224729887184;17254.56863578408;17277.222524986406;3615.4576813477925;3637.7635453695425;3659.743817932746;3661.3226553087497;3661.8901432957055;125209;125492;126450.36774816159;127552.36223818915;128061.35969320094;16615.08617026051;16784.496465106065;16838.073905935293;16877;16963.491095267163;30883.536746948816;30950.380992380025;31047.534286985712;31071.844640777104;31654.683453165635;7806.57063861493;8063.919360806317;8269.09040005599;8574.528400938008;8914;3817.5609804872797;3915.393114067324;3939.940900886489;3948.703847211413;3952.0317522207242;5182.663126896739;5212.713300768418;5297.894042119213;5305.336832895888;5318.803269264385;1049.1344640671477;1056.4823236614156;1083.9241253112364;1084.3602274657833;1084.7776205877776;682.3074579302013;699.1994166679226;705.2806137739477;706.5372181221309;713.3472872321768;12103.33431661267;12618.990480761517;12719.364031798374;12897.161684490478;13451.46194152223;647.6858723519184;717.1752484642702;720.3049057659384;722.3967986731138;725.1081170160732;5639.718014099279;5690.573207009491;5837.7664893404635;6005.009173486325;6079.787207447718;106608;107125;107924;109883.90116098737;109996.450017751;90270;94297;95452;96293.0370696298;101045.99999999853;81052.59473702594;81561;82059;82718.80448318804;85238.5738071318;10133.18934485254;10294.176465882862;10353.4305613192;10501.789964200825;10607.045365917105;37180;37223.62776372202;39599.60400396075;39759.80120099381;39974.60025399709;70437;71785;72495.27504725097;72912.63543682247;76161;20112.597748044664;20452.181912723325;20486.48783780358;20797.79202208019;20842.062107204907;19577.80422195817;19589.118489668283;19667.80332196717;20057.097430615948;22007.339779806633;19270;19828.70256946176;19900.70148947738;20033.699494507302;20329.6950545739;19162;19419.320323789165;19488.317908873123;19502.219911203392;19680.40958771239;15749.842501575296;15969.840301596836;15991.360345586047;16269.918650406673;16297;13349.265790381234;13605.523806666719;13664.248466334448;13787.103838250481;14461.855381446472;14881.553553393416;15624.296906639001;15668.843311566738;16221.59446013859;16279.51161465158 16:08:09 INFO - PID 29463 | __end_tp_report 16:08:09 INFO - PID 29463 | __start_cc_report 16:08:09 INFO - PID 29463 | _x_x_mozilla_cycle_collect,391 16:08:09 INFO - PID 29463 | __end_cc_report 16:08:09 INFO - PID 29463 | __startTimestamp1502752089131__endTimestamp 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | ------- Summary: start ------- 16:08:09 INFO - PID 29463 | Number of tests: 6 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | [#0] dojo.html Cycles:165 Average:6067.26 Median:6290.12 stddev:696.79 (11.1%) stddev-sans-first:659.76 16:08:09 INFO - PID 29463 | Values: 3131.0 3159.7 3177.7 3182.3 3196.3 6105.1 6133.9 6147.2 6193.6 6201.3 6014.0 6103.4 6126.6 6134.0 6146.0 5585.9 5626.4 5635.3 5645.8 5757.6 5585.6 5657.9 5728.9 5745.4 5769.2 5514.5 5613.4 5615.4 5694.9 5695.9 5632.3 5670.8 5704.9 5713.6 5728.9 5580.9 5618.2 5671.0 5676.5 5702.4 5981.3 6062.6 6065.0 6067.2 6106.5 6532.0 6541.7 6609.7 6627.2 6627.8 6589.8 6613.5 6624.1 6700.6 6715.9 6182.3 6185.3 6185.7 6200.3 6207.1 6708.2 6752.7 6762.9 6833.9 6839.8 6315.3 6440.0 6512.3 6519.5 6538.1 6528.4 6536.3 6543.7 6544.0 6556.8 6456.6 6495.7 6503.9 6505.7 6513.0 6458.1 6534.6 6538.1 6540.8 6541.5 5280.6 5332.3 5344.3 5367.4 5379.9 4568.4 4591.3 4623.8 4624.2 4625.0 5692.9 5769.3 5770.0 5777.2 5872.3 6582.7 6584.6 6585.0 6595.3 6601.7 5733.0 5760.9 5764.7 5766.9 5769.1 5824.1 5846.2 5857.4 5887.7 5894.4 6415.7 6463.3 6500.8 6509.9 6515.5 6595.7 6603.3 6639.4 6707.0 6709.1 6285.7 6358.5 6373.9 6420.7 6456.4 6424.7 6451.3 6478.5 6503.3 6507.6 5703.9 6595.1 6650.3 6710.2 6728.2 6407.2 6414.8 6498.3 6519.6 6524.6 6290.1 6365.8 6367.9 6376.3 6380.3 6343.8 6372.8 6385.0 6385.3 6387.3 5904.9 6347.5 6401.6 6419.0 6457.9 6265.6 6271.7 6280.8 6285.6 6294.7 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | [#1] ext.html Cycles:180 Average:39519.35 Median:19494.21 stddev:57475.03 (294.8%) stddev-sans-first:57562.65 16:08:09 INFO - PID 29463 | Values: 778.2 862.6 891.1 894.2 1172.8 30694.5 41910.8 42701.6 42712.0 42905.6 44128.0 44323.0 44540.6 44558.3 44595.3 7214.5 7625.0 7847.0 7850.2 7855.3 7632.1 7747.8 7756.4 7763.5 7768.8 7653.3 7723.6 7723.7 7724.3 7729.5 7663.7 7682.9 7685.1 7748.0 7748.8 7654.4 7684.4 7689.9 7699.8 7722.0 39003.8 39339.6 39363.6 39390.0 39480.8 3498.8 3545.8 3548.1 3552.7 3565.6 32189.2 32193.8 32209.7 32234.8 32236.0 5027.9 5087.2 5106.3 5133.0 5136.5 199059.0 199504.0 199524.0 200059.0 200165.0 50063.0 50354.0 50403.0 50411.0 50431.7 52598.0 52616.5 52754.2 52913.5 52918.5 13621.7 16203.0 16637.9 16681.8 16752.9 11259.8 12119.3 12159.3 12236.9 12245.5 14102.5 14232.7 14249.0 14300.6 14456.7 5631.9 5680.3 5806.8 5833.7 5873.9 1014.0 1036.5 1037.1 1039.6 1042.5 23313.7 23346.3 23424.8 23464.3 23592.0 1124.7 1133.6 1140.6 1155.0 1160.5 12267.2 12290.6 16020.3 16037.8 16693.4 246743.0 249513.0 250493.0 250611.0 250980.0 57795.0 58355.0 58372.7 58772.0 58839.7 1452.6 1504.8 1512.9 1514.7 1520.4 27371.5 27673.4 28175.4 28296.3 28424.1 38758.8 39000.4 39016.4 39028.6 39108.2 210963.0 212050.0 212284.0 212294.0 212677.0 32124.7 35071.8 35442.6 35894.8 35897.5 42701.4 43663.3 44395.0 44512.6 45272.5 31824.2 32032.2 32217.4 32586.5 32630.8 31798.8 32053.5 32527.3 32737.8 32964.7 35560.3 35585.6 35889.6 35992.8 36210.5 33617.2 33720.5 34236.7 34442.7 34695.1 24687.6 25085.0 25122.9 25152.9 25732.6 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | [#2] jquery.html Cycles:180 Average:37688.32 Median:22775.72 stddev:90067.34 (395.5%) stddev-sans-first:90276.90 16:08:09 INFO - PID 29463 | Values: 575.7 576.0 584.5 588.1 596.9 21976.0 22775.0 22776.4 22781.0 23369.3 27018.3 27774.9 27833.6 27852.0 27977.6 6383.8 6527.2 6554.2 6569.0 6587.2 5966.0 6490.8 6526.9 6540.1 6547.9 6503.7 6509.6 6510.1 6510.6 6512.2 6453.5 6486.9 6491.5 6493.1 6495.4 6001.4 6046.2 6053.1 6053.8 6054.0 29290.9 29823.9 30605.5 31120.2 31224.8 1946.6 1979.3 1988.0 1988.6 1991.1 18791.8 19264.6 20357.7 20375.7 20477.0 2363.6 2374.9 2425.2 2436.9 2437.0 125483.4 126523.0 127339.0 137702.3 139022.0 14901.6 15267.2 15373.8 15444.4 15529.4 23654.2 23712.4 23744.6 23749.0 23776.4 10570.2 10645.4 10667.5 10709.0 10773.0 10004.1 10013.2 10013.9 10018.1 10038.7 8093.5 9522.0 9683.9 9755.8 9786.6 2765.2 2778.2 2784.1 2822.4 2882.8 935.7 964.0 985.7 998.3 998.7 19776.2 19805.4 19934.7 20086.3 20629.0 1039.7 1045.5 1046.3 1047.4 1061.2 11095.4 11114.8 11121.2 11270.9 11304.9 483765.0 489040.0 564264.0 565366.0 573438.0 123951.0 129039.0 131807.3 131881.0 134344.0 1269.2 1283.4 1303.9 1323.3 1327.0 20903.9 21132.8 21179.4 21312.4 22648.0 63135.4 63527.0 64791.2 65071.0 65399.0 82245.0 83513.2 83624.2 87236.6 87620.6 21797.5 22168.6 22343.9 22476.4 22876.4 24091.6 24510.4 24934.5 25140.2 25243.9 19092.7 19726.4 19738.6 19747.7 19925.9 17417.2 17742.3 17926.6 17953.1 18431.5 18728.9 19790.4 19820.8 20249.6 20252.9 21354.8 21501.7 21524.4 21609.0 21714.9 18853.6 19467.0 19652.4 19666.9 19685.6 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | [#3] mootools.html Cycles:180 Average:8686.44 Median:2529.02 stddev:5857.10 (231.6%) stddev-sans-first:5847.78 16:08:09 INFO - PID 29463 | Values: 1378.0 1405.2 1406.1 1420.2 1423.8 13257.8 13917.6 13951.5 13965.1 13989.2 14351.4 14540.9 14607.0 14655.5 14674.8 2649.2 2727.2 2731.4 2732.2 2733.3 2618.2 2677.0 2706.7 2719.3 2720.5 2615.7 2662.8 2666.0 2709.3 2711.6 2618.2 2641.6 2643.1 2644.9 2648.6 2500.1 2518.7 2519.6 2523.8 2534.3 13513.4 13732.6 13740.2 13761.2 13775.7 7292.5 7563.2 7563.7 7567.6 7586.3 5051.6 5093.5 5138.9 5247.1 5252.9 1762.7 1781.3 1784.2 1813.8 1824.3 21976.2 22141.8 22185.9 22192.7 22192.8 6271.1 6498.0 6593.7 6697.6 6748.2 15697.8 15730.8 15757.9 15759.2 15774.1 7297.2 7447.5 7506.2 7514.7 7534.7 5697.3 6044.2 6060.7 6063.3 6997.7 4958.0 5140.9 5160.3 5201.8 5215.5 1498.5 1514.0 1518.3 1530.3 1544.9 878.8 898.6 902.7 904.4 907.0 7049.3 7184.7 8770.2 8906.6 8912.2 973.9 996.0 1011.8 1017.3 1031.7 4847.7 5690.3 5704.3 5749.9 5914.2 19250.9 19564.8 19648.6 19688.8 19735.4 18951.8 19028.4 19181.5 19191.6 19245.8 9994.0 10861.3 10873.0 10891.9 10960.6 8145.1 8579.5 8662.4 8750.5 8907.0 16729.8 16871.2 16940.2 16946.2 17002.6 17141.1 17177.5 17196.4 17324.5 17333.7 10735.4 11057.7 11060.3 11063.2 11077.2 12701.3 12765.2 12822.4 12858.0 12919.7 10791.9 10860.6 10873.1 10907.3 10943.1 10331.5 10346.2 10408.3 10433.0 10580.4 9302.7 9479.0 9479.5 9480.1 9489.7 7124.4 7125.2 7184.4 7229.2 7229.5 7190.2 7217.0 7267.5 7269.4 7299.2 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | [#4] prototype.html Cycles:180 Average:5512.58 Median:6121.36 stddev:1553.20 (25.4%) stddev-sans-first:1511.41 16:08:09 INFO - PID 29463 | Values: 505.6 506.0 517.9 532.2 541.8 6212.6 6235.5 6265.5 6340.7 6347.9 5933.3 6105.6 6107.6 6154.0 6228.3 4927.2 4940.8 4945.2 4986.1 4988.8 4820.8 4972.7 4977.2 4985.5 4998.6 4890.0 4958.3 4973.8 4977.0 4988.3 4878.6 4890.0 4914.6 4930.3 4960.5 4444.5 4459.1 4471.3 4475.9 4489.9 6060.5 6080.5 6090.6 6135.1 6153.8 5691.8 5701.9 5721.5 5729.9 5744.2 6468.5 6517.9 6535.4 6539.9 6571.0 4787.6 4852.0 4874.5 4908.7 4921.8 6806.5 6862.7 6900.2 6936.8 6980.2 4942.6 4944.7 4966.7 4992.0 5002.8 5028.4 5075.2 5078.2 5103.9 5132.9 5669.6 5701.2 5724.3 5727.6 5741.3 6613.9 6633.4 6638.3 6679.4 6689.7 1673.6 1676.7 1699.6 1711.8 1733.2 1202.8 1212.5 1217.9 1224.9 1229.5 5664.7 5719.4 5805.2 5811.9 5839.3 6703.8 6728.3 6751.6 6775.8 6848.6 5820.7 5850.6 5886.0 5907.0 5911.7 3565.0 3588.4 3595.9 3614.9 3648.2 6541.9 6562.3 6597.5 6608.7 6653.0 6853.8 6912.6 6920.6 6963.7 6970.0 6451.8 6517.1 6567.5 6588.0 6601.4 6727.3 6729.9 6773.0 6800.6 6837.9 6664.3 6720.4 6736.9 6768.5 6788.2 6352.7 6489.5 6509.5 6592.3 6644.2 4956.7 4977.8 5004.5 5006.8 5038.5 6597.8 6630.5 6788.0 6797.5 6876.4 6189.8 6353.4 6383.5 6435.6 6459.3 6376.6 6422.6 6428.5 6473.3 6507.4 6309.3 6391.1 6409.2 6414.2 6453.9 6405.4 6459.2 6482.3 6511.0 6550.6 6272.0 6308.3 6358.8 6362.8 6368.8 16:08:09 INFO - PID 29463 | 16:08:09 INFO - PID 29463 | [#5] yui.html Cycles:180 Average:23764.72 Median:20084.85 stddev:31764.97 (158.2%) stddev-sans-first:31807.75 16:08:09 INFO - PID 29463 | Values: 918.4 931.4 948.6 948.7 953.7 18566.8 19460.3 19475.0 19599.3 21538.8 20878.2 21146.6 21308.0 21528.9 21571.6 1013.6 1058.3 1058.7 1061.9 1063.4 954.2 1031.7 1047.5 1047.6 1048.9 1118.1 1119.0 1119.3 1119.5 1119.8 1105.5 1118.8 1119.1 1119.7 1121.4 816.6 817.1 818.1 820.0 821.2 17881.5 17982.5 18080.4 18840.2 20907.8 21539.8 21830.8 22271.7 22275.3 22276.2 16899.2 17052.5 17228.2 17254.6 17277.2 3615.5 3637.8 3659.7 3661.3 3661.9 125209.0 125492.0 126450.4 127552.4 128061.4 16615.1 16784.5 16838.1 16877.0 16963.5 30883.5 30950.4 31047.5 31071.8 31654.7 7806.6 8063.9 8269.1 8574.5 8914.0 3817.6 3915.4 3939.9 3948.7 3952.0 5182.7 5212.7 5297.9 5305.3 5318.8 1049.1 1056.5 1083.9 1084.4 1084.8 682.3 699.2 705.3 706.5 713.3 12103.3 12619.0 12719.4 12897.2 13451.5 647.7 717.2 720.3 722.4 725.1 5639.7 5690.6 5837.8 6005.0 6079.8 106608.0 107125.0 107924.0 109883.9 109996.5 90270.0 94297.0 95452.0 96293.0 101046.0 81052.6 81561.0 82059.0 82718.8 85238.6 10133.2 10294.2 10353.4 10501.8 10607.0 37180.0 37223.6 39599.6 39759.8 39974.6 70437.0 71785.0 72495.3 72912.6 76161.0 20112.6 20452.2 20486.5 20797.8 20842.1 19577.8 19589.1 19667.8 20057.1 22007.3 19270.0 19828.7 19900.7 20033.7 20329.7 19162.0 19419.3 19488.3 19502.2 19680.4 15749.8 15969.8 15991.4 16269.9 16297.0 13349.3 13605.5 13664.2 13787.1 14461.9 14881.6 15624.3 15668.8 16221.6 16279.5 16:08:09 INFO - PID 29463 | -------- Summary: end -------- 16:08:09 INFO - PID 29463 | 16:08:09 INFO - TEST-INFO | 29463: exit 0 16:08:09 INFO - TEST-OK | dromaeo_css | took 1113251ms 16:08:09 INFO - TEST-START | kraken 16:08:09 INFO - Initialising browser for kraken test... 16:08:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48265/getInfo.html -profile /tmp/tmpc1mJYZ/profile 16:08:09 INFO - TEST-INFO | started process 29838 (/builds/slave/test/build/application/firefox/firefox http://localhost:48265/getInfo.html) 16:08:15 INFO - TEST-INFO | 29838: exit 0 16:08:16 INFO - Browser initialized. 16:08:16 INFO - Running cycle 1/1 for kraken test... 16:08:16 INFO - TEST-INFO | started process 30076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1mJYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:17 INFO - PID 30076 | 16:08:17 INFO - PID 30076 | (/builds/slave/test/build/application/firefox/firefox:30130): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:08:17 INFO - PID 30076 | 16:08:27 INFO - PID 30076 | RSS: Main: 167620608 16:08:27 INFO - PID 30076 | 16:08:30 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:31 INFO - PID 30076 | RSS: Main: 173649920 16:08:31 INFO - PID 30076 | 16:08:33 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-dft) 16:08:34 INFO - PID 30076 | RSS: Main: 177508352 16:08:34 INFO - PID 30076 | 16:08:37 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-fft) 16:08:38 INFO - PID 30076 | RSS: Main: 171134976 16:08:38 INFO - PID 30076 | 16:08:40 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-oscillator) 16:08:41 INFO - PID 30076 | RSS: Main: 172056576 16:08:41 INFO - PID 30076 | 16:08:43 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:43 INFO - PID 30076 | RSS: Main: 172105728 16:08:43 INFO - PID 30076 | 16:08:47 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48265/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:47 INFO - PID 30076 | RSS: Main: 173780992 16:08:47 INFO - PID 30076 | 16:08:51 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48265/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:51 INFO - PID 30076 | RSS: Main: 173568000 16:08:51 INFO - PID 30076 | 16:08:54 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48265/tests/kraken/driver.html?testName=json-parse-financial) 16:08:55 INFO - PID 30076 | RSS: Main: 174063616 16:08:55 INFO - PID 30076 | 16:08:57 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:57 INFO - PID 30076 | RSS: Main: 173989888 16:08:57 INFO - PID 30076 | 16:08:59 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:00 INFO - PID 30076 | RSS: Main: 174448640 16:09:00 INFO - PID 30076 | 16:09:02 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:03 INFO - PID 30076 | RSS: Main: 173989888 16:09:03 INFO - PID 30076 | 16:09:05 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:06 INFO - PID 30076 | RSS: Main: 174764032 16:09:06 INFO - PID 30076 | 16:09:09 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:10 INFO - PID 30076 | RSS: Main: 174743552 16:09:10 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48265/tests/kraken/driver.html?testName=ai-astar) 16:09:12 INFO - PID 30076 | RSS: Main: 175861760 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | __start_tp_report 16:09:12 INFO - PID 30076 | _x_x_mozilla_page_load 16:09:12 INFO - PID 30076 | _x_x_mozilla_page_load_details 16:09:12 INFO - PID 30076 | |i|pagename|runs| 16:09:12 INFO - PID 30076 | |0;ai-astar;97;110;110;108;108;112;115;100;108;108 16:09:12 INFO - PID 30076 | |1;audio-beat-detection;141;117;169;190;118;159;147;123;174;124 16:09:12 INFO - PID 30076 | |2;audio-dft;162;162;161;163;162;171;173;164;169;164 16:09:12 INFO - PID 30076 | |3;audio-fft;76;76;76;172;74;74;74;91;105;75 16:09:12 INFO - PID 30076 | |4;audio-oscillator;82;80;136;87;79;78;124;82;78;125 16:09:12 INFO - PID 30076 | |5;imaging-gaussian-blur;116;115;114;114;114;117;115;120;119;117 16:09:12 INFO - PID 30076 | |6;imaging-darkroom;151;151;150;149;152;150;152;152;151;153 16:09:12 INFO - PID 30076 | |7;imaging-desaturate;97;94;94;102;94;94;93;93;93;94 16:09:12 INFO - PID 30076 | |8;json-parse-financial;56;54;56;53;55;55;58;53;53;59 16:09:12 INFO - PID 30076 | |9;json-stringify-tinderbox;55;55;54;57;55;55;54;55;56;54 16:09:12 INFO - PID 30076 | |10;stanford-crypto-aes;79;78;82;79;77;96;79;79;78;84 16:09:12 INFO - PID 30076 | |11;stanford-crypto-ccm;132;132;119;132;126;122;128;151;121;170 16:09:12 INFO - PID 30076 | |12;stanford-crypto-pbkdf2;172;174;175;171;183;178;187;192;175;173 16:09:12 INFO - PID 30076 | |13;stanford-crypto-sha256-iterative;70;74;72;68;69;71;67;71;76;73 16:09:12 INFO - PID 30076 | __end_tp_report 16:09:12 INFO - PID 30076 | __start_cc_report 16:09:12 INFO - PID 30076 | _x_x_mozilla_cycle_collect,981 16:09:12 INFO - PID 30076 | __end_cc_report 16:09:12 INFO - PID 30076 | __startTimestamp1502752152400__endTimestamp 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | ------- Summary: start ------- 16:09:12 INFO - PID 30076 | Number of tests: 14 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#0] ai-astar Cycles:10 Average:107.60 Median:110.00 stddev:5.34 (4.9%) stddev-sans-first:4.06 16:09:12 INFO - PID 30076 | Values: 97.0 110.0 110.0 108.0 108.0 112.0 115.0 100.0 108.0 108.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:25.99 (17.0%) stddev-sans-first:27.50 16:09:12 INFO - PID 30076 | Values: 141.0 117.0 169.0 190.0 118.0 159.0 147.0 123.0 174.0 124.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.28 (2.6%) stddev-sans-first:4.39 16:09:12 INFO - PID 30076 | Values: 162.0 162.0 161.0 163.0 162.0 171.0 173.0 164.0 169.0 164.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#3] audio-fft Cycles:10 Average:89.30 Median:75.50 stddev:30.78 (40.8%) stddev-sans-first:32.27 16:09:12 INFO - PID 30076 | Values: 76.0 76.0 76.0 172.0 74.0 74.0 74.0 91.0 105.0 75.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.50 stddev:23.29 (29.3%) stddev-sans-first:24.22 16:09:12 INFO - PID 30076 | Values: 82.0 80.0 136.0 87.0 79.0 78.0 124.0 82.0 78.0 125.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.50 stddev:2.13 (1.8%) stddev-sans-first:2.26 16:09:12 INFO - PID 30076 | Values: 116.0 115.0 114.0 114.0 114.0 117.0 115.0 120.0 119.0 117.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:1.20 (0.8%) stddev-sans-first:1.27 16:09:12 INFO - PID 30076 | Values: 151.0 151.0 150.0 149.0 152.0 150.0 152.0 152.0 151.0 153.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.78 (3.0%) stddev-sans-first:2.83 16:09:12 INFO - PID 30076 | Values: 97.0 94.0 94.0 102.0 94.0 94.0 93.0 93.0 93.0 94.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:2.10 (3.8%) stddev-sans-first:2.20 16:09:12 INFO - PID 30076 | Values: 56.0 54.0 56.0 53.0 55.0 55.0 58.0 53.0 53.0 59.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 16:09:12 INFO - PID 30076 | Values: 55.0 55.0 54.0 57.0 55.0 55.0 54.0 55.0 56.0 54.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:79.00 stddev:5.63 (7.1%) stddev-sans-first:5.92 16:09:12 INFO - PID 30076 | Values: 79.0 78.0 82.0 79.0 77.0 96.0 79.0 79.0 78.0 84.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:132.00 stddev:15.74 (11.9%) stddev-sans-first:16.69 16:09:12 INFO - PID 30076 | Values: 132.0 132.0 119.0 132.0 126.0 122.0 128.0 151.0 121.0 170.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:176.50 stddev:7.04 (4.0%) stddev-sans-first:7.12 16:09:12 INFO - PID 30076 | Values: 172.0 174.0 175.0 171.0 183.0 178.0 187.0 192.0 175.0 173.0 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:2.77 (3.9%) stddev-sans-first:2.91 16:09:12 INFO - PID 30076 | Values: 70.0 74.0 72.0 68.0 69.0 71.0 67.0 71.0 76.0 73.0 16:09:12 INFO - PID 30076 | -------- Summary: end -------- 16:09:12 INFO - PID 30076 | 16:09:12 INFO - PID 30076 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:09:13 INFO - TEST-INFO | 30076: exit 0 16:09:13 INFO - TEST-OK | kraken | took 63373ms 16:09:13 INFO - SUITE-END | took 1176s 16:09:13 INFO - Completed test suite (00:19:37) 16:09:13 INFO - javascript benchmark 16:09:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8607.458551047534, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.045031265463, 3159.731422829059, 3177.666345033773, 3182.347618738158, 3196.280836811716, 6105.053716673911, 6133.907991380132, 6147.231596050494, 6193.597416167957, 6201.255849298085, 6013.969930150343, 6103.389661033894, 6126.571140020201, 6134.018557030876, 6146.0, 5585.888282234353, 5626.437356264381, 5635.3237611486675, 5645.830625081254, 5757.625754325955, 5585.609007369486, 5657.9434205658035, 5728.856778580527, 5745.396733343002, 5769.1923130761725, 5514.531264842493, 5613.4386561343945, 5615.438456154393, 5694.857628559278, 5695.914561281584, 5632.2678051853, 5670.829875103754, 5704.942950570483, 5713.628614140068, 5728.856778580527, 5580.944190558083, 5618.185363122325, 5670.971645141748, 5676.517496012844, 5702.429757024306, 5981.282246130449, 6062.575619706622, 6064.96967515164, 6067.24159480065, 6106.542009349317, 6532.0, 6541.672916354163, 6609.6695165241545, 6627.204735431731, 6627.801165965029, 6589.802305930782, 6613.4709223262025, 6624.138861947916, 6700.631465269408, 6715.865682686319, 6182.258129024501, 6185.319614842364, 6185.6597887116195, 6200.286966998763, 6207.099970504251, 6708.161479815023, 6752.662366881636, 6762.932370676329, 6833.940739185434, 6839.794806155824, 6315.273743519462, 6440.0, 6512.283648798629, 6519.478441724651, 6538.051982462516, 6528.412442880069, 6536.3136870627895, 6543.738250470023, 6544.0183972403565, 6556.8360790980605, 6456.644884531396, 6495.7401703932255, 6503.8699226015215, 6505.7397704092255, 6512.967435162794, 6458.12815269942, 6534.607923524603, 6538.051982462516, 6540.803775886731, 6541.542092053511, 5280.630355875129, 5332.253484512172, 5344.305240318734, 5367.382750983609, 5379.892402151935, 4568.360429539867, 4591.334256532784, 4623.768811559408, 4624.190766615829, 4624.95375046252, 5692.9146062809095, 5769.307683078057, 5769.9711501442225, 5777.220075289866, 5872.324682661463, 6582.736690532421, 6584.572002819801, 6585.0, 6595.340465953366, 6601.735930562723, 5732.971335143297, 5760.855978600484, 5764.682942438122, 5766.88466230673, 5769.07694768835, 5824.097264923944, 5846.210761547137, 5857.414258574108, 5887.735051922674, 5894.381089985575, 6415.743370265231, 6463.321351258144, 6500.837479063061, 6509.934900651027, 6515.51133664977, 6595.703193356215, 6603.339666033455, 6639.402453779183, 6707.0, 6709.094272273181, 6285.685715714288, 6358.459530939922, 6373.904391434039, 6420.6789660517725, 6456.418922297016, 6424.698780239689, 6451.3226111257645, 6478.481721462366, 6503.284638689645, 6507.642079685663, 5703.914441283467, 6595.142631457879, 6650.268470468148, 6710.16122984627, 6728.158980127484, 6407.167068281094, 6414.839629009312, 6498.285188629153, 6519.576227545194, 6524.575902566318, 6290.119383286252, 6365.777197798055, 6367.936320636734, 6376.330485299162, 6380.298167201511, 6343.777967771106, 6372.808815735535, 6385.0, 6385.297617262005, 6387.265464471459, 5904.940950590611, 6347.492200623847, 6401.64790936503, 6419.005054216604, 6457.870842583216, 6265.624062556261, 6271.686415679106, 6280.842978925563, 6285.59143655661, 6294.685265736786], "value": 6016.908460277826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.2256654628645, 862.6118246788944, 891.0777345447464, 894.1639567004851, 1172.8064869296566, 30694.53958190626, 41910.7904460478, 42701.57298427015, 42712.0, 42905.57094429055, 44128.0, 44323.0, 44540.55459445413, 44558.331625025654, 44595.33107003398, 7214.494985351028, 7625.046869141372, 7847.0, 7850.214978502133, 7855.293023627873, 7632.122305934805, 7747.845043099134, 7756.3794896408435, 7763.456558040939, 7768.805779855492, 7653.31120199182, 7723.575203363813, 7723.652435640382, 7724.343430808388, 7729.53622782632, 7663.731769388072, 7682.923170768277, 7685.116211635677, 7747.96126019372, 7748.767536973844, 7654.387648988068, 7684.385249180108, 7689.884651730228, 7699.807504812425, 7722.0, 39003.8049809752, 39339.606603933884, 39363.606363936284, 39390.0, 39480.80259598712, 3498.8425520851624, 3545.769524980868, 3548.1307079765365, 3552.662497062775, 3565.554305711786, 32189.1952701182, 32193.839030804695, 32209.677903221138, 32234.838825805957, 32236.0, 5027.893863350094, 5087.211482220262, 5106.285120083191, 5133.0, 5136.486351364871, 199059.0, 199504.0, 199524.0, 200059.0, 200165.0, 50063.0, 50354.0, 50403.0, 50411.0, 50431.747841260556, 52598.0, 52616.47383526116, 52754.20868686973, 52913.47086529162, 52918.47081529212, 13621.727565448635, 16203.0, 16637.91681041587, 16681.83318166827, 16752.91623541899, 11259.774804503864, 12119.333436660892, 12159.270443773403, 12236.877631223751, 12245.510179592895, 14102.506412275521, 14232.715345693028, 14249.0, 14300.570982870531, 14456.710865782625, 5631.915521267184, 5680.318361796528, 5806.79676211339, 5833.7374818133285, 5873.853153671193, 1013.9594416223268, 1036.5387402605768, 1037.071820720451, 1039.6465201831413, 1042.5464922758472, 23313.650295245585, 23346.2996110117, 23424.765752342257, 23464.296071117893, 23592.0, 1124.668222874254, 1133.5773604126769, 1140.5551834784442, 1154.9538018479166, 1160.4719852467108, 12267.202631828903, 12290.569830055905, 16020.279087441093, 16037.839621603634, 16693.415730449375, 246743.0, 249513.0, 250493.0, 250611.0, 250980.0, 57795.0, 58355.0, 58372.70813645905, 58772.0, 58839.70580147072, 1452.556970124101, 1504.7818066380314, 1512.8638422542024, 1514.681916797463, 1520.3842443810274, 27371.45257094807, 27673.44653106967, 28175.43649127047, 28296.292592685346, 28424.147275581767, 38758.80620596879, 39000.414993774546, 39016.41475377815, 39028.6097139025, 39108.2178356437, 210963.0, 212050.0, 212284.0, 212294.0, 212677.0, 32124.678753213102, 35071.824640876635, 35442.64557354394, 35894.8205258972, 35897.46153807643, 42701.35947960721, 43663.345049824915, 44395.0, 44512.55487445214, 45272.547274526834, 31824.204394889388, 32032.199195019377, 32217.35565288728, 32586.53360598826, 32630.83684581562, 31798.841005795748, 32053.51919721253, 32527.34945301128, 32737.836310818293, 32964.67035329616, 35560.288794224485, 35585.64414355927, 35889.64110358863, 35992.820035899655, 36210.45684314684, 33617.15957101092, 33720.49419258664, 34236.657633424344, 34442.655573443946, 34695.13262168466, 24687.62968555509, 25084.99660013652, 25122.86947087422, 25152.874235628704, 25732.61401078948], "value": 17715.116307000088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7063897412321, 575.9884802303957, 584.5352944409194, 588.1471865794599, 596.8507873031742, 21976.0, 22775.0, 22776.43058923528, 22781.0, 23369.298921032354, 27018.324541886464, 27774.861125694395, 27833.582496262574, 27852.0, 27977.580336294974, 6383.840403989902, 6527.151470308853, 6554.213494380657, 6569.0, 6587.176602924635, 5966.0, 6490.772822951198, 6526.869462610745, 6540.051692504584, 6547.9017814732815, 6503.674816259168, 6509.609423434586, 6510.056041873925, 6510.609363438209, 6512.185976752906, 6453.451456626192, 6486.935130648704, 6491.480681545489, 6493.058506516529, 6495.447886929616, 6001.369856165084, 6046.183765191687, 6053.092036194562, 6053.757849686007, 6054.0, 29290.85354573235, 29823.850880745675, 30605.540916886264, 31120.221994450094, 31224.8438757807, 1946.581484980736, 1979.30724246514, 1987.9503012424661, 1988.562516246438, 1991.0940522062426, 18791.81208187928, 19264.614707705907, 20357.694634580494, 20375.694364584542, 20477.0, 2363.5627408929404, 2374.905003799846, 2425.175440350272, 2436.8537887726616, 2437.049550675238, 125483.37258313742, 126523.0, 127339.0, 137702.31148844192, 139021.99999999898, 14901.627459313388, 15267.236638168048, 15373.846261537241, 15444.382224711111, 15529.378824846879, 23654.172103976278, 23712.40718982039, 23744.64383034256, 23749.0, 23776.40558986039, 10570.15438764897, 10645.414502202299, 10667.51996160159, 10709.0, 10773.030427261427, 10004.149647279917, 10013.249006324555, 10013.949930250303, 10018.098371146632, 10038.749031274276, 8093.473924194908, 9522.00018998009, 9683.90316096844, 9755.756106097404, 9786.5596048178, 2765.2119146043283, 2778.2220978126156, 2784.136917555564, 2822.3649678822103, 2882.827030378184, 935.7192842147329, 963.9710808675611, 985.7239972807625, 998.2762497189625, 998.6604554451376, 19776.20895164206, 19805.40583782489, 19934.70097948532, 20086.292665123336, 20629.0, 1039.6517166749072, 1045.5033858917106, 1046.3460337289193, 1047.418682631147, 1061.1722856172198, 11095.44522773858, 11114.833277500844, 11121.165912556591, 11270.94364528172, 11304.886951130547, 483765.0, 489040.0, 564264.0, 565366.0, 573438.0, 123951.0, 129039.0, 131807.34096329458, 131881.0, 134344.0, 1269.1813780111777, 1283.403217503865, 1303.947842086325, 1323.305264736002, 1326.9867301327056, 20903.8954805225, 21132.78867211308, 21179.364619061453, 21312.36062918115, 22648.0, 63135.36864631295, 63527.0, 64791.177218788886, 65071.0, 65399.0, 82245.0, 83513.16486835053, 83624.16375836164, 87236.5638171805, 87620.56189719011, 21797.455063623536, 22168.55662886701, 22343.888280558494, 22476.438089047904, 22876.4280892979, 24091.63862542028, 24510.387240319134, 24934.50130997406, 25140.24579262625, 25243.87378063098, 19092.713609295595, 19726.40820775379, 19738.60522789565, 19747.703784442958, 19925.900370498053, 17417.216225270146, 17742.29030838752, 17926.5518362042, 17953.102344882966, 18431.539211519284, 18728.906355468134, 19790.406287810813, 19820.801791982474, 20249.595008100052, 20252.898735506227, 21354.78645213528, 21501.6774748382, 21524.354269371943, 21609.0, 21714.89142554277, 18853.5859810512, 19467.026648667226, 19652.41042768719, 19666.90166549158, 19685.606287873878], "value": 12731.721245752227, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.972440551189, 1405.2201028429217, 1406.1000959385992, 1420.2188796162109, 1423.8291405031398, 13257.801132983013, 13917.582472525815, 13951.511697090604, 13965.092269002533, 13989.230592317419, 14351.425942962294, 14540.927295363535, 14607.0, 14655.487057952974, 14674.779878301833, 2649.1655128634466, 2727.2091093582935, 2731.4400547887735, 2732.180345896233, 2733.289344770354, 2618.2145356393103, 2677.0, 2706.715794841543, 2719.3473566344132, 2720.469508445854, 2615.738426157388, 2662.840229586231, 2666.013574977261, 2709.2549548874117, 2711.620373147761, 2618.188361607898, 2641.5905534642066, 2643.127767836609, 2644.854533000684, 2648.6424332715223, 2500.0749722602754, 2518.659980902573, 2519.5590771614893, 2523.7728604425506, 2534.2650631316897, 13513.391897364641, 13732.588022359345, 13740.244286564335, 13761.17432954026, 13775.655608609764, 7292.489525733201, 7563.168051514329, 7563.7352692655495, 7567.583782891938, 7586.279303466162, 5051.646384753069, 5093.490650934914, 5138.948610513922, 5247.10799164143, 5252.921206181911, 1762.7179651255738, 1781.3141940352928, 1784.1703607822294, 1813.8186181381889, 1824.2885274742862, 21976.230831920806, 22141.778582214294, 22185.889070554706, 22192.667109993203, 22192.778072219393, 6271.122042913996, 6498.0, 6593.670316484253, 6697.564658297292, 6748.177991942148, 15697.843021569639, 15730.764038539432, 15757.921210394104, 15759.212039397984, 15774.0535567864, 7297.197308296083, 7447.515911465737, 7506.24937506245, 7514.699412023567, 7534.736284230025, 5697.287839020122, 6044.214252147192, 6060.696965151725, 6063.302720187146, 6997.685104170325, 4957.975210123926, 5140.871478213, 5160.277561141368, 5201.843944681666, 5215.452377500384, 1498.5129832804382, 1513.9772903406458, 1518.32434566619, 1530.3419529602156, 1544.9150296733562, 878.7934835313696, 898.6135961536602, 902.7111324376136, 904.380499357942, 907.0158877617727, 7049.330313620198, 7184.748533801397, 8770.166834150745, 8906.59920303588, 8912.242459391024, 973.8636590877283, 995.9601615935426, 1011.8431643095332, 1017.2624846985876, 1031.6750223679517, 4847.733374664357, 5690.2887139107615, 5704.3154821421695, 5749.9425005750245, 5914.201582786269, 19250.903745481184, 19564.804351956584, 19648.60702785936, 19688.803111968984, 19735.40793776189, 18951.81048189528, 19028.429147125607, 19181.520461988563, 19191.616167676846, 19245.80754192468, 9994.0, 10861.294015888941, 10873.0, 10891.945540272249, 10960.616378426717, 8145.144759800372, 8579.485230886166, 8662.35032372562, 8750.51872147038, 8907.0, 16729.83270167283, 16871.156442178086, 16940.237689303765, 16946.152692365085, 17002.574935626708, 17141.14294285256, 17177.484675459757, 17196.39812606603, 17324.480265592054, 17333.653326933138, 10735.355878647306, 11057.723556911142, 11060.281081729661, 11063.170262230526, 11077.169212308949, 12701.301428421157, 12765.234085954873, 12822.422990965615, 12858.0, 12919.741605168032, 10791.946040269748, 10860.565577376816, 10873.075788557744, 10907.345559266469, 10943.069839063768, 10331.535080921227, 10346.172306215334, 10408.271421000458, 10433.0, 10580.36517808934, 9302.720918372459, 9479.0, 9479.526023698925, 9480.051994800464, 9489.66786162481, 7124.358807707331, 7125.216226215009, 7184.353408193288, 7229.204787473479, 7229.457790665616, 7190.245024272376, 7216.96391518039, 7267.491275610657, 7269.382102521134, 7299.197088320387], "value": 6379.500808614557, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.5702652745167, 505.9620528460364, 517.9456157103504, 532.2282690099357, 541.7995341723561, 6212.565120441571, 6235.536962899652, 6265.530085243614, 6340.714667839947, 6347.904781428282, 5933.3176684681275, 6105.633661980273, 6107.572469927107, 6154.0, 6228.314885362606, 4927.162382395001, 4940.777665005084, 4945.23348880924, 4986.127427700156, 4988.775505102279, 4820.783064762094, 4972.70163790172, 4977.178765503688, 4985.526374994388, 4998.5501304882555, 4890.0, 4958.305837182797, 4973.776180071887, 4976.975115124437, 4988.301637770715, 4878.634102442314, 4889.951100489021, 4914.582260507861, 4930.3344048553345, 4960.503949605047, 4444.488883778375, 4459.130469558438, 4471.2845944649025, 4475.865724028252, 4489.932651010237, 6060.545459090542, 6080.543959203033, 6090.634561926298, 6135.141080248769, 6153.784617538365, 5691.8292451226525, 5701.857453563653, 5721.456461636138, 5729.856753581152, 5744.195812586241, 6468.482521398277, 6517.934820651828, 6535.411812936811, 6539.93460065398, 6570.967145164243, 4787.593054590364, 4851.951480485221, 4874.46380898101, 4908.680935739166, 4921.827736029221, 6806.523543351967, 6862.730394876964, 6900.2064762552445, 6936.751384750743, 6980.16238051432, 4942.579880710108, 4944.728039957837, 4966.652334336634, 4992.0, 5002.774875130628, 5028.421731500851, 5075.187969924795, 5078.162103252996, 5103.923441148386, 5132.868041226774, 5669.574781891292, 5701.173329867146, 5724.284464441945, 5727.570432217517, 5741.282339707536, 6613.867722645617, 6633.402993730588, 6638.336166383323, 6679.432248258952, 6689.698963546554, 1673.5983363992555, 1676.740105283683, 1699.609089909303, 1711.7517959895745, 1733.202726745711, 1202.7955247607927, 1212.5089338817793, 1217.8782121787751, 1224.8547607986561, 1229.471327329239, 5664.716764161775, 5719.370869204384, 5805.187273781674, 5811.912821307684, 5839.270091238595, 6703.765368212089, 6728.327167283331, 6751.56114852533, 6775.762848300285, 6848.589084654936, 5820.748539064037, 5850.5612079094235, 5886.0, 5906.9537366903805, 5911.733971971185, 3564.982175089108, 3588.4258518637416, 3595.94606080909, 3614.8915532534065, 3648.175912043978, 6541.901871471931, 6562.326606715353, 6597.47220222381, 6608.702608382634, 6653.0, 6853.760118395832, 6912.55068420551, 6920.619365934821, 6963.6866341013765, 6969.965150174216, 6451.774187903401, 6517.110038088996, 6567.474602031826, 6588.011798230208, 6601.3728695773825, 6727.327267273234, 6729.932700673126, 6773.0, 6800.591964482147, 6837.863242735018, 6664.266930637723, 6720.420701135327, 6736.898946515708, 6768.4585233182215, 6788.151481064867, 6352.714127864165, 6489.528102465159, 6509.479241660751, 6592.307807680125, 6644.235912870082, 4956.72737999399, 4977.776000079933, 5004.47453017428, 5006.774695138654, 5038.496150384932, 6597.769078082244, 6630.46956243509, 6788.015737717905, 6797.524173307821, 6876.381125698511, 6189.843179978154, 6353.396427339396, 6383.457406120346, 6435.613863168225, 6459.321771213955, 6376.617402955838, 6422.614643121427, 6428.453581445442, 6473.287938326875, 6507.446867016357, 6309.264952138199, 6391.137196478416, 6409.230892292955, 6414.230292364946, 6453.9354606453335, 6405.423511883766, 6459.224893012869, 6482.254540727877, 6510.967445162744, 6550.639714815731, 6271.965125754382, 6308.306086330408, 6358.834963099177, 6362.809115726535, 6368.808935731936], "value": 5055.060728162657, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.3709159225934, 931.3573634192406, 948.6489998700482, 948.7296120605624, 953.7091187187905, 18566.814331856676, 19460.318888838876, 19475.0, 19599.314024009163, 21538.784612153875, 20878.164873405083, 21146.57706845862, 21308.0, 21528.8923555382, 21571.56856862862, 1013.579364563707, 1058.30680904008, 1058.7353161709573, 1061.8778840433333, 1063.420435862453, 954.2413781044052, 1031.7317497450642, 1047.5233768635253, 1047.596675280015, 1048.937063776172, 1118.1166878166239, 1118.9552417903315, 1119.28925132541, 1119.4738472917757, 1119.8096323625002, 1105.4804242006244, 1118.8433619293305, 1119.1158984402311, 1119.658504156232, 1121.4336759936261, 816.6325153680867, 817.0930267403178, 818.0592318833329, 820.0487434575863, 821.1706176761454, 17881.46355609334, 17982.460526184237, 18080.367187148386, 18840.246390144515, 20907.790922090888, 21539.784602153934, 21830.781692183034, 22271.665925011137, 22275.331740047663, 22276.220332288452, 16899.23953422099, 17052.48842534726, 17228.224729887184, 17254.56863578408, 17277.222524986406, 3615.4576813477925, 3637.7635453695425, 3659.743817932746, 3661.3226553087497, 3661.8901432957055, 125209.0, 125492.0, 126450.36774816159, 127552.36223818915, 128061.35969320094, 16615.08617026051, 16784.496465106065, 16838.073905935293, 16877.0, 16963.491095267163, 30883.536746948816, 30950.380992380025, 31047.534286985712, 31071.844640777104, 31654.683453165635, 7806.57063861493, 8063.919360806317, 8269.09040005599, 8574.528400938008, 8914.0, 3817.5609804872797, 3915.393114067324, 3939.940900886489, 3948.703847211413, 3952.0317522207242, 5182.663126896739, 5212.713300768418, 5297.894042119213, 5305.336832895888, 5318.803269264385, 1049.1344640671477, 1056.4823236614156, 1083.9241253112364, 1084.3602274657833, 1084.7776205877776, 682.3074579302013, 699.1994166679226, 705.2806137739477, 706.5372181221309, 713.3472872321768, 12103.33431661267, 12618.990480761517, 12719.364031798374, 12897.161684490478, 13451.46194152223, 647.6858723519184, 717.1752484642702, 720.3049057659384, 722.3967986731138, 725.1081170160732, 5639.718014099279, 5690.573207009491, 5837.7664893404635, 6005.009173486325, 6079.787207447718, 106608.0, 107125.0, 107924.0, 109883.90116098737, 109996.450017751, 90270.0, 94297.0, 95452.0, 96293.0370696298, 101045.99999999853, 81052.59473702594, 81561.0, 82059.0, 82718.80448318804, 85238.5738071318, 10133.18934485254, 10294.176465882862, 10353.4305613192, 10501.789964200825, 10607.045365917105, 37180.0, 37223.62776372202, 39599.60400396075, 39759.80120099381, 39974.60025399709, 70437.0, 71785.0, 72495.27504725097, 72912.63543682247, 76161.0, 20112.597748044664, 20452.181912723325, 20486.48783780358, 20797.79202208019, 20842.062107204907, 19577.80422195817, 19589.118489668283, 19667.80332196717, 20057.097430615948, 22007.339779806633, 19270.0, 19828.70256946176, 19900.70148947738, 20033.699494507302, 20329.6950545739, 19162.0, 19419.320323789165, 19488.317908873123, 19502.219911203392, 19680.40958771239, 15749.842501575296, 15969.840301596836, 15991.360345586047, 16269.918650406673, 16297.0, 13349.265790381234, 13605.523806666719, 13664.248466334448, 13787.103838250481, 14461.855381446472, 14881.553553393416, 15624.296906639001, 15668.843311566738, 16221.59446013859, 16279.51161465158], "value": 9291.872429603902, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 110.0, 110.0, 108.0, 108.0, 112.0, 115.0, 100.0, 108.0, 108.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 169.0, 190.0, 118.0, 159.0, 147.0, 123.0, 174.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 171.0, 173.0, 164.0, 169.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 172.0, 74.0, 74.0, 74.0, 91.0, 105.0, 75.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 136.0, 87.0, 79.0, 78.0, 124.0, 82.0, 78.0, 125.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 114.0, 114.0, 117.0, 115.0, 120.0, 119.0, 117.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 149.0, 152.0, 150.0, 152.0, 152.0, 151.0, 153.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 94.0, 102.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 53.0, 55.0, 55.0, 58.0, 53.0, 53.0, 59.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 57.0, 55.0, 55.0, 54.0, 55.0, 56.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 82.0, 79.0, 77.0, 96.0, 79.0, 79.0, 78.0, 84.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 119.0, 132.0, 126.0, 122.0, 128.0, 151.0, 121.0, 170.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 175.0, 171.0, 183.0, 178.0, 187.0, 192.0, 175.0, 173.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 72.0, 68.0, 69.0, 71.0, 67.0, 71.0, 76.0, 73.0], "value": 71.1, "unit": "score"}]}]} 16:09:13 INFO - Return code: 0 16:09:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:13 INFO - # TBPL SUCCESS # 16:09:13 INFO - Running post-action listener: _package_coverage_data 16:09:13 INFO - Running post-action listener: _resource_record_post_action 16:09:13 INFO - [mozharness: 2017-08-14 23:09:13.661248Z] Finished run-tests step (success) 16:09:13 INFO - Running post-run listener: _resource_record_post_run 16:09:13 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 429867008; Read time: 16; Write time: 390036 16:09:13 INFO - TinderboxPrint: CPU usage
13.2% 16:09:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:09:13 INFO - TinderboxPrint: I/O write bytes / time
429,867,008 / 390,036 16:09:13 INFO - TinderboxPrint: CPU idle
8,271.7 (86.8%) 16:09:13 INFO - TinderboxPrint: CPU user
1,204.4 (12.6%) 16:09:13 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106442752; Read time: 0; Write time: 124180 16:09:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:09:13 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 323424256; Read time: 0; Write time: 265856 16:09:14 INFO - Running post-run listener: _upload_blobber_files 16:09:14 INFO - Blob upload gear active. 16:09:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:14 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 16:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:14 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:09:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:09:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:15 INFO - (blobuploader) - INFO - Done attempting. 16:09:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:09:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:09:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:16 INFO - (blobuploader) - INFO - Done attempting. 16:09:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:09:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:09:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:17 INFO - (blobuploader) - INFO - Done attempting. 16:09:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:23 INFO - (blobuploader) - INFO - Done attempting. 16:09:23 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:23 INFO - Return code: 0 16:09:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9adc8c1db23ca1b28fa430b10c25974f803e32ff12d6713a2101bafcd54eba145cfaa59cd8565d577780ea7b5574a8a813bc4b6f088c68022b3d6942ffe6813b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9122ac16bf93468bb22d9357c7a3a0910dd7914d3c27f006c4718ed8b05fab47ca3066a30fb388a09a0df0ef39323f8298308a900a441e564c1d71f0a81e1951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbbcd17376a7763beff79d738afd6df8bc326a5056d8fcff077b78e8dad40bf38247ef7d8a705306f18ab467d4f274348a6b9399f7da02f5f01d0e7a8ba051c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d60e813d4f4bea3d99dd2709b905b7811da7b52795eaeeb287bea86b907bc9b335d0427a80b4c2469b82e26ace2d41e90be520dccd2ce72216dd50bf0c945a"} 16:09:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:23 INFO - Contents: 16:09:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9adc8c1db23ca1b28fa430b10c25974f803e32ff12d6713a2101bafcd54eba145cfaa59cd8565d577780ea7b5574a8a813bc4b6f088c68022b3d6942ffe6813b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9122ac16bf93468bb22d9357c7a3a0910dd7914d3c27f006c4718ed8b05fab47ca3066a30fb388a09a0df0ef39323f8298308a900a441e564c1d71f0a81e1951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbbcd17376a7763beff79d738afd6df8bc326a5056d8fcff077b78e8dad40bf38247ef7d8a705306f18ab467d4f274348a6b9399f7da02f5f01d0e7a8ba051c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d60e813d4f4bea3d99dd2709b905b7811da7b52795eaeeb287bea86b907bc9b335d0427a80b4c2469b82e26ace2d41e90be520dccd2ce72216dd50bf0c945a"} 16:09:23 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:23 INFO - Copying logs to upload dir... 16:09:23 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.957828 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-08-14 16:09:21.720293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 16:09:21.724075) ========= 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=1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9adc8c1db23ca1b28fa430b10c25974f803e32ff12d6713a2101bafcd54eba145cfaa59cd8565d577780ea7b5574a8a813bc4b6f088c68022b3d6942ffe6813b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9122ac16bf93468bb22d9357c7a3a0910dd7914d3c27f006c4718ed8b05fab47ca3066a30fb388a09a0df0ef39323f8298308a900a441e564c1d71f0a81e1951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbbcd17376a7763beff79d738afd6df8bc326a5056d8fcff077b78e8dad40bf38247ef7d8a705306f18ab467d4f274348a6b9399f7da02f5f01d0e7a8ba051c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d60e813d4f4bea3d99dd2709b905b7811da7b52795eaeeb287bea86b907bc9b335d0427a80b4c2469b82e26ace2d41e90be520dccd2ce72216dd50bf0c945a"} build_url:https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011800 build_url: 'https://queue.taskcluster.net/v1/task/D65EYMoBSGC1-IshLAOwxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9adc8c1db23ca1b28fa430b10c25974f803e32ff12d6713a2101bafcd54eba145cfaa59cd8565d577780ea7b5574a8a813bc4b6f088c68022b3d6942ffe6813b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9122ac16bf93468bb22d9357c7a3a0910dd7914d3c27f006c4718ed8b05fab47ca3066a30fb388a09a0df0ef39323f8298308a900a441e564c1d71f0a81e1951", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdbbcd17376a7763beff79d738afd6df8bc326a5056d8fcff077b78e8dad40bf38247ef7d8a705306f18ab467d4f274348a6b9399f7da02f5f01d0e7a8ba051c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d60e813d4f4bea3d99dd2709b905b7811da7b52795eaeeb287bea86b907bc9b335d0427a80b4c2469b82e26ace2d41e90be520dccd2ce72216dd50bf0c945a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 16:09:21.750892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 16:09:21.751210) ========= 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=1258088b6da462a47ba2cd90000001a2-1502749524.825871-1743483770 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 16:09:21.834997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 16:09:21.835385) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 16:09:21.835675) ========= ========= Total master_lag: 0.20 =========