builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1502819524.4 results: success (0) revision: 5ab5511100233277a760550ac509283278a0e3d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.398128) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.398576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.398848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.418041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.418346) ========= 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=ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 10:52:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-08-15 10:52:04 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.541764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.542056) ========= 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=ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016661 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.596160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.596486) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ab5511100233277a760550ac509283278a0e3d9 --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 5ab5511100233277a760550ac509283278a0e3d9 --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=ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 10:52:05,023 truncating revision to first 12 chars 2017-08-15 10:52:05,023 Setting DEBUG logging. 2017-08-15 10:52:05,023 attempt 1/10 2017-08-15 10:52:05,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ab551110023?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 10:52:05,319 unpacking tar archive at: mozilla-central-5ab551110023/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:05.221489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:05.224982) ========= script_repo_revision: 5ab5511100233277a760550ac509283278a0e3d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:05.225388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:05.225720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:05.237653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-15 10:52:05.238408) ========= /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=ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:05 INFO - MultiFileLogger online at 20170815 10:52:05 in /builds/slave/test 10:52:05 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 10:52:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:05 INFO - {'append_to_log': False, 10:52:05 INFO - 'base_work_dir': '/builds/slave/test', 10:52:05 INFO - 'blob_upload_branch': 'Firefox', 10:52:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:05 INFO - 'branch': 'Firefox', 10:52:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:05 INFO - 'code_coverage': False, 10:52:05 INFO - 'config_files': ('talos/linux_config.py',), 10:52:05 INFO - 'default_actions': ('clobber', 10:52:05 INFO - 'read-buildbot-config', 10:52:05 INFO - 'download-and-extract', 10:52:05 INFO - 'populate-webroot', 10:52:05 INFO - 'create-virtualenv', 10:52:05 INFO - 'install', 10:52:05 INFO - 'setup-mitmproxy', 10:52:05 INFO - 'run-tests'), 10:52:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:05 INFO - 'disable_ccov_upload': False, 10:52:05 INFO - 'download_minidump_stackwalk': True, 10:52:05 INFO - 'download_symbols': 'ondemand', 10:52:05 INFO - 'enable_stylo': False, 10:52:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:05 INFO - 'gecko_profile': False, 10:52:05 INFO - 'gecko_profile_interval': 0, 10:52:05 INFO - 'installer_path': 'installer.exe', 10:52:05 INFO - 'log_level': 'info', 10:52:05 INFO - 'log_name': 'talos', 10:52:05 INFO - 'log_to_console': True, 10:52:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:05 INFO - 'opt_config_files': (), 10:52:05 INFO - 'pip_index': False, 10:52:05 INFO - 'suite': 'dromaeojs-e10s', 10:52:05 INFO - 'system_bits': '32', 10:52:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:05 INFO - 'title': 'talos-linux64-ix-050', 10:52:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:05 INFO - 'use_talos_json': True, 10:52:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:05 INFO - 'work_dir': 'build'} 10:52:05 INFO - [mozharness: 2017-08-15 17:52:05.770124Z] Running clobber step. 10:52:05 INFO - Running pre-action listener: _resource_record_pre_action 10:52:05 INFO - Running main action method: clobber 10:52:05 INFO - rmtree: /builds/slave/test/build 10:52:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:07 INFO - Running post-action listener: _resource_record_post_action 10:52:07 INFO - [mozharness: 2017-08-15 17:52:07.313457Z] Finished clobber step (success) 10:52:07 INFO - [mozharness: 2017-08-15 17:52:07.313560Z] Running read-buildbot-config step. 10:52:07 INFO - Running pre-action listener: _resource_record_pre_action 10:52:07 INFO - Running main action method: read_buildbot_config 10:52:07 INFO - Using buildbot properties: 10:52:07 INFO - { 10:52:07 INFO - "project": "", 10:52:07 INFO - "product": "firefox", 10:52:07 INFO - "who": "ffxbld@noreply.mozilla.org", 10:52:07 INFO - "installer_path": "public/build/target.tar.bz2", 10:52:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:52:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:52:07 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:52:07 INFO - "stage_platform": "linux64-stylo", 10:52:07 INFO - "basedir": "/builds/slave/test", 10:52:07 INFO - "buildnumber": 33, 10:52:07 INFO - "platform": "ubuntu64_hw_stylo", 10:52:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:52:07 INFO - "slavebuilddir": "test", 10:52:07 INFO - "taskId": "OFcH0ZCeRnaSuU1WKO_tJw", 10:52:07 INFO - "branch": "mozilla-central", 10:52:07 INFO - "script_repo_revision": "production", 10:52:07 INFO - "revision": "5ab5511100233277a760550ac509283278a0e3d9", 10:52:07 INFO - "slavename": "talos-linux64-ix-050", 10:52:07 INFO - "repo_path": "mozilla-central" 10:52:07 INFO - } 10:52:07 INFO - Finding installer, test and symbols from parent task. 10:52:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OFcH0ZCeRnaSuU1WKO_tJw'}, attempt #1 10:52:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OFcH0ZCeRnaSuU1WKO_tJw'}, attempt #1 10:52:08 INFO - Task dependencies: YgRi8VxOQVeYwb_FbxWT9g 10:52:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g'}, attempt #1 10:52:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json 10:52:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip 10:52:08 INFO - Running post-action listener: _resource_record_post_action 10:52:08 INFO - [mozharness: 2017-08-15 17:52:08.658438Z] Finished read-buildbot-config step (success) 10:52:08 INFO - [mozharness: 2017-08-15 17:52:08.658660Z] Running download-and-extract step. 10:52:08 INFO - Running pre-action listener: _resource_record_pre_action 10:52:08 INFO - Running main action method: download_and_extract 10:52:08 INFO - mkdir: /builds/slave/test/build/tests 10:52: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')]} 10:52:08 INFO - trying https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json 10:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:52:09 INFO - Downloaded 989 bytes. 10:52:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:52:09 INFO - Using the following test package requirements: 10:52:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:52:09 INFO - u'common': [u'target.common.tests.zip'], 10:52:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:52:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:52:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:52:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:52:09 INFO - u'mozbase': [u'target.common.tests.zip'], 10:52:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:52:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:52:09 INFO - u'web-platform': [u'target.common.tests.zip', 10:52:09 INFO - u'target.web-platform.tests.tar.gz'], 10:52:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:52:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:52:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip 10:52:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:52:09 INFO - Fetch https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip into memory 10:52:10 INFO - Content-Length response header: 54002477 10:52:10 INFO - Bytes received: 54002477 10:52:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip 10:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:52:21 INFO - Fetch https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip into memory 10:52:23 INFO - Content-Length response header: 54002477 10:52:23 INFO - Bytes received: 54002477 10:52:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.talos.tests.zip 10:52:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:52:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.talos.tests.zip into memory 10:52:36 INFO - Content-Length response header: 14496050 10:52:36 INFO - Bytes received: 14496050 10:52: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')]} 10:52:36 INFO - trying https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:36 INFO - Downloading https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:52:39 INFO - Downloaded 61956701 bytes. 10:52:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:39 INFO - mkdir: /builds/slave/test/properties 10:52:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:39 INFO - Contents: 10:52:39 INFO - build_url:https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:39 INFO - Running post-action listener: _resource_record_post_action 10:52:39 INFO - Running post-action listener: set_extra_try_arguments 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.752075Z] Finished download-and-extract step (success) 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.752305Z] Running populate-webroot step. 10:52:39 INFO - Running pre-action listener: _resource_record_pre_action 10:52:39 INFO - Running main action method: populate_webroot 10:52:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'tests': ['damp', 'tps']}, 10:52:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:52:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:52:39 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:39 INFO - 'ts_paint', 10:52:39 INFO - 'tpaint', 10:52:39 INFO - 'sessionrestore', 10:52:39 INFO - 'sessionrestore_many_windows', 10:52:39 INFO - 'sessionrestore_no_auto_restore', 10:52:39 INFO - 'tabpaint']}, 10:52:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:52:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:52:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:39 INFO - 'tsvgr_opacity', 10:52:39 INFO - 'tart', 10:52:39 INFO - 'tscrollx', 10:52:39 INFO - 'tsvg_static']}, 10:52:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:52:39 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:39 INFO - 'talos_options': ['--mitmproxy', 10:52:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:39 INFO - '--firstNonBlankPaint'], 10:52:39 INFO - 'tests': ['tp6_google', 10:52:39 INFO - 'tp6_youtube', 10:52:39 INFO - 'tp6_amazon', 10:52:39 INFO - 'tp6_facebook']}, 10:52:39 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:39 INFO - 'talos_options': ['--stylo', 10:52:39 INFO - '--mitmproxy', 10:52:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:39 INFO - '--firstNonBlankPaint'], 10:52:39 INFO - 'tests': ['tp6_google', 10:52:39 INFO - 'tp6_youtube', 10:52:39 INFO - 'tp6_amazon', 10:52:39 INFO - 'tp6_facebook']}, 10:52:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:39 INFO - 'talos_options': ['--stylo', 10:52:39 INFO - '--stylo-threads=1', 10:52:39 INFO - '--mitmproxy', 10:52:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:39 INFO - '--firstNonBlankPaint'], 10:52:39 INFO - 'tests': ['tp6_google', 10:52:39 INFO - 'tp6_youtube', 10:52:39 INFO - 'tp6_amazon', 10:52:39 INFO - 'tp6_facebook']}, 10:52:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'talos_options': ['--xperf_path', 10:52:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:39 INFO - 'tests': ['tp5n']}}} 10:52:39 INFO - Running post-action listener: _resource_record_post_action 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.784480Z] Finished populate-webroot step (success) 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.784712Z] Running create-virtualenv step. 10:52:39 INFO - Running pre-action listener: _resource_record_pre_action 10:52:39 INFO - Running main action method: create_virtualenv 10:52:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:39 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 10:52:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:52:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:39 INFO - Using real prefix '/usr' 10:52:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:42 INFO - Installing pip.................done. 10:52:42 INFO - Return code: 0 10:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:52:42 INFO - Reading from file tmpfile_stdout 10:52:42 INFO - Output received: 10:52:42 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) 10:52:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:42 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:42 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 10:52:42 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 10:52:42 INFO - Using env: {'DISPLAY': ':0', 10:52:42 INFO - 'HOME': '/home/cltbld', 10:52:42 INFO - 'LANG': 'en_US.UTF-8', 10:52:42 INFO - 'LANGUAGE': 'en_US:en', 10:52:42 INFO - 'LOGNAME': 'cltbld', 10:52:42 INFO - 'MAIL': '/var/mail/cltbld', 10:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:42 INFO - 'MOZ_NO_REMOTE': '1', 10:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:42 INFO - 'NO_EM_RESTART': '1', 10:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:42 INFO - 'PWD': '/builds/slave/test', 10:52:42 INFO - 'SHELL': '/bin/bash', 10:52:42 INFO - 'SHLVL': '1', 10:52:42 INFO - 'TERM': 'linux', 10:52:42 INFO - 'TMOUT': '86400', 10:52:42 INFO - 'USER': 'cltbld', 10:52:42 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:42 INFO - '_': '/tools/buildbot/bin/python'} 10:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:42 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 10:52:42 INFO - Cleaning up... 10:52:42 INFO - Return code: 0 10:52:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:42 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:42 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 10:52:42 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 10:52:42 INFO - Using env: {'DISPLAY': ':0', 10:52:42 INFO - 'HOME': '/home/cltbld', 10:52:42 INFO - 'LANG': 'en_US.UTF-8', 10:52:42 INFO - 'LANGUAGE': 'en_US:en', 10:52:42 INFO - 'LOGNAME': 'cltbld', 10:52:42 INFO - 'MAIL': '/var/mail/cltbld', 10:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:42 INFO - 'MOZ_NO_REMOTE': '1', 10:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:42 INFO - 'NO_EM_RESTART': '1', 10:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:42 INFO - 'PWD': '/builds/slave/test', 10:52:42 INFO - 'SHELL': '/bin/bash', 10:52:42 INFO - 'SHLVL': '1', 10:52:42 INFO - 'TERM': 'linux', 10:52:42 INFO - 'TMOUT': '86400', 10:52:42 INFO - 'USER': 'cltbld', 10:52:42 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:42 INFO - '_': '/tools/buildbot/bin/python'} 10:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:43 INFO - Downloading/unpacking psutil>=3.1.1 10:52:43 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 10:52:43 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 10:52:43 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 10:52:43 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 10:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:44 INFO - Installing collected packages: psutil 10:52:44 INFO - Running setup.py install for psutil 10:52:44 INFO - building 'psutil._psutil_linux' extension 10:52:44 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 10:52:44 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 10:52:44 INFO - building 'psutil._psutil_posix' extension 10:52:44 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 10:52:44 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 10:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:44 INFO - Successfully installed psutil 10:52:44 INFO - Cleaning up... 10:52:44 INFO - Return code: 0 10:52:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:44 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:44 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 10:52:44 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 10:52:44 INFO - Using env: {'DISPLAY': ':0', 10:52:44 INFO - 'HOME': '/home/cltbld', 10:52:44 INFO - 'LANG': 'en_US.UTF-8', 10:52:44 INFO - 'LANGUAGE': 'en_US:en', 10:52:44 INFO - 'LOGNAME': 'cltbld', 10:52:44 INFO - 'MAIL': '/var/mail/cltbld', 10:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:44 INFO - 'MOZ_NO_REMOTE': '1', 10:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:44 INFO - 'NO_EM_RESTART': '1', 10:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:44 INFO - 'PWD': '/builds/slave/test', 10:52:44 INFO - 'SHELL': '/bin/bash', 10:52:44 INFO - 'SHLVL': '1', 10:52:44 INFO - 'TERM': 'linux', 10:52:44 INFO - 'TMOUT': '86400', 10:52:44 INFO - 'USER': 'cltbld', 10:52:44 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:44 INFO - '_': '/tools/buildbot/bin/python'} 10:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:52:44 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 10:52:44 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 10:52:44 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 10:52:44 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 10:52:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:52:46 INFO - Installing collected packages: mozsystemmonitor 10:52:46 INFO - Running setup.py install for mozsystemmonitor 10:52:46 INFO - Successfully installed mozsystemmonitor 10:52:46 INFO - Cleaning up... 10:52:46 INFO - Return code: 0 10:52:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:52:46 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')]} 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:46 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')]} 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:46 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:46 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 10:52:46 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 10:52:46 INFO - Using env: {'DISPLAY': ':0', 10:52:46 INFO - 'HOME': '/home/cltbld', 10:52:46 INFO - 'LANG': 'en_US.UTF-8', 10:52:46 INFO - 'LANGUAGE': 'en_US:en', 10:52:46 INFO - 'LOGNAME': 'cltbld', 10:52:46 INFO - 'MAIL': '/var/mail/cltbld', 10:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:46 INFO - 'MOZ_NO_REMOTE': '1', 10:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:46 INFO - 'NO_EM_RESTART': '1', 10:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:46 INFO - 'PWD': '/builds/slave/test', 10:52:46 INFO - 'SHELL': '/bin/bash', 10:52:46 INFO - 'SHLVL': '1', 10:52:46 INFO - 'TERM': 'linux', 10:52:46 INFO - 'TMOUT': '86400', 10:52:46 INFO - 'USER': 'cltbld', 10:52:46 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:46 INFO - '_': '/tools/buildbot/bin/python'} 10:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:46 INFO - Downloading/unpacking jsonschema==2.5.1 10:52:46 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 10:52:46 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 10:52:46 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 10:52:46 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 10:52:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:52:47 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 10:52:47 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 10:52:47 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 10:52:47 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 10:52:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:47 INFO - warning: no files found matching '*.txt' 10:52:47 INFO - no previously-included directories found matching 'build' 10:52:47 INFO - no previously-included directories found matching 'dist' 10:52:47 INFO - no previously-included directories found matching '.git*' 10:52:47 INFO - Installing collected packages: jsonschema, functools32 10:52:47 INFO - Running setup.py install for functools32 10:52:47 INFO - warning: no files found matching '*.txt' 10:52:47 INFO - no previously-included directories found matching 'build' 10:52:47 INFO - no previously-included directories found matching 'dist' 10:52:47 INFO - no previously-included directories found matching '.git*' 10:52:47 INFO - Successfully installed jsonschema functools32 10:52:47 INFO - Cleaning up... 10:52:47 INFO - Return code: 0 10:52:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:52:47 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')]} 10:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:47 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')]} 10:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:47 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:47 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 10:52:47 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 10:52:47 INFO - Using env: {'DISPLAY': ':0', 10:52:47 INFO - 'HOME': '/home/cltbld', 10:52:47 INFO - 'LANG': 'en_US.UTF-8', 10:52:47 INFO - 'LANGUAGE': 'en_US:en', 10:52:47 INFO - 'LOGNAME': 'cltbld', 10:52:47 INFO - 'MAIL': '/var/mail/cltbld', 10:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:47 INFO - 'MOZ_NO_REMOTE': '1', 10:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:47 INFO - 'NO_EM_RESTART': '1', 10:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:47 INFO - 'PWD': '/builds/slave/test', 10:52:47 INFO - 'SHELL': '/bin/bash', 10:52:47 INFO - 'SHLVL': '1', 10:52:47 INFO - 'TERM': 'linux', 10:52:47 INFO - 'TMOUT': '86400', 10:52:47 INFO - 'USER': 'cltbld', 10:52:47 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:47 INFO - '_': '/tools/buildbot/bin/python'} 10:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:52:48 INFO - Cleaning up... 10:52:48 INFO - Return code: 0 10:52:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:48 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')]} 10:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:48 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')]} 10:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:48 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:48 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 10:52:48 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 10:52:48 INFO - Using env: {'DISPLAY': ':0', 10:52:48 INFO - 'HOME': '/home/cltbld', 10:52:48 INFO - 'LANG': 'en_US.UTF-8', 10:52:48 INFO - 'LANGUAGE': 'en_US:en', 10:52:48 INFO - 'LOGNAME': 'cltbld', 10:52:48 INFO - 'MAIL': '/var/mail/cltbld', 10:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:48 INFO - 'MOZ_NO_REMOTE': '1', 10:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:48 INFO - 'NO_EM_RESTART': '1', 10:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:48 INFO - 'PWD': '/builds/slave/test', 10:52:48 INFO - 'SHELL': '/bin/bash', 10:52:48 INFO - 'SHLVL': '1', 10:52:48 INFO - 'TERM': 'linux', 10:52:48 INFO - 'TMOUT': '86400', 10:52:48 INFO - 'USER': 'cltbld', 10:52:48 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:48 INFO - '_': '/tools/buildbot/bin/python'} 10:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:48 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 10:52:48 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 10:52:48 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 10:52:48 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 10:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:50 INFO - Downloading docopt-0.6.1.tar.gz 10:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:50 INFO - Running setup.py install for blobuploader 10:52:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:50 INFO - Running setup.py install for requests 10:52:50 INFO - Running setup.py install for docopt 10:52:50 INFO - Successfully installed blobuploader requests docopt 10:52:50 INFO - Cleaning up... 10:52:50 INFO - Return code: 0 10:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:50 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')]} 10:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:50 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')]} 10:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:50 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:50 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 10:52:50 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 10:52:50 INFO - Using env: {'DISPLAY': ':0', 10:52:50 INFO - 'HOME': '/home/cltbld', 10:52:50 INFO - 'LANG': 'en_US.UTF-8', 10:52:50 INFO - 'LANGUAGE': 'en_US:en', 10:52:50 INFO - 'LOGNAME': 'cltbld', 10:52:50 INFO - 'MAIL': '/var/mail/cltbld', 10:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:50 INFO - 'MOZ_NO_REMOTE': '1', 10:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:50 INFO - 'NO_EM_RESTART': '1', 10:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:50 INFO - 'PWD': '/builds/slave/test', 10:52:50 INFO - 'SHELL': '/bin/bash', 10:52:50 INFO - 'SHLVL': '1', 10:52:50 INFO - 'TERM': 'linux', 10:52:50 INFO - 'TMOUT': '86400', 10:52:50 INFO - 'USER': 'cltbld', 10:52:50 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:50 INFO - '_': '/tools/buildbot/bin/python'} 10:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:50 INFO - Running setup.py (path:/tmp/pip-NuSwnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:50 INFO - Running setup.py (path:/tmp/pip-WSlWLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:51 INFO - Running setup.py (path:/tmp/pip-1UV0uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:51 INFO - Running setup.py (path:/tmp/pip-27uKth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:51 INFO - Running setup.py (path:/tmp/pip-BgmJyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:51 INFO - Running setup.py (path:/tmp/pip-3D88Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:51 INFO - Running setup.py (path:/tmp/pip-PjvQhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:51 INFO - Running setup.py (path:/tmp/pip-a5LT_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:51 INFO - Running setup.py (path:/tmp/pip-KKBMoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:51 INFO - Running setup.py (path:/tmp/pip-bYQQCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:51 INFO - Running setup.py (path:/tmp/pip-6OG2Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:51 INFO - Running setup.py (path:/tmp/pip-awYIhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:51 INFO - Running setup.py (path:/tmp/pip-3JDtO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:51 INFO - Running setup.py (path:/tmp/pip-tt5Z_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:51 INFO - Running setup.py (path:/tmp/pip-HQ9Z6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:52 INFO - Running setup.py (path:/tmp/pip-k9n3BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:52 INFO - Running setup.py (path:/tmp/pip-kUzh1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:52 INFO - Running setup.py install for manifestparser 10:52:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozcrash 10:52:52 INFO - Running setup.py install for mozdebug 10:52:52 INFO - Running setup.py install for mozdevice 10:52:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozfile 10:52:52 INFO - Running setup.py install for mozhttpd 10:52:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozinfo 10:52:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozInstall 10:52:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozleak 10:52:53 INFO - Running setup.py install for mozlog 10:52:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for moznetwork 10:52:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozprocess 10:52:53 INFO - Running setup.py install for mozprofile 10:52:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozrunner 10:52:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozscreenshot 10:52:53 INFO - Running setup.py install for moztest 10:52:53 INFO - Running setup.py install for mozversion 10:52:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:53 INFO - Cleaning up... 10:52:53 INFO - Return code: 0 10:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:53 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')]} 10:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:53 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')]} 10:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:53 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:53 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 10:52:53 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 10:52:53 INFO - Using env: {'DISPLAY': ':0', 10:52:53 INFO - 'HOME': '/home/cltbld', 10:52:53 INFO - 'LANG': 'en_US.UTF-8', 10:52:53 INFO - 'LANGUAGE': 'en_US:en', 10:52:53 INFO - 'LOGNAME': 'cltbld', 10:52:53 INFO - 'MAIL': '/var/mail/cltbld', 10:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:53 INFO - 'MOZ_NO_REMOTE': '1', 10:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:53 INFO - 'NO_EM_RESTART': '1', 10:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:53 INFO - 'PWD': '/builds/slave/test', 10:52:53 INFO - 'SHELL': '/bin/bash', 10:52:53 INFO - 'SHLVL': '1', 10:52:53 INFO - 'TERM': 'linux', 10:52:53 INFO - 'TMOUT': '86400', 10:52:53 INFO - 'USER': 'cltbld', 10:52:53 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:53 INFO - '_': '/tools/buildbot/bin/python'} 10:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:54 INFO - Running setup.py (path:/tmp/pip-bY3duv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:54 INFO - Running setup.py (path:/tmp/pip-hscD27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:54 INFO - Running setup.py (path:/tmp/pip-Es6DpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:54 INFO - Running setup.py (path:/tmp/pip-ZLGLpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:54 INFO - Running setup.py (path:/tmp/pip-XiYuyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:54 INFO - Running setup.py (path:/tmp/pip-jNqxub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:54 INFO - Running setup.py (path:/tmp/pip-m0QWLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:54 INFO - Running setup.py (path:/tmp/pip-hxoGKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:54 INFO - Running setup.py (path:/tmp/pip-rbn6av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:54 INFO - Running setup.py (path:/tmp/pip-t9oIZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:54 INFO - Running setup.py (path:/tmp/pip-6yBD6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:54 INFO - Running setup.py (path:/tmp/pip-gDuL6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:54 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)) 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:55 INFO - Running setup.py (path:/tmp/pip-olWOBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:55 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)) 10:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:55 INFO - Running setup.py (path:/tmp/pip-L0CCBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:55 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)) 10:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:55 INFO - Running setup.py (path:/tmp/pip-sqPKeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:55 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)) 10:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:55 INFO - Running setup.py (path:/tmp/pip-gNKdbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:55 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)) 10:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:55 INFO - Running setup.py (path:/tmp/pip-cNHFd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:55 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)) 10:52:55 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)) 10:52:55 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)) 10:52:55 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)) 10:52:55 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)) 10:52:55 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)) 10:52:55 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)) 10:52:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:56 INFO - Downloading blessings-1.6.tar.gz 10:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:56 INFO - Installing collected packages: blessings 10:52:56 INFO - Running setup.py install for blessings 10:52:56 INFO - Successfully installed blessings 10:52:56 INFO - Cleaning up... 10:52:56 INFO - Return code: 0 10:52:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:56 INFO - Reading from file tmpfile_stdout 10:52:56 INFO - Current package versions: 10:52:56 INFO - argparse == 1.2.1 10:52:56 INFO - blessings == 1.6 10:52:56 INFO - blobuploader == 1.2.4 10:52:56 INFO - docopt == 0.6.1 10:52:56 INFO - functools32 == 3.2.3-2 10:52:56 INFO - jsonschema == 2.5.1 10:52:56 INFO - manifestparser == 1.1 10:52:56 INFO - mozInstall == 1.13 10:52:56 INFO - mozcrash == 1.0 10:52:56 INFO - mozdebug == 0.1 10:52:56 INFO - mozdevice == 0.51 10:52:56 INFO - mozfile == 1.2 10:52:56 INFO - mozhttpd == 0.7 10:52:56 INFO - mozinfo == 0.10 10:52:56 INFO - mozleak == 0.1 10:52:56 INFO - mozlog == 3.5 10:52:56 INFO - moznetwork == 0.27 10:52:56 INFO - mozprocess == 0.25 10:52:56 INFO - mozprofile == 0.28 10:52:56 INFO - mozrunner == 6.13 10:52:56 INFO - mozscreenshot == 0.1 10:52:56 INFO - mozsystemmonitor == 0.3 10:52:56 INFO - moztest == 0.8 10:52:56 INFO - mozversion == 1.4 10:52:56 INFO - psutil == 3.1.1 10:52:56 INFO - requests == 1.2.3 10:52:56 INFO - wsgiref == 0.1.2 10:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52: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')]} 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:56 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:56 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 10:52:56 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 10:52:56 INFO - Using env: {'DISPLAY': ':0', 10:52:56 INFO - 'HOME': '/home/cltbld', 10:52:56 INFO - 'LANG': 'en_US.UTF-8', 10:52:56 INFO - 'LANGUAGE': 'en_US:en', 10:52:56 INFO - 'LOGNAME': 'cltbld', 10:52:56 INFO - 'MAIL': '/var/mail/cltbld', 10:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:56 INFO - 'MOZ_NO_REMOTE': '1', 10:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:56 INFO - 'NO_EM_RESTART': '1', 10:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:56 INFO - 'PWD': '/builds/slave/test', 10:52:56 INFO - 'SHELL': '/bin/bash', 10:52:56 INFO - 'SHLVL': '1', 10:52:56 INFO - 'TERM': 'linux', 10:52:56 INFO - 'TMOUT': '86400', 10:52:56 INFO - 'USER': 'cltbld', 10:52:56 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:56 INFO - '_': '/tools/buildbot/bin/python'} 10:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 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)) 10:52:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:52:57 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 10:52:57 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 10:52:57 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 10:52:57 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 10:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:52:58 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)) 10:52:58 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)) 10:52:58 INFO - Installing collected packages: simplejson 10:52:58 INFO - Running setup.py install for simplejson 10:52:58 INFO - building 'simplejson._speedups' extension 10:52:58 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 10:52:59 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 10:52:59 INFO - Successfully installed simplejson 10:52:59 INFO - Cleaning up... 10:52:59 INFO - Return code: 0 10:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:59 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')]} 10:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:59 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')]} 10:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:59 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 0x26b11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1eb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, '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': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', '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 10:52:59 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 10:52:59 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 10:52:59 INFO - Using env: {'DISPLAY': ':0', 10:52:59 INFO - 'HOME': '/home/cltbld', 10:52:59 INFO - 'LANG': 'en_US.UTF-8', 10:52:59 INFO - 'LANGUAGE': 'en_US:en', 10:52:59 INFO - 'LOGNAME': 'cltbld', 10:52:59 INFO - 'MAIL': '/var/mail/cltbld', 10:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:59 INFO - 'MOZ_NO_REMOTE': '1', 10:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:59 INFO - 'NO_EM_RESTART': '1', 10:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:59 INFO - 'PWD': '/builds/slave/test', 10:52:59 INFO - 'SHELL': '/bin/bash', 10:52:59 INFO - 'SHLVL': '1', 10:52:59 INFO - 'TERM': 'linux', 10:52:59 INFO - 'TMOUT': '86400', 10:52:59 INFO - 'USER': 'cltbld', 10:52:59 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:59 INFO - '_': '/tools/buildbot/bin/python'} 10:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:52:59 INFO - Cleaning up... 10:52:59 INFO - Return code: 0 10:52:59 INFO - Running post-action listener: _resource_record_post_action 10:52:59 INFO - Running post-action listener: _start_resource_monitoring 10:52:59 INFO - Starting resource monitoring. 10:52:59 INFO - [mozharness: 2017-08-15 17:52:59.626428Z] Finished create-virtualenv step (success) 10:52:59 INFO - [mozharness: 2017-08-15 17:52:59.626952Z] Running install step. 10:52:59 INFO - Running pre-action listener: _resource_record_pre_action 10:52:59 INFO - Running main action method: install 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:59 INFO - Reading from file tmpfile_stdout 10:52:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:59 INFO - Reading from file tmpfile_stdout 10:52:59 INFO - Output received: 10:52:59 INFO - Usage: mozinstall [options] installer 10:52:59 INFO - Options: 10:52:59 INFO - -h, --help show this help message and exit 10:52:59 INFO - -d DEST, --destination=DEST 10:52:59 INFO - Directory to install application into. [default: 10:52:59 INFO - "/builds/slave/test"] 10:52:59 INFO - --app=APP Application being installed. [default: firefox] 10:52:59 INFO - mkdir: /builds/slave/test/build/application 10:52:59 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'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:53:17 INFO - Reading from file tmpfile_stdout 10:53:17 INFO - Output received: 10:53:17 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:17 INFO - Running post-action listener: _resource_record_post_action 10:53:17 INFO - [mozharness: 2017-08-15 17:53:17.972564Z] Finished install step (success) 10:53:17 INFO - [mozharness: 2017-08-15 17:53:17.972933Z] Running setup-mitmproxy step. 10:53:17 INFO - Running pre-action listener: _resource_record_pre_action 10:53:17 INFO - Running main action method: setup_mitmproxy 10:53:17 INFO - Skipping: mitmproxy is not required 10:53:17 INFO - Running post-action listener: _resource_record_post_action 10:53:17 INFO - [mozharness: 2017-08-15 17:53:17.974092Z] Finished setup-mitmproxy step (success) 10:53:17 INFO - [mozharness: 2017-08-15 17:53:17.974315Z] Running run-tests step. 10:53:17 INFO - Running pre-action listener: _resource_record_pre_action 10:53:17 INFO - Running pre-action listener: _set_gcov_prefix 10:53:17 INFO - Running main action method: run_tests 10:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:17 INFO - Python 2.7.3 10:53:17 INFO - Return code: 0 10:53:17 INFO - grabbing minidump binary from tooltool 10:53: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')]} 10:53:17 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 0x2a21f00>, '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 0x2a1cba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1d050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:17 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 10:53:17 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 10:53:17 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 10:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:18 INFO - Return code: 0 10:53:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:18 INFO - ENV: RUST_BACKTRACE is now full 10:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:18 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/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:53:18 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/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 10:53:18 INFO - Using env: {'DISPLAY': ':0', 10:53:18 INFO - 'HOME': '/home/cltbld', 10:53:18 INFO - 'LANG': 'en_US.UTF-8', 10:53:18 INFO - 'LANGUAGE': 'en_US:en', 10:53:18 INFO - 'LOGNAME': 'cltbld', 10:53:18 INFO - 'MAIL': '/var/mail/cltbld', 10:53:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:18 INFO - 'MOZ_NO_REMOTE': '1', 10:53:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:18 INFO - 'NO_EM_RESTART': '1', 10:53:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:18 INFO - 'PWD': '/builds/slave/test', 10:53:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:18 INFO - 'RUST_BACKTRACE': 'full', 10:53:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:53:18 INFO - 'SHELL': '/bin/bash', 10:53:18 INFO - 'SHLVL': '1', 10:53:18 INFO - 'STYLO_FORCE_ENABLED': '1', 10:53:18 INFO - 'TERM': 'linux', 10:53:18 INFO - 'TMOUT': '86400', 10:53:18 INFO - 'USER': 'cltbld', 10:53:18 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730', 10:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:18 INFO - '_': '/tools/buildbot/bin/python'} 10:53:18 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/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 10:53:18 INFO - mozversion application_buildid: 20170815170214 10:53:18 INFO - mozversion application_changeset: 5ab5511100233277a760550ac509283278a0e3d9 10:53:18 INFO - mozversion application_display_name: Nightly 10:53:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:18 INFO - mozversion application_name: Firefox 10:53:18 INFO - mozversion application_remotingname: firefox 10:53:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:53:18 INFO - mozversion application_vendor: Mozilla 10:53:18 INFO - mozversion application_version: 57.0a1 10:53:18 INFO - mozversion platform_buildid: 20170815170214 10:53:18 INFO - mozversion platform_changeset: 5ab5511100233277a760550ac509283278a0e3d9 10:53:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:53:18 INFO - mozversion platform_version: 57.0a1 10:53:18 INFO - using testdate: 1502819598 10:53:18 INFO - actual date: 1502819598 10:53:18 INFO - starting webserver on 'localhost:50046' 10:53:18 INFO - SUITE-START | Running 2 tests 10:53:18 INFO - TEST-START | dromaeo_css 10:53:18 INFO - Initialising browser for dromaeo_css test... 10:53:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50046/getInfo.html -profile /tmp/tmpKT4E8g/profile 10:53:18 INFO - TEST-INFO | started process 19736 (/builds/slave/test/build/application/firefox/firefox http://localhost:50046/getInfo.html) 10:53:24 INFO - TEST-INFO | 19736: exit 0 10:53:24 INFO - Browser initialized. 10:53:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:24 INFO - TEST-INFO | started process 19972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT4E8g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:25 INFO - PID 19972 | 10:53:25 INFO - PID 19972 | (/builds/slave/test/build/application/firefox/firefox:20026): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:53:25 INFO - PID 19972 | 10:53:35 INFO - PID 19972 | RSS: Main: 166825984 10:53:35 INFO - PID 19972 | 10:56:33 INFO - PID 19972 | Cycle 1(1): loaded http://localhost:50046/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50046/tests/dromaeo/cssquery-ext.html) 10:56:35 INFO - PID 19972 | RSS: Main: 174649344 10:56:35 INFO - PID 19972 | 10:59:37 INFO - PID 19972 | Cycle 1(1): loaded http://localhost:50046/tests/dromaeo/cssquery-ext.html (next: http://localhost:50046/tests/dromaeo/cssquery-jquery.html) 10:59:37 INFO - PID 19972 | RSS: Main: 172290048 10:59:37 INFO - PID 19972 | 11:02:39 INFO - PID 19972 | Cycle 1(1): loaded http://localhost:50046/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50046/tests/dromaeo/cssquery-mootools.html) 11:02:40 INFO - PID 19972 | RSS: Main: 173244416 11:02:40 INFO - PID 19972 | 11:05:42 INFO - PID 19972 | Cycle 1(1): loaded http://localhost:50046/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50046/tests/dromaeo/cssquery-prototype.html) 11:05:42 INFO - PID 19972 | RSS: Main: 172994560 11:05:42 INFO - PID 19972 | 11:08:46 INFO - PID 19972 | Cycle 1(1): loaded http://localhost:50046/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50046/tests/dromaeo/cssquery-yui.html) 11:08:47 INFO - PID 19972 | RSS: Main: 176181248 11:08:47 INFO - PID 19972 | 11:11:48 INFO - PID 19972 | Cycle 1(1): loaded http://localhost:50046/tests/dromaeo/cssquery-yui.html (next: http://localhost:50046/tests/dromaeo/cssquery-dojo.html) 11:11:49 INFO - PID 19972 | RSS: Main: 174993408 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | __start_tp_report 11:11:49 INFO - PID 19972 | _x_x_mozilla_page_load 11:11:49 INFO - PID 19972 | _x_x_mozilla_page_load_details 11:11:49 INFO - PID 19972 | |i|pagename|runs| 11:11:49 INFO - PID 19972 | |0;dojo.html;3104.1153271317694;3145.6382516010635;3148.071318960907;3173.7778355515115;3192.9361412771746;6035.124906888498;6218.906716399258;6219.657918814469;6220.315765265823;6230.283517395501;6026.216591843055;6123.969380153093;6130.969345153279;6140.938590614092;6141.539384546166;5599.740058486838;5638.210650508932;5646.717664116798;5673.404292549285;5687.829365119053;5678.858028549299;5729.828105156852;5771.3074431068335;5784.479396854283;5820.767169313243;5513.09034009388;5566.610337276392;5673.6879471629045;5703.31560212775;5720.742566584493;5599.972000140014;5611.6352437091455;5670.3479099903625;5687.943120568824;5711.971440142815;5520.033994051025;5587.38538760736;5600.4959553640365;5664.0937450007805;5674.858128546819;6057.485113765335;6070.089486577004;6070.6357618543025;6096.1770161028135;6096.878062438771;6505.0892874997535;6561.245456772484;6573.93426065738;6589.637569933651;6591.505637077191;6657.367550082734;6741.898871516931;6759.290274521203;6766.2895395983205;6771;6175.413335733098;6193.9070913935875;6232.501399887998;6268.529860260499;6270.31026587075;6705.530612857151;6801.5238933274195;6822.147231596051;6851.040854280404;6910.101686780787;6400.583962042452;6412.038194270804;6422.004589288667;6427;6444.871102577922;6441.840468715676;6507.251666058464;6518.087467754518;6520.576162549419;6547.148870646785;6440.323766004502;6448.580842245239;6512.92536731434;6527.510436717265;6543.607383557001;6466.288708242089;6569.770058047945;6573.1783527059115;6609.239937407164;6701.932980670228;5284;5293.497117773805;5298.496642818926;5307.363116426053;5335.359756829128;4514;4530.365748795171;4558.088382323548;4565.817367305337;4575.428071491064;5711.257536520309;5714.7428365723645;5784;5787.536997040227;5788.450097240755;6471.126397936312;6537.673116344164;6573.276939536647;6603.471722262208;6620.933790662128;5714.79998200061;5729.7708091676695;5758.107493338539;5759.452851979056;5768.625039372511;5827.388124246893;5841.094630332305;5904.645721256738;5913.05391137416;5920.940790592125;6269.185005949289;6458.870822583522;6550.508711846631;6551.017347397833;6564.967175164189;6575.342465753386;6613.768518101843;6687.297833727584;6706.899396509154;6724.361185687352;6454.612723236621;6496;6502.349765023649;6505.447037001908;6527.249366322933;6507.349265073455;6512.218533775787;6526.412622863965;6596.373344532261;6616.503762217757;6476.481881449378;6585.539012269095;6589.703463344257;6610.140681711347;6676.532642714963;6358.841028974312;6385.808425747049;6392.3927226913365;6426.518011149276;6429.58207716497;6340.714667839866;6350.68246587678;6400;6409.935900640934;6411.6153030818305;6244.718987645658;6341.048842673636;6348.873022539431;6360.236771587439;6398.616083035033;6486.967565162144;6499.025146227915;6527.836804079936;6531.281559028408;6565.343465653396;6335.2714437838395;6397.488200943821;6410.326915673787;6411.51913606472;6417.871642567029 11:11:49 INFO - PID 19972 | |1;ext.html;770.710983381232;818.6438899078905;833.8582440985034;858.5149390594318;862.0689655172416;38555.42166867499;38995;39278.60721392789;39342.8032859836;39427.605723942754;36350.454743178874;36513;36519.4522082169;36590.08524786882;36678.449823252675;6564.310747371529;6671.199456065255;6679.165104361955;6680.799576012703;6682.799516014527;6599.076129341896;6622.139121914144;6646.0363247329105;6687.632180230085;6690.230623478289;6664.333566643345;6679.799606011828;6691.464682825386;7324.267573242686;7564.886526702104;7408.481406301561;7418.332350088518;7423.480356375056;7428.554286742813;7431.628418579076;6834.9658251708925;6925.930740692579;6945.444364450832;6960.65196740161;7187.964060179718;36436.45345319822;36781.26437471262;36874;36880.44679329812;36989.07527311839;3106.3631955449077;3108.9067327980197;3109.2693217093965;3119.251379668886;3226.6612005739294;29728.8513557433;29859;29922.551161732375;29961;29985.250368740737;4968.180250258703;4994;5017.2724954881705;5036.043151801146;5037.49625037497;217346;218207;218806;221071;221757.23849665344;47660.76169619199;47734.522654773704;47799;47831.5216847834;48057.75971120192;48670.513294867305;48678.75660621674;48689.5131048685;48724.75637621789;48747;14870.851291486946;15051.322690478955;15087.773683394758;15095.924520377328;15100.39598416051;12211.168324751181;12259.816102758467;12264.264144151379;12335.321557314433;12348.567800127132;13932.651683707989;13985.650358741113;14103.435862565382;14248.216348100746;14318.85681143196;5588.161775733591;5655;5710;5862.355140934494;5919.112133180058;984.9704508864745;989.7426669066094;1010.7068950004416;1013.0983424751829;1020.3112898793285;22655.52739071988;28671;28741.856290718413;29170.708292917225;29382.853085734434;1086.820674588684;1088.7223757941833;1098;1098.6154845803906;1099.8020356335937;12342.506299748089;12463.252204867737;12476.875231247572;12585.496580136693;15394.538163855103;227271;229162;229293;229637;229717;53595;53853.461465385626;54068.45931540634;54266;57493.425065749645;1437.4781784627703;1471.3231913319992;1474.793528905954;1478.1057460236616;1492.2315007771006;26839.56724883161;26972.730272697023;27382;27403;27747.44505109927;36173.27653446969;36836.81581592075;36850.63149368472;36907;36964.63035369612;210352;211391;211698;211935;213000;32565.34869302648;33553.66446335505;33641.15897102494;33871;33886.322273554884;41685.79157104195;42140.578594213664;42467;42500.362494563225;42623.57376426196;31348;31675.20811979719;34127.82936085304;35000.29999399947;35389.29221415506;33593.83203083969;33780.324393512485;34058;34158;34362.484562732076;37000;38083.428748568236;38156.6184338153;38189.4271585932;38452.80773596114;32156.67843321537;32744.672553275115;33055.33889322152;33066.834665826515;33294.16764580808;22857.88571057134;24259.150929717376;24817.50364992726;24884;24884.87557562273 11:11:49 INFO - PID 19972 | |2;jquery.html;548.7625404712373;559.8488408129805;571.9116769444996;579.0763731847703;594.6313285762827;21798.89100554497;22632.321030369094;22734.88632556835;22736.88631556842;22962.655560166568;26282.211533654023;26736.5989510157;26881.193564193105;26883.865580672118;26993.86503067482;6505.056766768816;6672.833179170511;6679.766208182715;6681.53229273951;6696.698648560802;6154.784582539612;6388.201474815648;6417.358264173568;6444.452221561173;6510.056041873925;6368.808935731936;6377.07532407803;6383.553151279412;6401.199850018747;6403.135576697133;6370.108184854147;6371.171747672819;6372.1397611322345;6386.87226255477;6399.552031357784;5873.412658734135;5948.167256584038;5960.374160713106;5967.522598192134;5970.402959704038;29104;29987.850060749774;30459.543106853416;30740.53889191664;30935.226619334473;1939.660559402099;1968.3209292793963;1968.4094771568473;1978.8911609861452;1979.1687491253708;18550.072496375127;19055.61888762217;19100.90449547757;19174;19182.616347672967;2346.624540073597;2351.318117745852;2405.4707964248014;2409.1929203716777;2422.8061755059553;129300;131436.34281828624;132222.3388883059;132470;133293;14695;15299.311530981133;15300.387984480718;15401.460948866736;15706.21468926572;23428.297151085495;23762.168324108574;23783;23869.16457923999;24080;10441.634542790965;10628.734281642866;10637.361758294526;10720.142388608892;10945.288556243819;10102.09081182697;10153.187744980383;10181.440020798927;10255.7436064099;10259.846102308471;9404.435733855991;9492.477913714813;9672.08115229052;9686;9730.318877678494;2599.753023462768;2685.9059932902255;2758.917232483029;2765.629597123643;2794.3153927287944;952.1430712358932;952.9809403812023;963.9614415423305;969.5007071358256;976.1605019683067;19485.805141948684;19738.901305493382;19869.403917882486;20517.89741051285;24072.87963560171;1007.7984403119406;1031.9535620896927;1036.383351905615;1039.3711804358406;1041.4220107840222;10935.234533582572;11546.751821175465;11583.07335413165;13322.866771332356;14733.336999835034;500593;518547;522128;526270;527192;120264;121790;124911.3754431222;128614.99999999812;128665;1250.8061250506187;1291.9547815826402;1302.2837439408288;1304.4586496603804;1304.5760127958451;20733.377998660064;20815.8959205203;20992.580148397254;21075.8946205268;21558.461038473535;57381.71309143428;59824.70087649534;60938.69530652319;61182.38817611767;63458.68270658617;69323;69782.30217697758;69912.30087699057;70358.64820675863;70468.64765676139;14766.187859667822;15229;15309.387624494895;15321.310541025457;15360.078395296317;23937.52124957526;23987.160449384188;24000.87999559991;24278.39304017343;24453.755462445148;18917.90541047341;18921;19096.23615055382;19111.235550578378;19250.22999080021;15475.071495710294;16913.985160890385;17303.480895573153;17882.463526094238;18042.819571804113;18522;19314.7102793461;19387.127579258686;19549;19596.11817468246;14932.328045238208;15088.094714316738;15109.622259443602;15136.394544218108;15137.394504220149;17738.379156729454;18537.44387668372;18653;18694.53263668365;18823.90588047051 11:11:49 INFO - PID 19972 | |3;mootools.html;1385.3765805387575;1426.1300606629954;1431.0626539616549;1437.6334034821118;1463.8609332113444;13990.440382384706;15016;15028.624284392896;15046.322915468803;15049.172295523742;14764.852351476482;15027.92486037571;15028.774568381483;15090.320935557898;15112.546623601282;2674.304680782996;2729.495043416964;2751.5184842652557;2756.104266113511;2758.089830355988;2645.7883369330502;2681.410089780255;2745.3548416122194;2745.6705195376485;2747.3269049083;2634.565296726038;2706.729327067297;2707.4991126641535;2710.7966902482294;2712.9593056104172;2547.847129172256;2574.781143602796;2591.5464793661035;2594.4940736556377;2602.141293373182;2422.333858189012;2465.3590066582638;2505.473850491399;2507.2728908616477;2517.483915797257;14312.92843535786;14408.783868241984;14507.129572225595;14518;14526;7349.081364829396;7579.279968402993;7591.696332146707;7603.619819009027;7616.428767842379;5123.615728820353;5201.323827902386;5256.106461901486;5279.287296215039;5291.100512912814;1811.5380577952537;1905.2759951218586;2271.341311019802;2379.619260918262;2397.137030668958;24428.63357049646;24860.627090593836;24872.3781905452;24903.50192996148;24945.750542494705;6712.844962867444;6881.965590172117;6912.792616221522;7062.823429414203;7105.111861017373;19279.51801204953;19378.70931936022;19379;19380.224791008484;19386.224551018084;7530.548167109991;7643.9617801911745;7651;7661.731839385595;7670.654820533089;6920.411764999931;6924.030635711005;7027.683754231072;7196.460265480006;7255.347018768336;4813.855584332476;4954.256861470736;4986.376702912136;4998.975005124951;5011.223260394645;1409.8026276321323;1440.8559144085718;1442.1707518176881;1464;1465.4870795221586;884.8274586455708;918.8897332320164;925.1812146250483;931.5621657820814;931.7670582354411;7262.891056634155;7309.159446663595;7336.303051210127;7374.225706300868;7416.295451932166;702.4380495603497;711.4130842055325;719.7516856684435;721.2030706069822;722.7506510253954;4457.799399026987;4482.798274077674;5634.352049514277;5734.655920644775;6002;19610.901945490183;19641.607167856848;19929.00354982245;20013.39959801208;20130.496737581678;19044.428667140008;19711.60576788456;19840.60318793616;19974.60050798976;19978.400647980583;10917.23579349438;11074.667759967213;11440.94279528597;11480.942595286802;11497.827532587018;8362.623681934207;8402.915970840213;8464.746057618282;8473.95763021181;8642.308615310634;17063.317467301167;17074.14629268507;17323.826761732726;17421.88827050043;18001.639967200845;17869.374571889923;17871.73192402141;18037.82754120978;18269.08654567293;18288.90855545714;11029.779404412027;11775.587854425054;11856.22934509254;11872.703182420508;11913.523459061887;13127.343632818513;13135.605931822061;13142.540011099565;13182.80225796633;13257.07200495956;11025.338479691245;11035.944820275847;11040.889591103985;11338.773224535627;11355.091592672401;10496.05535501778;10542.15662746963;10557.419341936267;10569.101626361846;10729.9463502682;9372.203362714246;9429.3399462037;9527.38072025316;9533.523323833642;9538.666146684833;7268.636568171676;7329.193788683134;7385.446091543048;7387.741429049957;7412.592307423143;7159.534630249017;7184.6048467334795;7251.601161936144;7292.708291668274;7432.888506672512 11:11:49 INFO - PID 19972 | |4;prototype.html;492.16937214495726;498.4971052618589;517.7877070401131;517.8886539394031;523.2831021500544;6219.657918814463;6285.151504546885;6285.937140628593;6316.021016742407;6371.713272902719;5910.615809972349;6015.9699201504045;6028.42729940656;6093.969530152354;6108.869859076063;4824.9493965064885;4853.752966154615;4886.706797592155;4887.804487820483;4907.656464047518;4858.659893807418;4862.124817532843;4890.877728056809;4926.876828079308;4958.404991401037;4694.155052090622;4827.541383568555;4864.586510146642;4891.505332280545;4956.504349565051;4853.150698627761;4859.829905953275;4871.29366241893;4878.438979517347;4912.901741965141;4346.195953748566;4352.086061926999;4361.538884473705;4377.212101821671;4378.978105109454;6066.816970690717;6079.756809727605;6108.267007959073;6152.292486364081;6165.32181460039;5620.522255608237;5650.220180643084;5674.659520428788;5676.233708449389;5692.943070569324;6453.805026732614;6535.607863528204;6536.150300460909;6584.02479256226;6619.503537234678;4758.072175925696;4774.856754297377;4819.987802561466;4822.397200349957;4836.975815120937;6808.2510923798345;6834.214065382445;6917.377436030782;6929.648718499894;7031.859362812766;4877.097736918681;4880.41435027799;4886.340344053508;4931.334269873521;4939.975300123549;4995.9500404996215;4997.100521906092;5014.774335154927;5023.618504911179;5032.924506132411;5616.831495055155;5662.03745363281;5672.914906276409;5680.4319568042865;5706.28671416073;6532.444742196966;6550.475961923034;6561.475081993429;6589.9341006590275;6691.866162676816;1675.31312162013;1681.529171831889;1713.922873470697;1729.9135043247786;1764.7176451767655;1176.4353110507004;1178.5403692559908;1184.7689700508317;1195.7668254690425;1199.4302706214653;5790.452201031532;5821.18503409523;5825;5848.970755146197;5854.648721076749;6593.175853018372;6682.699278532477;6687.598744075371;6744.6627668616375;6768.323167683291;5805.419458054161;5818.6217895836635;5824.534037277008;5870.970645146747;5874.383189765099;3580.2839432113683;3582.194006348551;3603.56757189139;3605.531280933462;3651.1419816343137;6508.926027205553;6550.475961923034;6558;6579.24338701046;6582.506312026617;6925.342092501305;6950.895736563955;6968.268331825187;6977.197622273504;6981.743286208532;6561.540692151599;6568.474522038226;6572.375624315682;6601.240857301472;6622.3113106157625;6800.973566762743;6801.183857936881;6851.314868513308;6860.794176174722;6885.51801373899;6628.668566571749;6697.899531506934;6698.062271282122;6759.695813688494;6852.280510546321;6575.24384695747;6593.769218077345;6598.37315455031;6613.603183808987;6621.1392518972225;4974.900501989868;4978.651494395358;4985;5014.473480284518;5030.522100400456;6683.732650693918;6740.314921269683;6748.4693240034985;6818.829244401377;6877.931220687729;6492.48060155177;6512.706928188148;6516.543841931019;6609.339066093352;6611.702473388806;6483.935160648333;6502.60984340941;6563.835904102436;6597.50518711089;6607.108040414675;6236.563440559117;6237.844053898507;6473.928342930217;6498.512611554247;6511.902321465276;6503.154589903283;6535.836604084936;6553.606783592809;6600.60396376219;6662.400383965466;6350.650714210763;6390.808275751735;6411.455026322815;6419.743210271537;6442.130312407952 11:11:49 INFO - PID 19972 | |5;yui.html;906.4697152165982;920.8434566123763;927.823713494436;931.9114684105016;935.7239614313777;16511.256993435294;17157.742633860486;17242.39651612194;17246.310147594097;21500;20402.285919992803;21184;21399.144034238652;21429.892850535725;21433.464163395885;1033.1889466768569;1064.7604289034982;1069.3476979042778;1070.8072546941548;1073.0878753059876;975.5024937281967;1060.5704689600725;1069.4064794039305;1069.983950240747;1070.71626019105;1110.0619976120165;1116.4250411038322;1119.4458742922266;1120.1318977792196;1120.2326406411635;1109.8668159820834;1115.4980258883495;1117.1007339092027;1117.4692021289904;1118.2675347647305;811.809224832164;817.2318021060184;817.337956255435;817.9591020449013;818.1368656067846;19320.71018934717;19332;19528.804711952842;19578.21687132513;19688.90155549213;20861.58276834455;21097;21181.36455906325;21203.151873925024;21339.039743211437;16201.837981620269;16427.342906283735;16525.83474165255;16594.336226550924;16656.75014874778;3615.511905892697;3629.764065335771;3644.671979521856;3650.4159334506353;3659.1218107654236;131442;133261;135298.999999999;136398;137912;15764.527064187863;16067.919660401856;16374.83625163757;16413.58966025835;16703;27568.44863102767;27851.164465066082;28002.159935201977;28300.15099547017;28444.573331400046;7465.253474652492;7692.46152769312;8606.526641034678;8626.784330391665;8923.330750193762;4109.383592461095;4205.306124489486;4209.074003719177;4216.915661686749;4223.936640950388;5143.948560514422;5239.371275446971;5239.633225674243;5267.920981185285;5316.494932981361;1015.7714514234239;1032.8812186598486;1050.5535147562255;1051.458498873081;1054.393723608928;672.8889733194067;685.7291369908858;686.3994005245411;690.3855568544;706.3148745716646;11228.831567526493;11690.70773230659;11692.532298708127;12242.938785306016;12819.743605128031;679.751890559942;680.4590350671228;693.8022663540968;700.7897630710767;706.5336877660822;5725.77096916127;5781.046127388934;6148.938510614837;6182.412670796267;6202.007678771465;109619;110911.44544277227;112259.4387028076;116521.41739291418;116891;95764;100965;101434.49282753539;102275;105144;84971;87240;87643;98350;101796;11510.884891150981;12151.635450936486;12489.625311240678;12494.37528123572;13364.866351336363;40728;41013.58986410217;41020.79489602533;42133.57866421297;42875;50409.49590504048;50600.49399506105;51454.22818657648;51857.481425185266;52912;18606.627867442305;18610.34863779761;18831.340903068874;19018.42944711661;19265.325713599956;21423.67864482003;21698.89150554237;21794.455138621663;21843;21919.67120493162;17489.125543722508;17651.470455885832;17872.55318617045;17942.910285448488;17962;16969.575760606083;17020.914895425445;17088.487345379657;17093.401730939855;17182.570435739206;17911;18369.908150459163;18475.260989560265;18526.814731852508;18768.7184692227;13184.40670169864;13419.26194059297;13562.489070970078;13695.794563081363;14117.08238964464;13852.445902163801;14010.929945350208;14115.576532704035;14118.576442706735;14163.221022843842 11:11:49 INFO - PID 19972 | __end_tp_report 11:11:49 INFO - PID 19972 | __start_cc_report 11:11:49 INFO - PID 19972 | _x_x_mozilla_cycle_collect,387 11:11:49 INFO - PID 19972 | __end_cc_report 11:11:49 INFO - PID 19972 | __startTimestamp1502820709188__endTimestamp 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | ------- Summary: start ------- 11:11:49 INFO - PID 19972 | Number of tests: 6 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | [#0] dojo.html Cycles:165 Average:6085.00 Median:6358.84 stddev:712.36 (11.2%) stddev-sans-first:675.08 11:11:49 INFO - PID 19972 | Values: 3104.1 3145.6 3148.1 3173.8 3192.9 6035.1 6218.9 6219.7 6220.3 6230.3 6026.2 6124.0 6131.0 6140.9 6141.5 5599.7 5638.2 5646.7 5673.4 5687.8 5678.9 5729.8 5771.3 5784.5 5820.8 5513.1 5566.6 5673.7 5703.3 5720.7 5600.0 5611.6 5670.3 5687.9 5712.0 5520.0 5587.4 5600.5 5664.1 5674.9 6057.5 6070.1 6070.6 6096.2 6096.9 6505.1 6561.2 6573.9 6589.6 6591.5 6657.4 6741.9 6759.3 6766.3 6771.0 6175.4 6193.9 6232.5 6268.5 6270.3 6705.5 6801.5 6822.1 6851.0 6910.1 6400.6 6412.0 6422.0 6427.0 6444.9 6441.8 6507.3 6518.1 6520.6 6547.1 6440.3 6448.6 6512.9 6527.5 6543.6 6466.3 6569.8 6573.2 6609.2 6701.9 5284.0 5293.5 5298.5 5307.4 5335.4 4514.0 4530.4 4558.1 4565.8 4575.4 5711.3 5714.7 5784.0 5787.5 5788.5 6471.1 6537.7 6573.3 6603.5 6620.9 5714.8 5729.8 5758.1 5759.5 5768.6 5827.4 5841.1 5904.6 5913.1 5920.9 6269.2 6458.9 6550.5 6551.0 6565.0 6575.3 6613.8 6687.3 6706.9 6724.4 6454.6 6496.0 6502.3 6505.4 6527.2 6507.3 6512.2 6526.4 6596.4 6616.5 6476.5 6585.5 6589.7 6610.1 6676.5 6358.8 6385.8 6392.4 6426.5 6429.6 6340.7 6350.7 6400.0 6409.9 6411.6 6244.7 6341.0 6348.9 6360.2 6398.6 6487.0 6499.0 6527.8 6531.3 6565.3 6335.3 6397.5 6410.3 6411.5 6417.9 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | [#1] ext.html Cycles:180 Average:38647.50 Median:34681.39 stddev:57079.81 (164.6%) stddev-sans-first:57169.08 11:11:49 INFO - PID 19972 | Values: 770.7 818.6 833.9 858.5 862.1 38555.4 38995.0 39278.6 39342.8 39427.6 36350.5 36513.0 36519.5 36590.1 36678.4 6564.3 6671.2 6679.2 6680.8 6682.8 6599.1 6622.1 6646.0 6687.6 6690.2 6664.3 6679.8 6691.5 7324.3 7564.9 7408.5 7418.3 7423.5 7428.6 7431.6 6835.0 6925.9 6945.4 6960.7 7188.0 36436.5 36781.3 36874.0 36880.4 36989.1 3106.4 3108.9 3109.3 3119.3 3226.7 29728.9 29859.0 29922.6 29961.0 29985.3 4968.2 4994.0 5017.3 5036.0 5037.5 217346.0 218207.0 218806.0 221071.0 221757.2 47660.8 47734.5 47799.0 47831.5 48057.8 48670.5 48678.8 48689.5 48724.8 48747.0 14870.9 15051.3 15087.8 15095.9 15100.4 12211.2 12259.8 12264.3 12335.3 12348.6 13932.7 13985.7 14103.4 14248.2 14318.9 5588.2 5655.0 5710.0 5862.4 5919.1 985.0 989.7 1010.7 1013.1 1020.3 22655.5 28671.0 28741.9 29170.7 29382.9 1086.8 1088.7 1098.0 1098.6 1099.8 12342.5 12463.3 12476.9 12585.5 15394.5 227271.0 229162.0 229293.0 229637.0 229717.0 53595.0 53853.5 54068.5 54266.0 57493.4 1437.5 1471.3 1474.8 1478.1 1492.2 26839.6 26972.7 27382.0 27403.0 27747.4 36173.3 36836.8 36850.6 36907.0 36964.6 210352.0 211391.0 211698.0 211935.0 213000.0 32565.3 33553.7 33641.2 33871.0 33886.3 41685.8 42140.6 42467.0 42500.4 42623.6 31348.0 31675.2 34127.8 35000.3 35389.3 33593.8 33780.3 34058.0 34158.0 34362.5 37000.0 38083.4 38156.6 38189.4 38452.8 32156.7 32744.7 33055.3 33066.8 33294.2 22857.9 24259.2 24817.5 24884.0 24884.9 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | [#2] jquery.html Cycles:180 Average:36094.54 Median:22683.60 stddev:87052.90 (383.8%) stddev-sans-first:87256.19 11:11:49 INFO - PID 19972 | Values: 548.8 559.8 571.9 579.1 594.6 21798.9 22632.3 22734.9 22736.9 22962.7 26282.2 26736.6 26881.2 26883.9 26993.9 6505.1 6672.8 6679.8 6681.5 6696.7 6154.8 6388.2 6417.4 6444.5 6510.1 6368.8 6377.1 6383.6 6401.2 6403.1 6370.1 6371.2 6372.1 6386.9 6399.6 5873.4 5948.2 5960.4 5967.5 5970.4 29104.0 29987.9 30459.5 30740.5 30935.2 1939.7 1968.3 1968.4 1978.9 1979.2 18550.1 19055.6 19100.9 19174.0 19182.6 2346.6 2351.3 2405.5 2409.2 2422.8 129300.0 131436.3 132222.3 132470.0 133293.0 14695.0 15299.3 15300.4 15401.5 15706.2 23428.3 23762.2 23783.0 23869.2 24080.0 10441.6 10628.7 10637.4 10720.1 10945.3 10102.1 10153.2 10181.4 10255.7 10259.8 9404.4 9492.5 9672.1 9686.0 9730.3 2599.8 2685.9 2758.9 2765.6 2794.3 952.1 953.0 964.0 969.5 976.2 19485.8 19738.9 19869.4 20517.9 24072.9 1007.8 1032.0 1036.4 1039.4 1041.4 10935.2 11546.8 11583.1 13322.9 14733.3 500593.0 518547.0 522128.0 526270.0 527192.0 120264.0 121790.0 124911.4 128615.0 128665.0 1250.8 1292.0 1302.3 1304.5 1304.6 20733.4 20815.9 20992.6 21075.9 21558.5 57381.7 59824.7 60938.7 61182.4 63458.7 69323.0 69782.3 69912.3 70358.6 70468.6 14766.2 15229.0 15309.4 15321.3 15360.1 23937.5 23987.2 24000.9 24278.4 24453.8 18917.9 18921.0 19096.2 19111.2 19250.2 15475.1 16914.0 17303.5 17882.5 18042.8 18522.0 19314.7 19387.1 19549.0 19596.1 14932.3 15088.1 15109.6 15136.4 15137.4 17738.4 18537.4 18653.0 18694.5 18823.9 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | [#3] mootools.html Cycles:180 Average:9048.60 Median:2561.31 stddev:6349.13 (247.9%) stddev-sans-first:6340.83 11:11:49 INFO - PID 19972 | Values: 1385.4 1426.1 1431.1 1437.6 1463.9 13990.4 15016.0 15028.6 15046.3 15049.2 14764.9 15027.9 15028.8 15090.3 15112.5 2674.3 2729.5 2751.5 2756.1 2758.1 2645.8 2681.4 2745.4 2745.7 2747.3 2634.6 2706.7 2707.5 2710.8 2713.0 2547.8 2574.8 2591.5 2594.5 2602.1 2422.3 2465.4 2505.5 2507.3 2517.5 14312.9 14408.8 14507.1 14518.0 14526.0 7349.1 7579.3 7591.7 7603.6 7616.4 5123.6 5201.3 5256.1 5279.3 5291.1 1811.5 1905.3 2271.3 2379.6 2397.1 24428.6 24860.6 24872.4 24903.5 24945.8 6712.8 6882.0 6912.8 7062.8 7105.1 19279.5 19378.7 19379.0 19380.2 19386.2 7530.5 7644.0 7651.0 7661.7 7670.7 6920.4 6924.0 7027.7 7196.5 7255.3 4813.9 4954.3 4986.4 4999.0 5011.2 1409.8 1440.9 1442.2 1464.0 1465.5 884.8 918.9 925.2 931.6 931.8 7262.9 7309.2 7336.3 7374.2 7416.3 702.4 711.4 719.8 721.2 722.8 4457.8 4482.8 5634.4 5734.7 6002.0 19610.9 19641.6 19929.0 20013.4 20130.5 19044.4 19711.6 19840.6 19974.6 19978.4 10917.2 11074.7 11440.9 11480.9 11497.8 8362.6 8402.9 8464.7 8474.0 8642.3 17063.3 17074.1 17323.8 17421.9 18001.6 17869.4 17871.7 18037.8 18269.1 18288.9 11029.8 11775.6 11856.2 11872.7 11913.5 13127.3 13135.6 13142.5 13182.8 13257.1 11025.3 11035.9 11040.9 11338.8 11355.1 10496.1 10542.2 10557.4 10569.1 10729.9 9372.2 9429.3 9527.4 9533.5 9538.7 7268.6 7329.2 7385.4 7387.7 7412.6 7159.5 7184.6 7251.6 7292.7 7432.9 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | [#4] prototype.html Cycles:180 Average:5507.36 Median:6101.12 stddev:1572.10 (25.8%) stddev-sans-first:1530.78 11:11:49 INFO - PID 19972 | Values: 492.2 498.5 517.8 517.9 523.3 6219.7 6285.2 6285.9 6316.0 6371.7 5910.6 6016.0 6028.4 6094.0 6108.9 4824.9 4853.8 4886.7 4887.8 4907.7 4858.7 4862.1 4890.9 4926.9 4958.4 4694.2 4827.5 4864.6 4891.5 4956.5 4853.2 4859.8 4871.3 4878.4 4912.9 4346.2 4352.1 4361.5 4377.2 4379.0 6066.8 6079.8 6108.3 6152.3 6165.3 5620.5 5650.2 5674.7 5676.2 5692.9 6453.8 6535.6 6536.2 6584.0 6619.5 4758.1 4774.9 4820.0 4822.4 4837.0 6808.3 6834.2 6917.4 6929.6 7031.9 4877.1 4880.4 4886.3 4931.3 4940.0 4996.0 4997.1 5014.8 5023.6 5032.9 5616.8 5662.0 5672.9 5680.4 5706.3 6532.4 6550.5 6561.5 6589.9 6691.9 1675.3 1681.5 1713.9 1729.9 1764.7 1176.4 1178.5 1184.8 1195.8 1199.4 5790.5 5821.2 5825.0 5849.0 5854.6 6593.2 6682.7 6687.6 6744.7 6768.3 5805.4 5818.6 5824.5 5871.0 5874.4 3580.3 3582.2 3603.6 3605.5 3651.1 6508.9 6550.5 6558.0 6579.2 6582.5 6925.3 6950.9 6968.3 6977.2 6981.7 6561.5 6568.5 6572.4 6601.2 6622.3 6801.0 6801.2 6851.3 6860.8 6885.5 6628.7 6697.9 6698.1 6759.7 6852.3 6575.2 6593.8 6598.4 6613.6 6621.1 4974.9 4978.7 4985.0 5014.5 5030.5 6683.7 6740.3 6748.5 6818.8 6877.9 6492.5 6512.7 6516.5 6609.3 6611.7 6483.9 6502.6 6563.8 6597.5 6607.1 6236.6 6237.8 6473.9 6498.5 6511.9 6503.2 6535.8 6553.6 6600.6 6662.4 6350.7 6390.8 6411.5 6419.7 6442.1 11:11:49 INFO - PID 19972 | 11:11:49 INFO - PID 19972 | [#5] yui.html Cycles:180 Average:23789.77 Median:18924.89 stddev:33139.75 (175.1%) stddev-sans-first:33188.17 11:11:49 INFO - PID 19972 | Values: 906.5 920.8 927.8 931.9 935.7 16511.3 17157.7 17242.4 17246.3 21500.0 20402.3 21184.0 21399.1 21429.9 21433.5 1033.2 1064.8 1069.3 1070.8 1073.1 975.5 1060.6 1069.4 1070.0 1070.7 1110.1 1116.4 1119.4 1120.1 1120.2 1109.9 1115.5 1117.1 1117.5 1118.3 811.8 817.2 817.3 818.0 818.1 19320.7 19332.0 19528.8 19578.2 19688.9 20861.6 21097.0 21181.4 21203.2 21339.0 16201.8 16427.3 16525.8 16594.3 16656.8 3615.5 3629.8 3644.7 3650.4 3659.1 131442.0 133261.0 135299.0 136398.0 137912.0 15764.5 16067.9 16374.8 16413.6 16703.0 27568.4 27851.2 28002.2 28300.2 28444.6 7465.3 7692.5 8606.5 8626.8 8923.3 4109.4 4205.3 4209.1 4216.9 4223.9 5143.9 5239.4 5239.6 5267.9 5316.5 1015.8 1032.9 1050.6 1051.5 1054.4 672.9 685.7 686.4 690.4 706.3 11228.8 11690.7 11692.5 12242.9 12819.7 679.8 680.5 693.8 700.8 706.5 5725.8 5781.0 6148.9 6182.4 6202.0 109619.0 110911.4 112259.4 116521.4 116891.0 95764.0 100965.0 101434.5 102275.0 105144.0 84971.0 87240.0 87643.0 98350.0 101796.0 11510.9 12151.6 12489.6 12494.4 13364.9 40728.0 41013.6 41020.8 42133.6 42875.0 50409.5 50600.5 51454.2 51857.5 52912.0 18606.6 18610.3 18831.3 19018.4 19265.3 21423.7 21698.9 21794.5 21843.0 21919.7 17489.1 17651.5 17872.6 17942.9 17962.0 16969.6 17020.9 17088.5 17093.4 17182.6 17911.0 18369.9 18475.3 18526.8 18768.7 13184.4 13419.3 13562.5 13695.8 14117.1 13852.4 14010.9 14115.6 14118.6 14163.2 11:11:49 INFO - PID 19972 | -------- Summary: end -------- 11:11:49 INFO - PID 19972 | 11:11:49 INFO - TEST-INFO | 19972: exit 0 11:11:49 INFO - TEST-OK | dromaeo_css | took 1111587ms 11:11:49 INFO - TEST-START | kraken 11:11:49 INFO - Initialising browser for kraken test... 11:11:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50046/getInfo.html -profile /tmp/tmpwMHkye/profile 11:11:49 INFO - TEST-INFO | started process 20350 (/builds/slave/test/build/application/firefox/firefox http://localhost:50046/getInfo.html) 11:11:55 INFO - TEST-INFO | 20350: exit 0 11:11:55 INFO - Browser initialized. 11:11:55 INFO - Running cycle 1/1 for kraken test... 11:11:55 INFO - TEST-INFO | started process 20586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMHkye/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:56 INFO - PID 20586 | 11:11:56 INFO - PID 20586 | (/builds/slave/test/build/application/firefox/firefox:20640): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:11:56 INFO - PID 20586 | 11:12:07 INFO - PID 20586 | RSS: Main: 167231488 11:12:07 INFO - PID 20586 | 11:12:09 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50046/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:10 INFO - PID 20586 | RSS: Main: 173518848 11:12:10 INFO - PID 20586 | 11:12:13 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50046/tests/kraken/driver.html?testName=audio-dft) 11:12:14 INFO - PID 20586 | RSS: Main: 177647616 11:12:14 INFO - PID 20586 | 11:12:17 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50046/tests/kraken/driver.html?testName=audio-fft) 11:12:17 INFO - PID 20586 | RSS: Main: 171778048 11:12:17 INFO - PID 20586 | 11:12:19 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50046/tests/kraken/driver.html?testName=audio-oscillator) 11:12:20 INFO - PID 20586 | RSS: Main: 171728896 11:12:20 INFO - PID 20586 | 11:12:22 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50046/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:23 INFO - PID 20586 | RSS: Main: 171642880 11:12:23 INFO - PID 20586 | 11:12:26 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50046/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:27 INFO - PID 20586 | RSS: Main: 173346816 11:12:27 INFO - PID 20586 | 11:12:30 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50046/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:31 INFO - PID 20586 | RSS: Main: 173043712 11:12:31 INFO - PID 20586 | 11:12:34 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50046/tests/kraken/driver.html?testName=json-parse-financial) 11:12:34 INFO - PID 20586 | RSS: Main: 174051328 11:12:34 INFO - PID 20586 | 11:12:36 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50046/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:37 INFO - PID 20586 | RSS: Main: 173682688 11:12:37 INFO - PID 20586 | 11:12:38 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:39 INFO - PID 20586 | RSS: Main: 173891584 11:12:39 INFO - PID 20586 | 11:12:41 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:42 INFO - PID 20586 | RSS: Main: 173641728 11:12:42 INFO - PID 20586 | 11:12:45 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:45 INFO - PID 20586 | RSS: Main: 174125056 11:12:45 INFO - PID 20586 | 11:12:49 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:49 INFO - PID 20586 | RSS: Main: 173924352 11:12:49 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | Cycle 1(1): loaded http://localhost:50046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50046/tests/kraken/driver.html?testName=ai-astar) 11:12:51 INFO - PID 20586 | RSS: Main: 175357952 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | __start_tp_report 11:12:51 INFO - PID 20586 | _x_x_mozilla_page_load 11:12:51 INFO - PID 20586 | _x_x_mozilla_page_load_details 11:12:51 INFO - PID 20586 | |i|pagename|runs| 11:12:51 INFO - PID 20586 | |0;ai-astar;99;112;101;109;111;110;114;100;108;107 11:12:51 INFO - PID 20586 | |1;audio-beat-detection;146;116;142;186;120;140;146;119;183;126 11:12:51 INFO - PID 20586 | |2;audio-dft;163;163;162;167;166;165;164;165;166;163 11:12:51 INFO - PID 20586 | |3;audio-fft;76;82;74;179;77;75;80;79;158;78 11:12:51 INFO - PID 20586 | |4;audio-oscillator;78;80;132;78;78;80;126;79;78;135 11:12:51 INFO - PID 20586 | |5;imaging-gaussian-blur;114;114;114;114;118;117;116;117;118;117 11:12:51 INFO - PID 20586 | |6;imaging-darkroom;152;152;152;151;151;151;152;155;149;149 11:12:51 INFO - PID 20586 | |7;imaging-desaturate;94;93;93;94;97;94;94;94;96;94 11:12:51 INFO - PID 20586 | |8;json-parse-financial;58;53;52;53;53;55;56;53;54;57 11:12:51 INFO - PID 20586 | |9;json-stringify-tinderbox;59;55;55;58;55;58;56;57;62;56 11:12:51 INFO - PID 20586 | |10;stanford-crypto-aes;78;79;79;89;82;83;80;80;88;80 11:12:51 INFO - PID 20586 | |11;stanford-crypto-ccm;124;132;128;134;130;127;128;122;125;162 11:12:51 INFO - PID 20586 | |12;stanford-crypto-pbkdf2;189;183;175;178;178;181;175;177;179;182 11:12:51 INFO - PID 20586 | |13;stanford-crypto-sha256-iterative;67;74;77;70;74;68;72;66;70;67 11:12:51 INFO - PID 20586 | __end_tp_report 11:12:51 INFO - PID 20586 | __start_cc_report 11:12:51 INFO - PID 20586 | _x_x_mozilla_cycle_collect,984 11:12:51 INFO - PID 20586 | __end_cc_report 11:12:51 INFO - PID 20586 | __startTimestamp1502820771790__endTimestamp 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | ------- Summary: start ------- 11:12:51 INFO - PID 20586 | Number of tests: 14 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#0] ai-astar Cycles:10 Average:107.10 Median:110.50 stddev:5.30 (4.8%) stddev-sans-first:4.74 11:12:51 INFO - PID 20586 | Values: 99.0 112.0 101.0 109.0 111.0 110.0 114.0 100.0 108.0 107.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:144.00 stddev:24.94 (17.3%) stddev-sans-first:26.41 11:12:51 INFO - PID 20586 | Values: 146.0 116.0 142.0 186.0 120.0 140.0 146.0 119.0 183.0 126.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:1.65 (1.0%) stddev-sans-first:1.67 11:12:51 INFO - PID 20586 | Values: 163.0 163.0 162.0 167.0 166.0 165.0 164.0 165.0 166.0 163.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.50 stddev:38.71 (49.9%) stddev-sans-first:40.39 11:12:51 INFO - PID 20586 | Values: 76.0 82.0 74.0 179.0 77.0 75.0 80.0 79.0 158.0 78.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:78.00 stddev:25.36 (32.5%) stddev-sans-first:26.20 11:12:51 INFO - PID 20586 | Values: 78.0 80.0 132.0 78.0 78.0 80.0 126.0 79.0 78.0 135.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:117.00 stddev:1.73 (1.5%) stddev-sans-first:1.69 11:12:51 INFO - PID 20586 | Values: 114.0 114.0 114.0 114.0 118.0 117.0 116.0 117.0 118.0 117.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:1.71 (1.1%) stddev-sans-first:1.80 11:12:51 INFO - PID 20586 | Values: 152.0 152.0 152.0 151.0 151.0 151.0 152.0 155.0 149.0 149.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 11:12:51 INFO - PID 20586 | Values: 94.0 93.0 93.0 94.0 97.0 94.0 94.0 94.0 96.0 94.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:2.01 (3.7%) stddev-sans-first:1.66 11:12:51 INFO - PID 20586 | Values: 58.0 53.0 52.0 53.0 53.0 55.0 56.0 53.0 54.0 57.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.50 stddev:2.23 (3.9%) stddev-sans-first:2.26 11:12:51 INFO - PID 20586 | Values: 59.0 55.0 55.0 58.0 55.0 58.0 56.0 57.0 62.0 56.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.82 (4.7%) stddev-sans-first:3.80 11:12:51 INFO - PID 20586 | Values: 78.0 79.0 79.0 89.0 82.0 83.0 80.0 80.0 88.0 80.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:129.00 stddev:11.41 (8.8%) stddev-sans-first:11.80 11:12:51 INFO - PID 20586 | Values: 124.0 132.0 128.0 134.0 130.0 127.0 128.0 122.0 125.0 162.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:180.00 stddev:4.24 (2.4%) stddev-sans-first:2.87 11:12:51 INFO - PID 20586 | Values: 189.0 183.0 175.0 178.0 178.0 181.0 175.0 177.0 179.0 182.0 11:12:51 INFO - PID 20586 | 11:12:51 INFO - PID 20586 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:3.66 (5.2%) stddev-sans-first:3.66 11:12:51 INFO - PID 20586 | Values: 67.0 74.0 77.0 70.0 74.0 68.0 72.0 66.0 70.0 67.0 11:12:51 INFO - PID 20586 | -------- Summary: end -------- 11:12:51 INFO - PID 20586 | 11:12:52 INFO - PID 20586 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:12:52 INFO - TEST-INFO | 20586: exit 0 11:12:52 INFO - TEST-OK | kraken | took 62539ms 11:12:52 INFO - SUITE-END | took 1174s 11:12:52 INFO - Completed test suite (00:19:34) 11:12:52 INFO - javascript benchmark 11:12:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8504.827415302843, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.1153271317694, 3145.6382516010635, 3148.071318960907, 3173.7778355515115, 3192.9361412771746, 6035.124906888498, 6218.906716399258, 6219.657918814469, 6220.315765265823, 6230.283517395501, 6026.216591843055, 6123.969380153093, 6130.969345153279, 6140.938590614092, 6141.539384546166, 5599.740058486838, 5638.210650508932, 5646.717664116798, 5673.404292549285, 5687.829365119053, 5678.858028549299, 5729.828105156852, 5771.3074431068335, 5784.479396854283, 5820.767169313243, 5513.09034009388, 5566.610337276392, 5673.6879471629045, 5703.31560212775, 5720.742566584493, 5599.972000140014, 5611.6352437091455, 5670.3479099903625, 5687.943120568824, 5711.971440142815, 5520.033994051025, 5587.38538760736, 5600.4959553640365, 5664.0937450007805, 5674.858128546819, 6057.485113765335, 6070.089486577004, 6070.6357618543025, 6096.1770161028135, 6096.878062438771, 6505.0892874997535, 6561.245456772484, 6573.93426065738, 6589.637569933651, 6591.505637077191, 6657.367550082734, 6741.898871516931, 6759.290274521203, 6766.2895395983205, 6771.0, 6175.413335733098, 6193.9070913935875, 6232.501399887998, 6268.529860260499, 6270.31026587075, 6705.530612857151, 6801.5238933274195, 6822.147231596051, 6851.040854280404, 6910.101686780787, 6400.583962042452, 6412.038194270804, 6422.004589288667, 6427.0, 6444.871102577922, 6441.840468715676, 6507.251666058464, 6518.087467754518, 6520.576162549419, 6547.148870646785, 6440.323766004502, 6448.580842245239, 6512.92536731434, 6527.510436717265, 6543.607383557001, 6466.288708242089, 6569.770058047945, 6573.1783527059115, 6609.239937407164, 6701.932980670228, 5284.0, 5293.497117773805, 5298.496642818926, 5307.363116426053, 5335.359756829128, 4514.0, 4530.365748795171, 4558.088382323548, 4565.817367305337, 4575.428071491064, 5711.257536520309, 5714.7428365723645, 5784.0, 5787.536997040227, 5788.450097240755, 6471.126397936312, 6537.673116344164, 6573.276939536647, 6603.471722262208, 6620.933790662128, 5714.79998200061, 5729.7708091676695, 5758.107493338539, 5759.452851979056, 5768.625039372511, 5827.388124246893, 5841.094630332305, 5904.645721256738, 5913.05391137416, 5920.940790592125, 6269.185005949289, 6458.870822583522, 6550.508711846631, 6551.017347397833, 6564.967175164189, 6575.342465753386, 6613.768518101843, 6687.297833727584, 6706.899396509154, 6724.361185687352, 6454.612723236621, 6496.0, 6502.349765023649, 6505.447037001908, 6527.249366322933, 6507.349265073455, 6512.218533775787, 6526.412622863965, 6596.373344532261, 6616.503762217757, 6476.481881449378, 6585.539012269095, 6589.703463344257, 6610.140681711347, 6676.532642714963, 6358.841028974312, 6385.808425747049, 6392.3927226913365, 6426.518011149276, 6429.58207716497, 6340.714667839866, 6350.68246587678, 6400.0, 6409.935900640934, 6411.6153030818305, 6244.718987645658, 6341.048842673636, 6348.873022539431, 6360.236771587439, 6398.616083035033, 6486.967565162144, 6499.025146227915, 6527.836804079936, 6531.281559028408, 6565.343465653396, 6335.2714437838395, 6397.488200943821, 6410.326915673787, 6411.51913606472, 6417.871642567029], "value": 6031.995978318677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.710983381232, 818.6438899078905, 833.8582440985034, 858.5149390594318, 862.0689655172416, 38555.42166867499, 38995.0, 39278.60721392789, 39342.8032859836, 39427.605723942754, 36350.454743178874, 36513.0, 36519.4522082169, 36590.08524786882, 36678.449823252675, 6564.310747371529, 6671.199456065255, 6679.165104361955, 6680.799576012703, 6682.799516014527, 6599.076129341896, 6622.139121914144, 6646.0363247329105, 6687.632180230085, 6690.230623478289, 6664.333566643345, 6679.799606011828, 6691.464682825386, 7324.267573242686, 7564.886526702104, 7408.481406301561, 7418.332350088518, 7423.480356375056, 7428.554286742813, 7431.628418579076, 6834.9658251708925, 6925.930740692579, 6945.444364450832, 6960.65196740161, 7187.964060179718, 36436.45345319822, 36781.26437471262, 36874.0, 36880.44679329812, 36989.07527311839, 3106.3631955449077, 3108.9067327980197, 3109.2693217093965, 3119.251379668886, 3226.6612005739294, 29728.8513557433, 29859.0, 29922.551161732375, 29961.0, 29985.250368740737, 4968.180250258703, 4994.0, 5017.2724954881705, 5036.043151801146, 5037.49625037497, 217346.0, 218207.0, 218806.0, 221071.0, 221757.23849665344, 47660.76169619199, 47734.522654773704, 47799.0, 47831.5216847834, 48057.75971120192, 48670.513294867305, 48678.75660621674, 48689.5131048685, 48724.75637621789, 48747.0, 14870.851291486946, 15051.322690478955, 15087.773683394758, 15095.924520377328, 15100.39598416051, 12211.168324751181, 12259.816102758467, 12264.264144151379, 12335.321557314433, 12348.567800127132, 13932.651683707989, 13985.650358741113, 14103.435862565382, 14248.216348100746, 14318.85681143196, 5588.161775733591, 5655.0, 5710.0, 5862.355140934494, 5919.112133180058, 984.9704508864745, 989.7426669066094, 1010.7068950004416, 1013.0983424751829, 1020.3112898793285, 22655.52739071988, 28671.0, 28741.856290718413, 29170.708292917225, 29382.853085734434, 1086.820674588684, 1088.7223757941833, 1098.0, 1098.6154845803906, 1099.8020356335937, 12342.506299748089, 12463.252204867737, 12476.875231247572, 12585.496580136693, 15394.538163855103, 227271.0, 229162.0, 229293.0, 229637.0, 229717.0, 53595.0, 53853.461465385626, 54068.45931540634, 54266.0, 57493.425065749645, 1437.4781784627703, 1471.3231913319992, 1474.793528905954, 1478.1057460236616, 1492.2315007771006, 26839.56724883161, 26972.730272697023, 27382.0, 27403.0, 27747.44505109927, 36173.27653446969, 36836.81581592075, 36850.63149368472, 36907.0, 36964.63035369612, 210352.0, 211391.0, 211698.0, 211935.0, 213000.0, 32565.34869302648, 33553.66446335505, 33641.15897102494, 33871.0, 33886.322273554884, 41685.79157104195, 42140.578594213664, 42467.0, 42500.362494563225, 42623.57376426196, 31348.0, 31675.20811979719, 34127.82936085304, 35000.29999399947, 35389.29221415506, 33593.83203083969, 33780.324393512485, 34058.0, 34158.0, 34362.484562732076, 37000.0, 38083.428748568236, 38156.6184338153, 38189.4271585932, 38452.80773596114, 32156.67843321537, 32744.672553275115, 33055.33889322152, 33066.834665826515, 33294.16764580808, 22857.88571057134, 24259.150929717376, 24817.50364992726, 24884.0, 24884.87557562273], "value": 16984.557384872784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.7625404712373, 559.8488408129805, 571.9116769444996, 579.0763731847703, 594.6313285762827, 21798.89100554497, 22632.321030369094, 22734.88632556835, 22736.88631556842, 22962.655560166568, 26282.211533654023, 26736.5989510157, 26881.193564193105, 26883.865580672118, 26993.86503067482, 6505.056766768816, 6672.833179170511, 6679.766208182715, 6681.53229273951, 6696.698648560802, 6154.784582539612, 6388.201474815648, 6417.358264173568, 6444.452221561173, 6510.056041873925, 6368.808935731936, 6377.07532407803, 6383.553151279412, 6401.199850018747, 6403.135576697133, 6370.108184854147, 6371.171747672819, 6372.1397611322345, 6386.87226255477, 6399.552031357784, 5873.412658734135, 5948.167256584038, 5960.374160713106, 5967.522598192134, 5970.402959704038, 29104.0, 29987.850060749774, 30459.543106853416, 30740.53889191664, 30935.226619334473, 1939.660559402099, 1968.3209292793963, 1968.4094771568473, 1978.8911609861452, 1979.1687491253708, 18550.072496375127, 19055.61888762217, 19100.90449547757, 19174.0, 19182.616347672967, 2346.624540073597, 2351.318117745852, 2405.4707964248014, 2409.1929203716777, 2422.8061755059553, 129300.0, 131436.34281828624, 132222.3388883059, 132470.0, 133293.0, 14695.0, 15299.311530981133, 15300.387984480718, 15401.460948866736, 15706.21468926572, 23428.297151085495, 23762.168324108574, 23783.0, 23869.16457923999, 24080.0, 10441.634542790965, 10628.734281642866, 10637.361758294526, 10720.142388608892, 10945.288556243819, 10102.09081182697, 10153.187744980383, 10181.440020798927, 10255.7436064099, 10259.846102308471, 9404.435733855991, 9492.477913714813, 9672.08115229052, 9686.0, 9730.318877678494, 2599.753023462768, 2685.9059932902255, 2758.917232483029, 2765.629597123643, 2794.3153927287944, 952.1430712358932, 952.9809403812023, 963.9614415423305, 969.5007071358256, 976.1605019683067, 19485.805141948684, 19738.901305493382, 19869.403917882486, 20517.89741051285, 24072.87963560171, 1007.7984403119406, 1031.9535620896927, 1036.383351905615, 1039.3711804358406, 1041.4220107840222, 10935.234533582572, 11546.751821175465, 11583.07335413165, 13322.866771332356, 14733.336999835034, 500593.0, 518547.0, 522128.0, 526270.0, 527192.0, 120264.0, 121790.0, 124911.3754431222, 128614.99999999812, 128665.0, 1250.8061250506187, 1291.9547815826402, 1302.2837439408288, 1304.4586496603804, 1304.5760127958451, 20733.377998660064, 20815.8959205203, 20992.580148397254, 21075.8946205268, 21558.461038473535, 57381.71309143428, 59824.70087649534, 60938.69530652319, 61182.38817611767, 63458.68270658617, 69323.0, 69782.30217697758, 69912.30087699057, 70358.64820675863, 70468.64765676139, 14766.187859667822, 15229.0, 15309.387624494895, 15321.310541025457, 15360.078395296317, 23937.52124957526, 23987.160449384188, 24000.87999559991, 24278.39304017343, 24453.755462445148, 18917.90541047341, 18921.0, 19096.23615055382, 19111.235550578378, 19250.22999080021, 15475.071495710294, 16913.985160890385, 17303.480895573153, 17882.463526094238, 18042.819571804113, 18522.0, 19314.7102793461, 19387.127579258686, 19549.0, 19596.11817468246, 14932.328045238208, 15088.094714316738, 15109.622259443602, 15136.394544218108, 15137.394504220149, 17738.379156729454, 18537.44387668372, 18653.0, 18694.53263668365, 18823.90588047051], "value": 12275.320377804896, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.3765805387575, 1426.1300606629954, 1431.0626539616549, 1437.6334034821118, 1463.8609332113444, 13990.440382384706, 15016.0, 15028.624284392896, 15046.322915468803, 15049.172295523742, 14764.852351476482, 15027.92486037571, 15028.774568381483, 15090.320935557898, 15112.546623601282, 2674.304680782996, 2729.495043416964, 2751.5184842652557, 2756.104266113511, 2758.089830355988, 2645.7883369330502, 2681.410089780255, 2745.3548416122194, 2745.6705195376485, 2747.3269049083, 2634.565296726038, 2706.729327067297, 2707.4991126641535, 2710.7966902482294, 2712.9593056104172, 2547.847129172256, 2574.781143602796, 2591.5464793661035, 2594.4940736556377, 2602.141293373182, 2422.333858189012, 2465.3590066582638, 2505.473850491399, 2507.2728908616477, 2517.483915797257, 14312.92843535786, 14408.783868241984, 14507.129572225595, 14518.0, 14526.0, 7349.081364829396, 7579.279968402993, 7591.696332146707, 7603.619819009027, 7616.428767842379, 5123.615728820353, 5201.323827902386, 5256.106461901486, 5279.287296215039, 5291.100512912814, 1811.5380577952537, 1905.2759951218586, 2271.341311019802, 2379.619260918262, 2397.137030668958, 24428.63357049646, 24860.627090593836, 24872.3781905452, 24903.50192996148, 24945.750542494705, 6712.844962867444, 6881.965590172117, 6912.792616221522, 7062.823429414203, 7105.111861017373, 19279.51801204953, 19378.70931936022, 19379.0, 19380.224791008484, 19386.224551018084, 7530.548167109991, 7643.9617801911745, 7651.0, 7661.731839385595, 7670.654820533089, 6920.411764999931, 6924.030635711005, 7027.683754231072, 7196.460265480006, 7255.347018768336, 4813.855584332476, 4954.256861470736, 4986.376702912136, 4998.975005124951, 5011.223260394645, 1409.8026276321323, 1440.8559144085718, 1442.1707518176881, 1464.0, 1465.4870795221586, 884.8274586455708, 918.8897332320164, 925.1812146250483, 931.5621657820814, 931.7670582354411, 7262.891056634155, 7309.159446663595, 7336.303051210127, 7374.225706300868, 7416.295451932166, 702.4380495603497, 711.4130842055325, 719.7516856684435, 721.2030706069822, 722.7506510253954, 4457.799399026987, 4482.798274077674, 5634.352049514277, 5734.655920644775, 6002.0, 19610.901945490183, 19641.607167856848, 19929.00354982245, 20013.39959801208, 20130.496737581678, 19044.428667140008, 19711.60576788456, 19840.60318793616, 19974.60050798976, 19978.400647980583, 10917.23579349438, 11074.667759967213, 11440.94279528597, 11480.942595286802, 11497.827532587018, 8362.623681934207, 8402.915970840213, 8464.746057618282, 8473.95763021181, 8642.308615310634, 17063.317467301167, 17074.14629268507, 17323.826761732726, 17421.88827050043, 18001.639967200845, 17869.374571889923, 17871.73192402141, 18037.82754120978, 18269.08654567293, 18288.90855545714, 11029.779404412027, 11775.587854425054, 11856.22934509254, 11872.703182420508, 11913.523459061887, 13127.343632818513, 13135.605931822061, 13142.540011099565, 13182.80225796633, 13257.07200495956, 11025.338479691245, 11035.944820275847, 11040.889591103985, 11338.773224535627, 11355.091592672401, 10496.05535501778, 10542.15662746963, 10557.419341936267, 10569.101626361846, 10729.9463502682, 9372.203362714246, 9429.3399462037, 9527.38072025316, 9533.523323833642, 9538.666146684833, 7268.636568171676, 7329.193788683134, 7385.446091543048, 7387.741429049957, 7412.592307423143, 7159.534630249017, 7184.6048467334795, 7251.601161936144, 7292.708291668274, 7432.888506672512], "value": 6493.069427959874, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.16937214495726, 498.4971052618589, 517.7877070401131, 517.8886539394031, 523.2831021500544, 6219.657918814463, 6285.151504546885, 6285.937140628593, 6316.021016742407, 6371.713272902719, 5910.615809972349, 6015.9699201504045, 6028.42729940656, 6093.969530152354, 6108.869859076063, 4824.9493965064885, 4853.752966154615, 4886.706797592155, 4887.804487820483, 4907.656464047518, 4858.659893807418, 4862.124817532843, 4890.877728056809, 4926.876828079308, 4958.404991401037, 4694.155052090622, 4827.541383568555, 4864.586510146642, 4891.505332280545, 4956.504349565051, 4853.150698627761, 4859.829905953275, 4871.29366241893, 4878.438979517347, 4912.901741965141, 4346.195953748566, 4352.086061926999, 4361.538884473705, 4377.212101821671, 4378.978105109454, 6066.816970690717, 6079.756809727605, 6108.267007959073, 6152.292486364081, 6165.32181460039, 5620.522255608237, 5650.220180643084, 5674.659520428788, 5676.233708449389, 5692.943070569324, 6453.805026732614, 6535.607863528204, 6536.150300460909, 6584.02479256226, 6619.503537234678, 4758.072175925696, 4774.856754297377, 4819.987802561466, 4822.397200349957, 4836.975815120937, 6808.2510923798345, 6834.214065382445, 6917.377436030782, 6929.648718499894, 7031.859362812766, 4877.097736918681, 4880.41435027799, 4886.340344053508, 4931.334269873521, 4939.975300123549, 4995.9500404996215, 4997.100521906092, 5014.774335154927, 5023.618504911179, 5032.924506132411, 5616.831495055155, 5662.03745363281, 5672.914906276409, 5680.4319568042865, 5706.28671416073, 6532.444742196966, 6550.475961923034, 6561.475081993429, 6589.9341006590275, 6691.866162676816, 1675.31312162013, 1681.529171831889, 1713.922873470697, 1729.9135043247786, 1764.7176451767655, 1176.4353110507004, 1178.5403692559908, 1184.7689700508317, 1195.7668254690425, 1199.4302706214653, 5790.452201031532, 5821.18503409523, 5825.0, 5848.970755146197, 5854.648721076749, 6593.175853018372, 6682.699278532477, 6687.598744075371, 6744.6627668616375, 6768.323167683291, 5805.419458054161, 5818.6217895836635, 5824.534037277008, 5870.970645146747, 5874.383189765099, 3580.2839432113683, 3582.194006348551, 3603.56757189139, 3605.531280933462, 3651.1419816343137, 6508.926027205553, 6550.475961923034, 6558.0, 6579.24338701046, 6582.506312026617, 6925.342092501305, 6950.895736563955, 6968.268331825187, 6977.197622273504, 6981.743286208532, 6561.540692151599, 6568.474522038226, 6572.375624315682, 6601.240857301472, 6622.3113106157625, 6800.973566762743, 6801.183857936881, 6851.314868513308, 6860.794176174722, 6885.51801373899, 6628.668566571749, 6697.899531506934, 6698.062271282122, 6759.695813688494, 6852.280510546321, 6575.24384695747, 6593.769218077345, 6598.37315455031, 6613.603183808987, 6621.1392518972225, 4974.900501989868, 4978.651494395358, 4985.0, 5014.473480284518, 5030.522100400456, 6683.732650693918, 6740.314921269683, 6748.4693240034985, 6818.829244401377, 6877.931220687729, 6492.48060155177, 6512.706928188148, 6516.543841931019, 6609.339066093352, 6611.702473388806, 6483.935160648333, 6502.60984340941, 6563.835904102436, 6597.50518711089, 6607.108040414675, 6236.563440559117, 6237.844053898507, 6473.928342930217, 6498.512611554247, 6511.902321465276, 6503.154589903283, 6535.836604084936, 6553.606783592809, 6600.60396376219, 6662.400383965466, 6350.650714210763, 6390.808275751735, 6411.455026322815, 6419.743210271537, 6442.130312407952], "value": 5041.467083178566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.4697152165982, 920.8434566123763, 927.823713494436, 931.9114684105016, 935.7239614313777, 16511.256993435294, 17157.742633860486, 17242.39651612194, 17246.310147594097, 21500.0, 20402.285919992803, 21184.0, 21399.144034238652, 21429.892850535725, 21433.464163395885, 1033.1889466768569, 1064.7604289034982, 1069.3476979042778, 1070.8072546941548, 1073.0878753059876, 975.5024937281967, 1060.5704689600725, 1069.4064794039305, 1069.983950240747, 1070.71626019105, 1110.0619976120165, 1116.4250411038322, 1119.4458742922266, 1120.1318977792196, 1120.2326406411635, 1109.8668159820834, 1115.4980258883495, 1117.1007339092027, 1117.4692021289904, 1118.2675347647305, 811.809224832164, 817.2318021060184, 817.337956255435, 817.9591020449013, 818.1368656067846, 19320.71018934717, 19332.0, 19528.804711952842, 19578.21687132513, 19688.90155549213, 20861.58276834455, 21097.0, 21181.36455906325, 21203.151873925024, 21339.039743211437, 16201.837981620269, 16427.342906283735, 16525.83474165255, 16594.336226550924, 16656.75014874778, 3615.511905892697, 3629.764065335771, 3644.671979521856, 3650.4159334506353, 3659.1218107654236, 131442.0, 133261.0, 135298.999999999, 136398.0, 137912.0, 15764.527064187863, 16067.919660401856, 16374.83625163757, 16413.58966025835, 16703.0, 27568.44863102767, 27851.164465066082, 28002.159935201977, 28300.15099547017, 28444.573331400046, 7465.253474652492, 7692.46152769312, 8606.526641034678, 8626.784330391665, 8923.330750193762, 4109.383592461095, 4205.306124489486, 4209.074003719177, 4216.915661686749, 4223.936640950388, 5143.948560514422, 5239.371275446971, 5239.633225674243, 5267.920981185285, 5316.494932981361, 1015.7714514234239, 1032.8812186598486, 1050.5535147562255, 1051.458498873081, 1054.393723608928, 672.8889733194067, 685.7291369908858, 686.3994005245411, 690.3855568544, 706.3148745716646, 11228.831567526493, 11690.70773230659, 11692.532298708127, 12242.938785306016, 12819.743605128031, 679.751890559942, 680.4590350671228, 693.8022663540968, 700.7897630710767, 706.5336877660822, 5725.77096916127, 5781.046127388934, 6148.938510614837, 6182.412670796267, 6202.007678771465, 109619.0, 110911.44544277227, 112259.4387028076, 116521.41739291418, 116891.0, 95764.0, 100965.0, 101434.49282753539, 102275.0, 105144.0, 84971.0, 87240.0, 87643.0, 98350.0, 101796.0, 11510.884891150981, 12151.635450936486, 12489.625311240678, 12494.37528123572, 13364.866351336363, 40728.0, 41013.58986410217, 41020.79489602533, 42133.57866421297, 42875.0, 50409.49590504048, 50600.49399506105, 51454.22818657648, 51857.481425185266, 52912.0, 18606.627867442305, 18610.34863779761, 18831.340903068874, 19018.42944711661, 19265.325713599956, 21423.67864482003, 21698.89150554237, 21794.455138621663, 21843.0, 21919.67120493162, 17489.125543722508, 17651.470455885832, 17872.55318617045, 17942.910285448488, 17962.0, 16969.575760606083, 17020.914895425445, 17088.487345379657, 17093.401730939855, 17182.570435739206, 17911.0, 18369.908150459163, 18475.260989560265, 18526.814731852508, 18768.7184692227, 13184.40670169864, 13419.26194059297, 13562.489070970078, 13695.794563081363, 14117.08238964464, 13852.445902163801, 14010.929945350208, 14115.576532704035, 14118.576442706735, 14163.221022843842], "value": 9192.023020341745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 101.0, 109.0, 111.0, 110.0, 114.0, 100.0, 108.0, 107.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 142.0, 186.0, 120.0, 140.0, 146.0, 119.0, 183.0, 126.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 167.0, 166.0, 165.0, 164.0, 165.0, 166.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 74.0, 179.0, 77.0, 75.0, 80.0, 79.0, 158.0, 78.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 132.0, 78.0, 78.0, 80.0, 126.0, 79.0, 78.0, 135.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 118.0, 117.0, 116.0, 117.0, 118.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 152.0, 151.0, 151.0, 151.0, 152.0, 155.0, 149.0, 149.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 97.0, 94.0, 94.0, 94.0, 96.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 52.0, 53.0, 53.0, 55.0, 56.0, 53.0, 54.0, 57.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 55.0, 58.0, 55.0, 58.0, 56.0, 57.0, 62.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 89.0, 82.0, 83.0, 80.0, 80.0, 88.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 132.0, 128.0, 134.0, 130.0, 127.0, 128.0, 122.0, 125.0, 162.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 183.0, 175.0, 178.0, 178.0, 181.0, 175.0, 177.0, 179.0, 182.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 77.0, 70.0, 74.0, 68.0, 72.0, 66.0, 70.0, 67.0], "value": 70.5, "unit": "score"}]}]} 11:12:52 INFO - Return code: 0 11:12:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:53 INFO - # TBPL SUCCESS # 11:12:53 INFO - Running post-action listener: _package_coverage_data 11:12:53 INFO - Running post-action listener: _resource_record_post_action 11:12:53 INFO - [mozharness: 2017-08-15 18:12:53.056315Z] Finished run-tests step (success) 11:12:53 INFO - Running post-run listener: _resource_record_post_run 11:12:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 433082368; Read time: 0; Write time: 223300 11:12:53 INFO - TinderboxPrint: CPU usage
13.1% 11:12:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:12:53 INFO - TinderboxPrint: I/O write bytes / time
433,082,368 / 223,300 11:12:53 INFO - TinderboxPrint: CPU idle
8,261.2 (86.8%) 11:12:53 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 11:12:53 INFO - TinderboxPrint: Swap in / out
0 / 0 11:12:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107331584; Read time: 0; Write time: 69320 11:12:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:12:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325750784; Read time: 0; Write time: 153980 11:12:53 INFO - Running post-run listener: _upload_blobber_files 11:12:53 INFO - Blob upload gear active. 11:12:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:53 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 11:12:53 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'] 11:12:53 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 11:12:54 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:54 INFO - (blobuploader) - INFO - Done attempting. 11:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:01 INFO - (blobuploader) - INFO - Done attempting. 11:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:13:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:02 INFO - (blobuploader) - INFO - Done attempting. 11:13:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:13:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:03 INFO - (blobuploader) - INFO - Done attempting. 11:13:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:03 INFO - Return code: 0 11:13:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc912021ead28b6db17b01876f763605edb7eae8c13a60fcd069ec3629514137ac1024f5624ecd4d76aeb10c73315da6becc241f587c3fbf5f18452b2d1e28cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06117a9237e75e481b0a5cb9b8a124ffa9498dcbcd1546c3e559726cf2ab02ac72d04dbc29a96a9a5b194ca1ec83210030e61b009ad077251c362ae5bc489976", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb330fd1a928a00fe049c7af4e6612a8917ee872dcb5c4d522862b784ff8bf11649c08a83607b3c8ab80871b4047c0280fd146301240a2ac1e9164a342732c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d135d9dab5e535f790b1bea9a0db910ab8e9ea81e5e9feb64bd64a21c216f4e4e7b97e265c589e3680952d0ccd4c81b3576d27a278fcf191eb015510aa9cca7d"} 11:13:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:03 INFO - Contents: 11:13:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc912021ead28b6db17b01876f763605edb7eae8c13a60fcd069ec3629514137ac1024f5624ecd4d76aeb10c73315da6becc241f587c3fbf5f18452b2d1e28cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06117a9237e75e481b0a5cb9b8a124ffa9498dcbcd1546c3e559726cf2ab02ac72d04dbc29a96a9a5b194ca1ec83210030e61b009ad077251c362ae5bc489976", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb330fd1a928a00fe049c7af4e6612a8917ee872dcb5c4d522862b784ff8bf11649c08a83607b3c8ab80871b4047c0280fd146301240a2ac1e9164a342732c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d135d9dab5e535f790b1bea9a0db910ab8e9ea81e5e9feb64bd64a21c216f4e4e7b97e265c589e3680952d0ccd4c81b3576d27a278fcf191eb015510aa9cca7d"} 11:13:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:03 INFO - Copying logs to upload dir... 11:13:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.717880 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-15 11:13:02.997409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:03.005040) ========= 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=ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730 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/cc912021ead28b6db17b01876f763605edb7eae8c13a60fcd069ec3629514137ac1024f5624ecd4d76aeb10c73315da6becc241f587c3fbf5f18452b2d1e28cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06117a9237e75e481b0a5cb9b8a124ffa9498dcbcd1546c3e559726cf2ab02ac72d04dbc29a96a9a5b194ca1ec83210030e61b009ad077251c362ae5bc489976", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb330fd1a928a00fe049c7af4e6612a8917ee872dcb5c4d522862b784ff8bf11649c08a83607b3c8ab80871b4047c0280fd146301240a2ac1e9164a342732c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d135d9dab5e535f790b1bea9a0db910ab8e9ea81e5e9feb64bd64a21c216f4e4e7b97e265c589e3680952d0ccd4c81b3576d27a278fcf191eb015510aa9cca7d"} build_url:https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc912021ead28b6db17b01876f763605edb7eae8c13a60fcd069ec3629514137ac1024f5624ecd4d76aeb10c73315da6becc241f587c3fbf5f18452b2d1e28cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06117a9237e75e481b0a5cb9b8a124ffa9498dcbcd1546c3e559726cf2ab02ac72d04dbc29a96a9a5b194ca1ec83210030e61b009ad077251c362ae5bc489976", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adb330fd1a928a00fe049c7af4e6612a8917ee872dcb5c4d522862b784ff8bf11649c08a83607b3c8ab80871b4047c0280fd146301240a2ac1e9164a342732c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d135d9dab5e535f790b1bea9a0db910ab8e9ea81e5e9feb64bd64a21c216f4e4e7b97e265c589e3680952d0ccd4c81b3576d27a278fcf191eb015510aa9cca7d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:03.034722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:03.035052) ========= 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=ca6c2627acea03e666270f68000001e0-1502818171.673357-1872768730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:03.116450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 11:13:03.119864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 11:13:03.120211) ========= ========= Total master_lag: 0.21 =========