builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1502014349.68 results: success (0) revision: b34cf908546b9f37f5d1b100e67dc8ef814fca7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.680442) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.680819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.681087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.699511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.699770) ========= 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=5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 03:12:29-- 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% 225M=0s 2017-08-06 03:12:29 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079995 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.808860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.809169) ========= 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=5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.864835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:29.865148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b34cf908546b9f37f5d1b100e67dc8ef814fca7a --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 b34cf908546b9f37f5d1b100e67dc8ef814fca7a --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=5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 03:12:29,961 truncating revision to first 12 chars 2017-08-06 03:12:29,961 Setting DEBUG logging. 2017-08-06 03:12:29,961 attempt 1/10 2017-08-06 03:12:29,961 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b34cf908546b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 03:12:30,494 unpacking tar archive at: mozilla-central-b34cf908546b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:30.799990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:30.800320) ========= script_repo_revision: b34cf908546b9f37f5d1b100e67dc8ef814fca7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:30.800672) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:30.800938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:30.818160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 03:12:30.818457) ========= /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=5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:12:31 INFO - MultiFileLogger online at 20170806 03:12:31 in /builds/slave/test 03:12:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:12:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:31 INFO - {'append_to_log': False, 03:12:31 INFO - 'base_work_dir': '/builds/slave/test', 03:12:31 INFO - 'blob_upload_branch': 'Firefox', 03:12:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:31 INFO - 'branch': 'Firefox', 03:12:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:31 INFO - 'code_coverage': False, 03:12:31 INFO - 'config_files': ('talos/linux_config.py',), 03:12:31 INFO - 'default_actions': ('clobber', 03:12:31 INFO - 'read-buildbot-config', 03:12:31 INFO - 'download-and-extract', 03:12:31 INFO - 'populate-webroot', 03:12:31 INFO - 'create-virtualenv', 03:12:31 INFO - 'install', 03:12:31 INFO - 'setup-mitmproxy', 03:12:31 INFO - 'run-tests'), 03:12:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:31 INFO - 'disable_ccov_upload': False, 03:12:31 INFO - 'download_minidump_stackwalk': True, 03:12:31 INFO - 'download_symbols': 'ondemand', 03:12:31 INFO - 'enable_stylo': False, 03:12:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:31 INFO - 'gecko_profile': False, 03:12:31 INFO - 'gecko_profile_interval': 0, 03:12:31 INFO - 'installer_path': 'installer.exe', 03:12:31 INFO - 'log_level': 'info', 03:12:31 INFO - 'log_name': 'talos', 03:12:31 INFO - 'log_to_console': True, 03:12:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:12:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:12:31 INFO - 'opt_config_files': (), 03:12:31 INFO - 'pip_index': False, 03:12:31 INFO - 'suite': 'dromaeojs-e10s', 03:12:31 INFO - 'system_bits': '32', 03:12:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:31 INFO - 'title': 'talos-linux64-ix-039', 03:12:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:31 INFO - 'use_talos_json': True, 03:12:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:31 INFO - 'work_dir': 'build'} 03:12:31 INFO - [mozharness: 2017-08-06 10:12:31.022193Z] Running clobber step. 03:12:31 INFO - Running pre-action listener: _resource_record_pre_action 03:12:31 INFO - Running main action method: clobber 03:12:31 INFO - rmtree: /builds/slave/test/build 03:12:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:32 INFO - Running post-action listener: _resource_record_post_action 03:12:32 INFO - [mozharness: 2017-08-06 10:12:32.554634Z] Finished clobber step (success) 03:12:32 INFO - [mozharness: 2017-08-06 10:12:32.554735Z] Running read-buildbot-config step. 03:12:32 INFO - Running pre-action listener: _resource_record_pre_action 03:12:32 INFO - Running main action method: read_buildbot_config 03:12:32 INFO - Using buildbot properties: 03:12:32 INFO - { 03:12:32 INFO - "project": "", 03:12:32 INFO - "product": "firefox", 03:12:32 INFO - "who": "archaeopteryx@coole-files.de", 03:12:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:12:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:12:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:12:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:12:32 INFO - "stage_platform": "linux64-pgo", 03:12:32 INFO - "basedir": "/builds/slave/test", 03:12:32 INFO - "buildnumber": 101, 03:12:32 INFO - "platform": "ubuntu64_hw", 03:12:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:12:32 INFO - "slavebuilddir": "test", 03:12:32 INFO - "taskId": "dWRQuboMRMOCbo4IyAQiuQ", 03:12:32 INFO - "branch": "mozilla-central", 03:12:32 INFO - "script_repo_revision": "production", 03:12:32 INFO - "revision": "b34cf908546b9f37f5d1b100e67dc8ef814fca7a", 03:12:32 INFO - "slavename": "talos-linux64-ix-039", 03:12:32 INFO - "repo_path": "mozilla-central" 03:12:32 INFO - } 03:12:32 INFO - Finding installer, test and symbols from parent task. 03:12:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dWRQuboMRMOCbo4IyAQiuQ'}, attempt #1 03:12:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dWRQuboMRMOCbo4IyAQiuQ'}, attempt #1 03:12:33 INFO - Task dependencies: RrmsT3M2RgivG5vR4dxB5g 03:12:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g'}, attempt #1 03:12:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2 03:12:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.test_packages.json 03:12:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.crashreporter-symbols.zip 03:12:33 INFO - Running post-action listener: _resource_record_post_action 03:12:33 INFO - [mozharness: 2017-08-06 10:12:33.897706Z] Finished read-buildbot-config step (success) 03:12:33 INFO - [mozharness: 2017-08-06 10:12:33.897930Z] Running download-and-extract step. 03:12:33 INFO - Running pre-action listener: _resource_record_pre_action 03:12:33 INFO - Running main action method: download_and_extract 03:12:33 INFO - mkdir: /builds/slave/test/build/tests 03:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:12:33 INFO - trying https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.test_packages.json 03:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:12:34 INFO - Downloaded 989 bytes. 03:12:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:12:34 INFO - Using the following test package requirements: 03:12:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:12:34 INFO - u'common': [u'target.common.tests.zip'], 03:12:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:12:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:12:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:12:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:12:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:12:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:12:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:12:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:12:34 INFO - u'target.web-platform.tests.tar.gz'], 03:12:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:12:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:12:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.common.tests.zip 03:12:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:12:34 INFO - Fetch https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.common.tests.zip into memory 03:12:35 INFO - Content-Length response header: 54900788 03:12:35 INFO - Bytes received: 54900788 03:12:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:12:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.common.tests.zip 03:12:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:12:46 INFO - Fetch https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.common.tests.zip into memory 03:12:47 INFO - Content-Length response header: 54900788 03:12:47 INFO - Bytes received: 54900788 03:13:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.talos.tests.zip 03:13:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:13:00 INFO - Fetch https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.talos.tests.zip into memory 03:13:00 INFO - Content-Length response header: 14496008 03:13:00 INFO - Bytes received: 14496008 03:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:01 INFO - trying https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2 03:13:01 INFO - Downloading https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:13:02 INFO - Downloaded 62721650 bytes. 03:13:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2 03:13:02 INFO - mkdir: /builds/slave/test/properties 03:13:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:13:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:13:02 INFO - Contents: 03:13:02 INFO - build_url:https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2 03:13:02 INFO - Running post-action listener: _resource_record_post_action 03:13:02 INFO - Running post-action listener: set_extra_try_arguments 03:13:02 INFO - [mozharness: 2017-08-06 10:13:02.425534Z] Finished download-and-extract step (success) 03:13:02 INFO - [mozharness: 2017-08-06 10:13:02.425633Z] Running populate-webroot step. 03:13:02 INFO - Running pre-action listener: _resource_record_pre_action 03:13:02 INFO - Running main action method: populate_webroot 03:13:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:13:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:13:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:13:02 INFO - 'tests': ['damp', 'tps']}, 03:13:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:13:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:13:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:13:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:13:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:13:02 INFO - 'ts_paint', 03:13:02 INFO - 'tpaint', 03:13:02 INFO - 'sessionrestore', 03:13:02 INFO - 'sessionrestore_many_windows', 03:13:02 INFO - 'sessionrestore_no_auto_restore', 03:13:02 INFO - 'tabpaint']}, 03:13:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:13:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:13:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:13:02 INFO - 'tsvgr_opacity', 03:13:02 INFO - 'tart', 03:13:02 INFO - 'tscrollx', 03:13:02 INFO - 'tsvg_static']}, 03:13:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:13:02 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:13:02 INFO - 'talos_options': ['--mitmproxy', 03:13:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:13:02 INFO - '--firstNonBlankPaint'], 03:13:02 INFO - 'tests': ['tp6_google', 03:13:02 INFO - 'tp6_youtube', 03:13:02 INFO - 'tp6_amazon', 03:13:02 INFO - 'tp6_facebook']}, 03:13:02 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:13:02 INFO - 'talos_options': ['--stylo', 03:13:02 INFO - '--mitmproxy', 03:13:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:13:02 INFO - '--firstNonBlankPaint'], 03:13:02 INFO - 'tests': ['tp6_google', 03:13:02 INFO - 'tp6_youtube', 03:13:02 INFO - 'tp6_amazon', 03:13:02 INFO - 'tp6_facebook']}, 03:13:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:13:02 INFO - 'talos_options': ['--stylo', 03:13:02 INFO - '--stylo-threads=1', 03:13:02 INFO - '--mitmproxy', 03:13:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:13:02 INFO - '--firstNonBlankPaint'], 03:13:02 INFO - 'tests': ['tp6_google', 03:13:02 INFO - 'tp6_youtube', 03:13:02 INFO - 'tp6_amazon', 03:13:02 INFO - 'tp6_facebook']}, 03:13:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:13:02 INFO - 'talos_options': ['--xperf_path', 03:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:02 INFO - 'tests': ['tp5n']}}} 03:13:02 INFO - Running post-action listener: _resource_record_post_action 03:13:02 INFO - [mozharness: 2017-08-06 10:13:02.434104Z] Finished populate-webroot step (success) 03:13:02 INFO - [mozharness: 2017-08-06 10:13:02.434194Z] Running create-virtualenv step. 03:13:02 INFO - Running pre-action listener: _resource_record_pre_action 03:13:02 INFO - Running main action method: create_virtualenv 03:13:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:13:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:13:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:13:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:13:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:13:02 INFO - Using real prefix '/usr' 03:13:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:13:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:13:04 INFO - Installing pip.................done. 03:13:05 INFO - Return code: 0 03:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:13:05 INFO - Reading from file tmpfile_stdout 03:13:05 INFO - Output received: 03:13:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:13:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:13:05 INFO - Using env: {'DISPLAY': ':0', 03:13:05 INFO - 'HOME': '/home/cltbld', 03:13:05 INFO - 'LANG': 'en_US.UTF-8', 03:13:05 INFO - 'LANGUAGE': 'en_US:en', 03:13:05 INFO - 'LOGNAME': 'cltbld', 03:13:05 INFO - 'MAIL': '/var/mail/cltbld', 03:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:05 INFO - 'MOZ_NO_REMOTE': '1', 03:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:05 INFO - 'NO_EM_RESTART': '1', 03:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:05 INFO - 'PWD': '/builds/slave/test', 03:13:05 INFO - 'SHELL': '/bin/bash', 03:13:05 INFO - 'SHLVL': '1', 03:13:05 INFO - 'TERM': 'linux', 03:13:05 INFO - 'TMOUT': '86400', 03:13:05 INFO - 'USER': 'cltbld', 03:13:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:05 INFO - '_': '/tools/buildbot/bin/python'} 03:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:13:05 INFO - Cleaning up... 03:13:05 INFO - Return code: 0 03:13:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:13:05 INFO - Using env: {'DISPLAY': ':0', 03:13:05 INFO - 'HOME': '/home/cltbld', 03:13:05 INFO - 'LANG': 'en_US.UTF-8', 03:13:05 INFO - 'LANGUAGE': 'en_US:en', 03:13:05 INFO - 'LOGNAME': 'cltbld', 03:13:05 INFO - 'MAIL': '/var/mail/cltbld', 03:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:05 INFO - 'MOZ_NO_REMOTE': '1', 03:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:05 INFO - 'NO_EM_RESTART': '1', 03:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:05 INFO - 'PWD': '/builds/slave/test', 03:13:05 INFO - 'SHELL': '/bin/bash', 03:13:05 INFO - 'SHLVL': '1', 03:13:05 INFO - 'TERM': 'linux', 03:13:05 INFO - 'TMOUT': '86400', 03:13:05 INFO - 'USER': 'cltbld', 03:13:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:05 INFO - '_': '/tools/buildbot/bin/python'} 03:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:05 INFO - Downloading/unpacking psutil>=3.1.1 03:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:13:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:06 INFO - Installing collected packages: psutil 03:13:06 INFO - Running setup.py install for psutil 03:13:07 INFO - building 'psutil._psutil_linux' extension 03:13:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:13:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:13:07 INFO - building 'psutil._psutil_posix' extension 03:13:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:13:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:13:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:07 INFO - Successfully installed psutil 03:13:07 INFO - Cleaning up... 03:13:07 INFO - Return code: 0 03:13:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:13:07 INFO - Using env: {'DISPLAY': ':0', 03:13:07 INFO - 'HOME': '/home/cltbld', 03:13:07 INFO - 'LANG': 'en_US.UTF-8', 03:13:07 INFO - 'LANGUAGE': 'en_US:en', 03:13:07 INFO - 'LOGNAME': 'cltbld', 03:13:07 INFO - 'MAIL': '/var/mail/cltbld', 03:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:07 INFO - 'MOZ_NO_REMOTE': '1', 03:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:07 INFO - 'NO_EM_RESTART': '1', 03:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:07 INFO - 'PWD': '/builds/slave/test', 03:13:07 INFO - 'SHELL': '/bin/bash', 03:13:07 INFO - 'SHLVL': '1', 03:13:07 INFO - 'TERM': 'linux', 03:13:07 INFO - 'TMOUT': '86400', 03:13:07 INFO - 'USER': 'cltbld', 03:13:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:07 INFO - '_': '/tools/buildbot/bin/python'} 03:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:13:08 INFO - Installing collected packages: mozsystemmonitor 03:13:08 INFO - Running setup.py install for mozsystemmonitor 03:13:08 INFO - Successfully installed mozsystemmonitor 03:13:08 INFO - Cleaning up... 03:13:09 INFO - Return code: 0 03:13:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:13:09 INFO - Using env: {'DISPLAY': ':0', 03:13:09 INFO - 'HOME': '/home/cltbld', 03:13:09 INFO - 'LANG': 'en_US.UTF-8', 03:13:09 INFO - 'LANGUAGE': 'en_US:en', 03:13:09 INFO - 'LOGNAME': 'cltbld', 03:13:09 INFO - 'MAIL': '/var/mail/cltbld', 03:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:09 INFO - 'MOZ_NO_REMOTE': '1', 03:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:09 INFO - 'NO_EM_RESTART': '1', 03:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:09 INFO - 'PWD': '/builds/slave/test', 03:13:09 INFO - 'SHELL': '/bin/bash', 03:13:09 INFO - 'SHLVL': '1', 03:13:09 INFO - 'TERM': 'linux', 03:13:09 INFO - 'TMOUT': '86400', 03:13:09 INFO - 'USER': 'cltbld', 03:13:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:09 INFO - '_': '/tools/buildbot/bin/python'} 03:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:13:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:13:10 INFO - warning: no files found matching '*.txt' 03:13:10 INFO - no previously-included directories found matching 'build' 03:13:10 INFO - no previously-included directories found matching 'dist' 03:13:10 INFO - no previously-included directories found matching '.git*' 03:13:10 INFO - Installing collected packages: jsonschema, functools32 03:13:10 INFO - Running setup.py install for functools32 03:13:10 INFO - warning: no files found matching '*.txt' 03:13:10 INFO - no previously-included directories found matching 'build' 03:13:10 INFO - no previously-included directories found matching 'dist' 03:13:10 INFO - no previously-included directories found matching '.git*' 03:13:10 INFO - Successfully installed jsonschema functools32 03:13:10 INFO - Cleaning up... 03:13:10 INFO - Return code: 0 03:13:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:10 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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:13:10 INFO - Using env: {'DISPLAY': ':0', 03:13:10 INFO - 'HOME': '/home/cltbld', 03:13:10 INFO - 'LANG': 'en_US.UTF-8', 03:13:10 INFO - 'LANGUAGE': 'en_US:en', 03:13:10 INFO - 'LOGNAME': 'cltbld', 03:13:10 INFO - 'MAIL': '/var/mail/cltbld', 03:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:10 INFO - 'MOZ_NO_REMOTE': '1', 03:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:10 INFO - 'NO_EM_RESTART': '1', 03:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:10 INFO - 'PWD': '/builds/slave/test', 03:13:10 INFO - 'SHELL': '/bin/bash', 03:13:10 INFO - 'SHLVL': '1', 03:13:10 INFO - 'TERM': 'linux', 03:13:10 INFO - 'TMOUT': '86400', 03:13:10 INFO - 'USER': 'cltbld', 03:13:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:10 INFO - '_': '/tools/buildbot/bin/python'} 03:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:13:10 INFO - Cleaning up... 03:13:10 INFO - Return code: 0 03:13:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:10 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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:13:10 INFO - Using env: {'DISPLAY': ':0', 03:13:10 INFO - 'HOME': '/home/cltbld', 03:13:10 INFO - 'LANG': 'en_US.UTF-8', 03:13:10 INFO - 'LANGUAGE': 'en_US:en', 03:13:10 INFO - 'LOGNAME': 'cltbld', 03:13:10 INFO - 'MAIL': '/var/mail/cltbld', 03:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:10 INFO - 'MOZ_NO_REMOTE': '1', 03:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:10 INFO - 'NO_EM_RESTART': '1', 03:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:10 INFO - 'PWD': '/builds/slave/test', 03:13:10 INFO - 'SHELL': '/bin/bash', 03:13:10 INFO - 'SHLVL': '1', 03:13:10 INFO - 'TERM': 'linux', 03:13:10 INFO - 'TMOUT': '86400', 03:13:10 INFO - 'USER': 'cltbld', 03:13:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:10 INFO - '_': '/tools/buildbot/bin/python'} 03:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:11 INFO - Downloading/unpacking blobuploader==1.2.4 03:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:13:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:12 INFO - Downloading docopt-0.6.1.tar.gz 03:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:12 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:12 INFO - Running setup.py install for blobuploader 03:13:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:13:12 INFO - Running setup.py install for requests 03:13:13 INFO - Running setup.py install for docopt 03:13:13 INFO - Successfully installed blobuploader requests docopt 03:13:13 INFO - Cleaning up... 03:13:13 INFO - Return code: 0 03:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:13 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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:13 INFO - Using env: {'DISPLAY': ':0', 03:13:13 INFO - 'HOME': '/home/cltbld', 03:13:13 INFO - 'LANG': 'en_US.UTF-8', 03:13:13 INFO - 'LANGUAGE': 'en_US:en', 03:13:13 INFO - 'LOGNAME': 'cltbld', 03:13:13 INFO - 'MAIL': '/var/mail/cltbld', 03:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:13 INFO - 'MOZ_NO_REMOTE': '1', 03:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:13 INFO - 'NO_EM_RESTART': '1', 03:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:13 INFO - 'PWD': '/builds/slave/test', 03:13:13 INFO - 'SHELL': '/bin/bash', 03:13:13 INFO - 'SHLVL': '1', 03:13:13 INFO - 'TERM': 'linux', 03:13:13 INFO - 'TMOUT': '86400', 03:13:13 INFO - 'USER': 'cltbld', 03:13:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:13 INFO - '_': '/tools/buildbot/bin/python'} 03:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:13 INFO - Running setup.py (path:/tmp/pip-mMzBG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:13 INFO - Running setup.py (path:/tmp/pip-HSgHtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:13 INFO - Running setup.py (path:/tmp/pip-O3NnXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:13 INFO - Running setup.py (path:/tmp/pip-DmJbzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:13 INFO - Running setup.py (path:/tmp/pip-yNjrtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:13 INFO - Running setup.py (path:/tmp/pip-Vk1Kmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:14 INFO - Running setup.py (path:/tmp/pip-fOKKcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:14 INFO - Running setup.py (path:/tmp/pip-a8mHF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:14 INFO - Running setup.py (path:/tmp/pip-d2GdUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:14 INFO - Running setup.py (path:/tmp/pip-wiZHBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:14 INFO - Running setup.py (path:/tmp/pip-Ceol7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:14 INFO - Running setup.py (path:/tmp/pip-gfjy8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:14 INFO - Running setup.py (path:/tmp/pip-UK30QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:14 INFO - Running setup.py (path:/tmp/pip-qkuwmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:14 INFO - Running setup.py (path:/tmp/pip-B38aVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:14 INFO - Running setup.py (path:/tmp/pip-uYxVkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:14 INFO - Running setup.py (path:/tmp/pip-IqMznx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:14 INFO - Running setup.py install for manifestparser 03:13:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:13:14 INFO - Running setup.py install for mozcrash 03:13:15 INFO - Running setup.py install for mozdebug 03:13:15 INFO - Running setup.py install for mozdevice 03:13:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Running setup.py install for mozfile 03:13:15 INFO - Running setup.py install for mozhttpd 03:13:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Running setup.py install for mozinfo 03:13:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Running setup.py install for mozInstall 03:13:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Running setup.py install for mozleak 03:13:15 INFO - Running setup.py install for mozlog 03:13:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Running setup.py install for moznetwork 03:13:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:13:15 INFO - Running setup.py install for mozprocess 03:13:16 INFO - Running setup.py install for mozprofile 03:13:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:13:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:13:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:13:16 INFO - Running setup.py install for mozrunner 03:13:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:13:16 INFO - Running setup.py install for mozscreenshot 03:13:16 INFO - Running setup.py install for moztest 03:13:16 INFO - Running setup.py install for mozversion 03:13:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:13:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:16 INFO - Cleaning up... 03:13:16 INFO - Return code: 0 03:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:16 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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:16 INFO - Using env: {'DISPLAY': ':0', 03:13:16 INFO - 'HOME': '/home/cltbld', 03:13:16 INFO - 'LANG': 'en_US.UTF-8', 03:13:16 INFO - 'LANGUAGE': 'en_US:en', 03:13:16 INFO - 'LOGNAME': 'cltbld', 03:13:16 INFO - 'MAIL': '/var/mail/cltbld', 03:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:16 INFO - 'MOZ_NO_REMOTE': '1', 03:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:16 INFO - 'NO_EM_RESTART': '1', 03:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:16 INFO - 'PWD': '/builds/slave/test', 03:13:16 INFO - 'SHELL': '/bin/bash', 03:13:16 INFO - 'SHLVL': '1', 03:13:16 INFO - 'TERM': 'linux', 03:13:16 INFO - 'TMOUT': '86400', 03:13:16 INFO - 'USER': 'cltbld', 03:13:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:16 INFO - '_': '/tools/buildbot/bin/python'} 03:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:16 INFO - Running setup.py (path:/tmp/pip-xY4lKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:16 INFO - Running setup.py (path:/tmp/pip-iwKjvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:16 INFO - Running setup.py (path:/tmp/pip-oi_wVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:17 INFO - Running setup.py (path:/tmp/pip-j9n8wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:17 INFO - Running setup.py (path:/tmp/pip-v3NStd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:17 INFO - Running setup.py (path:/tmp/pip-4MH8Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:17 INFO - Running setup.py (path:/tmp/pip-gpe52W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:17 INFO - Running setup.py (path:/tmp/pip-AxwhjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:17 INFO - Running setup.py (path:/tmp/pip-bUuBmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:17 INFO - Running setup.py (path:/tmp/pip-Z1lAGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:17 INFO - Running setup.py (path:/tmp/pip-F0go1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:17 INFO - Running setup.py (path:/tmp/pip-E1zvOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:17 INFO - Running setup.py (path:/tmp/pip-PprRMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:17 INFO - Running setup.py (path:/tmp/pip-DnKUS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:17 INFO - Running setup.py (path:/tmp/pip-UbM7rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:17 INFO - Running setup.py (path:/tmp/pip-zHG7t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:17 INFO - Running setup.py (path:/tmp/pip-KiSkil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:13:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:19 INFO - Downloading blessings-1.6.tar.gz 03:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:13:19 INFO - Installing collected packages: blessings 03:13:19 INFO - Running setup.py install for blessings 03:13:19 INFO - Successfully installed blessings 03:13:19 INFO - Cleaning up... 03:13:19 INFO - Return code: 0 03:13:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:19 INFO - Reading from file tmpfile_stdout 03:13:19 INFO - Current package versions: 03:13:19 INFO - argparse == 1.2.1 03:13:19 INFO - blessings == 1.6 03:13:19 INFO - blobuploader == 1.2.4 03:13:19 INFO - docopt == 0.6.1 03:13:19 INFO - functools32 == 3.2.3-2 03:13:19 INFO - jsonschema == 2.5.1 03:13:19 INFO - manifestparser == 1.1 03:13:19 INFO - mozInstall == 1.13 03:13:19 INFO - mozcrash == 1.0 03:13:19 INFO - mozdebug == 0.1 03:13:19 INFO - mozdevice == 0.51 03:13:19 INFO - mozfile == 1.2 03:13:19 INFO - mozhttpd == 0.7 03:13:19 INFO - mozinfo == 0.10 03:13:19 INFO - mozleak == 0.1 03:13:19 INFO - mozlog == 3.5 03:13:19 INFO - moznetwork == 0.27 03:13:19 INFO - mozprocess == 0.25 03:13:19 INFO - mozprofile == 0.28 03:13:19 INFO - mozrunner == 6.13 03:13:19 INFO - mozscreenshot == 0.1 03:13:19 INFO - mozsystemmonitor == 0.3 03:13:19 INFO - moztest == 0.8 03:13:19 INFO - mozversion == 1.4 03:13:19 INFO - psutil == 3.1.1 03:13:19 INFO - requests == 1.2.3 03:13:19 INFO - wsgiref == 0.1.2 03:13:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:19 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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:19 INFO - Using env: {'DISPLAY': ':0', 03:13:19 INFO - 'HOME': '/home/cltbld', 03:13:19 INFO - 'LANG': 'en_US.UTF-8', 03:13:19 INFO - 'LANGUAGE': 'en_US:en', 03:13:19 INFO - 'LOGNAME': 'cltbld', 03:13:19 INFO - 'MAIL': '/var/mail/cltbld', 03:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:19 INFO - 'MOZ_NO_REMOTE': '1', 03:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:19 INFO - 'NO_EM_RESTART': '1', 03:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:19 INFO - 'PWD': '/builds/slave/test', 03:13:19 INFO - 'SHELL': '/bin/bash', 03:13:19 INFO - 'SHLVL': '1', 03:13:19 INFO - 'TERM': 'linux', 03:13:19 INFO - 'TMOUT': '86400', 03:13:19 INFO - 'USER': 'cltbld', 03:13:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:19 INFO - '_': '/tools/buildbot/bin/python'} 03:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:13:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:20 INFO - Installing collected packages: simplejson 03:13:20 INFO - Running setup.py install for simplejson 03:13:21 INFO - building 'simplejson._speedups' extension 03:13:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:13:21 INFO - Successfully installed simplejson 03:13:21 INFO - Cleaning up... 03:13:22 INFO - Return code: 0 03:13:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:22 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 0x23cb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2597a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, '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': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:13:22 INFO - Using env: {'DISPLAY': ':0', 03:13:22 INFO - 'HOME': '/home/cltbld', 03:13:22 INFO - 'LANG': 'en_US.UTF-8', 03:13:22 INFO - 'LANGUAGE': 'en_US:en', 03:13:22 INFO - 'LOGNAME': 'cltbld', 03:13:22 INFO - 'MAIL': '/var/mail/cltbld', 03:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:22 INFO - 'MOZ_NO_REMOTE': '1', 03:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:22 INFO - 'NO_EM_RESTART': '1', 03:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:22 INFO - 'PWD': '/builds/slave/test', 03:13:22 INFO - 'SHELL': '/bin/bash', 03:13:22 INFO - 'SHLVL': '1', 03:13:22 INFO - 'TERM': 'linux', 03:13:22 INFO - 'TMOUT': '86400', 03:13:22 INFO - 'USER': 'cltbld', 03:13:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:22 INFO - '_': '/tools/buildbot/bin/python'} 03:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:13:22 INFO - Cleaning up... 03:13:22 INFO - Return code: 0 03:13:22 INFO - Running post-action listener: _resource_record_post_action 03:13:22 INFO - Running post-action listener: _start_resource_monitoring 03:13:22 INFO - Starting resource monitoring. 03:13:22 INFO - [mozharness: 2017-08-06 10:13:22.290091Z] Finished create-virtualenv step (success) 03:13:22 INFO - [mozharness: 2017-08-06 10:13:22.290561Z] Running install step. 03:13:22 INFO - Running pre-action listener: _resource_record_pre_action 03:13:22 INFO - Running main action method: install 03:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:22 INFO - Reading from file tmpfile_stdout 03:13:22 INFO - Detecting whether we're running mozinstall >=1.0... 03:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:13:22 INFO - Reading from file tmpfile_stdout 03:13:22 INFO - Output received: 03:13:22 INFO - Usage: mozinstall [options] installer 03:13:22 INFO - Options: 03:13:22 INFO - -h, --help show this help message and exit 03:13:22 INFO - -d DEST, --destination=DEST 03:13:22 INFO - Directory to install application into. [default: 03:13:22 INFO - "/builds/slave/test"] 03:13:22 INFO - --app=APP Application being installed. [default: firefox] 03:13:22 INFO - mkdir: /builds/slave/test/build/application 03:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:13:40 INFO - Reading from file tmpfile_stdout 03:13:40 INFO - Output received: 03:13:40 INFO - /builds/slave/test/build/application/firefox/firefox 03:13:40 INFO - Running post-action listener: _resource_record_post_action 03:13:40 INFO - [mozharness: 2017-08-06 10:13:40.484242Z] Finished install step (success) 03:13:40 INFO - [mozharness: 2017-08-06 10:13:40.484524Z] Running setup-mitmproxy step. 03:13:40 INFO - Running pre-action listener: _resource_record_pre_action 03:13:40 INFO - Running main action method: setup_mitmproxy 03:13:40 INFO - Skipping: mitmproxy is not required 03:13:40 INFO - Running post-action listener: _resource_record_post_action 03:13:40 INFO - [mozharness: 2017-08-06 10:13:40.485712Z] Finished setup-mitmproxy step (success) 03:13:40 INFO - [mozharness: 2017-08-06 10:13:40.485932Z] Running run-tests step. 03:13:40 INFO - Running pre-action listener: _resource_record_pre_action 03:13:40 INFO - Running pre-action listener: _set_gcov_prefix 03:13:40 INFO - Running main action method: run_tests 03:13:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:13:40 INFO - Python 2.7.3 03:13:40 INFO - Return code: 0 03:13:40 INFO - grabbing minidump binary from tooltool 03:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:13:40 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 0x2737eb0>, '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 0x2738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2739240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:13:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:13:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:13:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:13:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:13:40 INFO - Return code: 0 03:13:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:13:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:13:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:13:40 INFO - ENV: RUST_BACKTRACE is now 1 03:13:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:13:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:13:40 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/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:13:40 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/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:13:40 INFO - Using env: {'DISPLAY': ':0', 03:13:40 INFO - 'HOME': '/home/cltbld', 03:13:40 INFO - 'LANG': 'en_US.UTF-8', 03:13:40 INFO - 'LANGUAGE': 'en_US:en', 03:13:40 INFO - 'LOGNAME': 'cltbld', 03:13:40 INFO - 'MAIL': '/var/mail/cltbld', 03:13:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:13:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:40 INFO - 'MOZ_NO_REMOTE': '1', 03:13:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:40 INFO - 'NO_EM_RESTART': '1', 03:13:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:40 INFO - 'PWD': '/builds/slave/test', 03:13:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:13:40 INFO - 'RUST_BACKTRACE': '1', 03:13:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:13:40 INFO - 'SHELL': '/bin/bash', 03:13:40 INFO - 'SHLVL': '1', 03:13:40 INFO - 'TERM': 'linux', 03:13:40 INFO - 'TMOUT': '86400', 03:13:40 INFO - 'USER': 'cltbld', 03:13:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843', 03:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:40 INFO - '_': '/tools/buildbot/bin/python'} 03:13:40 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/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:13:40 INFO - mozversion application_buildid: 20170806090346 03:13:40 INFO - mozversion application_changeset: b34cf908546b9f37f5d1b100e67dc8ef814fca7a 03:13:40 INFO - mozversion application_display_name: Nightly 03:13:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:13:40 INFO - mozversion application_name: Firefox 03:13:40 INFO - mozversion application_remotingname: firefox 03:13:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:13:40 INFO - mozversion application_vendor: Mozilla 03:13:40 INFO - mozversion application_version: 57.0a1 03:13:40 INFO - mozversion platform_buildid: 20170806090346 03:13:40 INFO - mozversion platform_changeset: b34cf908546b9f37f5d1b100e67dc8ef814fca7a 03:13:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:13:40 INFO - mozversion platform_version: 57.0a1 03:13:40 INFO - using testdate: 1502014420 03:13:40 INFO - actual date: 1502014420 03:13:40 INFO - starting webserver on 'localhost:60976' 03:13:40 INFO - SUITE-START | Running 2 tests 03:13:40 INFO - TEST-START | dromaeo_css 03:13:40 INFO - Initialising browser for dromaeo_css test... 03:13:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60976/getInfo.html -profile /tmp/tmpzpTQdn/profile 03:13:40 INFO - TEST-INFO | started process 12290 (/builds/slave/test/build/application/firefox/firefox http://localhost:60976/getInfo.html) 03:13:46 INFO - TEST-INFO | 12290: exit 0 03:13:46 INFO - Browser initialized. 03:13:46 INFO - Running cycle 1/1 for dromaeo_css test... 03:13:46 INFO - TEST-INFO | started process 12500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzpTQdn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:47 INFO - PID 12500 | 03:13:47 INFO - PID 12500 | (/builds/slave/test/build/application/firefox/firefox:12549): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:13:47 INFO - PID 12500 | 03:13:58 INFO - PID 12500 | RSS: Main: 165203968 03:13:58 INFO - PID 12500 | 03:16:56 INFO - PID 12500 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60976/tests/dromaeo/cssquery-ext.html) 03:16:58 INFO - PID 12500 | RSS: Main: 166854656 03:16:58 INFO - PID 12500 | 03:19:59 INFO - PID 12500 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-ext.html (next: http://localhost:60976/tests/dromaeo/cssquery-jquery.html) 03:20:00 INFO - PID 12500 | RSS: Main: 164257792 03:20:00 INFO - PID 12500 | 03:23:01 INFO - PID 12500 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60976/tests/dromaeo/cssquery-mootools.html) 03:23:02 INFO - PID 12500 | RSS: Main: 166277120 03:23:02 INFO - PID 12500 | 03:26:04 INFO - PID 12500 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60976/tests/dromaeo/cssquery-prototype.html) 03:26:04 INFO - PID 12500 | RSS: Main: 164528128 03:26:04 INFO - PID 12500 | 03:29:07 INFO - PID 12500 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60976/tests/dromaeo/cssquery-yui.html) 03:29:08 INFO - PID 12500 | RSS: Main: 167956480 03:29:08 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-yui.html (next: http://localhost:60976/tests/dromaeo/cssquery-dojo.html) 03:32:10 INFO - PID 12500 | RSS: Main: 168558592 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | __start_tp_report 03:32:10 INFO - PID 12500 | _x_x_mozilla_page_load 03:32:10 INFO - PID 12500 | _x_x_mozilla_page_load_details 03:32:10 INFO - PID 12500 | |i|pagename|runs| 03:32:10 INFO - PID 12500 | |0;dojo.html;3463.168839478524;3475.7566970312087;3523.083998160478;3533.646635336465;3563.518924945133;6181.6600086995195;6233;6239.344868788774;6316.810495685131;6330.145430366899;6121.540884433674;6205.81382558524;6218.036204388316;6221.066839973995;6260.405261500162;5434.728263586825;5436.673799572019;5449.455054494539;5453.536449401786;5500.80747173847;5484.91772623411;5495.6427832190975;5496.945030549683;5503.174523821419;5566.109422492402;5497.340319161686;5506.614536982413;5543.889122217553;5551.084071128259;5614.606977511576;5338.065838478289;5394.568434525228;5429.809956651518;5466.617336786427;5523.392426833045;5352.223927530486;5385.542228910547;5390.056740070472;5406.351237851483;5417.945820541783;6134.539909506805;6134.96932515339;6169.321374648785;6252.3122456529745;6273.435390814849;6554.24626167992;6641.302663220389;6731.562448440835;6749.763758268437;6762.154730658668;6780.355866192704;6785.491088168407;6866;6875.346842049998;6898.413634841045;6264.029075493306;6298.338674439164;6316.842078948017;6330.050492426127;6343.429091381798;6897.62063086525;6924.861502769916;6927.376536111774;6962.1297337832775;7017.368436840607;6561.737530498726;6618.073469714244;6623.07276981223;6638.20341559016;6687.431568316748;6701.765438209639;6741.797746067626;6793.728250870009;6794.660266986631;6818.454523638097;6736.696848641823;6779.0509328694025;6795.320467953264;6807.897881531781;6818.488613353919;6706.463482921355;6733.7643182489355;6760.560563563353;6835.7949261522235;6839.316068393121;4797.304390863375;4882.316475693406;4883.121038213156;4937.432195297515;4939.234418665113;4304.78476076195;4373.278409062469;4403.053343531156;4415.558444155558;4438.622717069021;6146.661933593606;6301.936980630227;6356.523260755462;6359.8092057238355;6364.777232796922;6711.094002309724;6722.361375669304;6733.797986060426;6750.696218670171;6753.527253092335;6308.810735677937;6357.078223657636;6357.427831495188;6359.586626869239;6466.4503517201565;5418.295621569249;5482.972585137129;5484.670919744828;5484.725763711878;5486.862828429321;7148.499605027599;7151.642417879085;7180.78457646261;7216.567005979553;7229.674664640103;6676.132102826601;6746.69639866217;6756.054152418764;6763;6771.3905748482875;7009.684564194726;7035;7072.3634872861685;7074.646267686492;7093.538919970186;6613.834654133492;6656.900146497709;6663.167104111986;6686.531942764154;6779.288174741779;6710.4631629470505;6716.227633822173;6791.083203767428;6804.795856124324;6810.693518791567;6491.545591808528;6566.277709452052;6576.013597960345;6580.1116849226655;6581.407673309425;6440;6535.477161826947;6542.1168142300185;6544.149260596092;6548.0832683425315;6477.481801455778;6491.350864913471;6502;6505.60966342021;6576.901346479903;6609.504287178384;6654.13496245485;6671.166104236971;6715.731370745116;6721.092652492047;6164.753409863555;6285.905711414241;6343.429091381798;6426;6465.547411681137 03:32:10 INFO - PID 12500 | |1;ext.html;864.1841071437017;898.6435662799445;926.8887733471983;929.5723966975191;932.9830484771597;41382.58617413825;42358.788206059005;42538;42561.36157957629;42637.78681106598;38530;38542;38849.223015539676;38893;38945.61054389455;6775.796726098212;6875.484338674594;6894.655267236643;6904.861902761942;6941.097657304544;6743;6831.829204269909;6832.385085342318;6833.521653484258;6838.7264509419565;6788.253292137861;6800.217974932896;6810.455163586926;6810.455163586926;6839.760608378708;6765.93234067658;6774.491913106512;6776.491763117761;6779.0509328694025;6782.253952065269;6322.0200868865395;6325.620462772203;6379.649119298437;6408.58344207625;6412.807615771534;33883;34114;34116.317673646634;34132.48801267983;34184.31631367384;3225.5000474926424;3251.788633738823;3253.3655937092276;3257.690519400653;3257.7719559630837;27128.45743085127;27592.862035689894;27816.860915695495;27864.582031269547;27945.720542794515;4558.931616025762;4595.816167353302;4596.126735920165;4607.861764147081;4632.166210082184;211940;213960;214215;214292;216724.9163754187;50871.23693144606;50924;50939;50989.49010509922;51009.744951275745;53015.46984530183;53382.19926701103;53426.46573534293;53437.73281133569;53538.464615354125;16410.507684769476;16529.586760330847;16548.669026619402;16558.254878530493;16920.57698557546;14028.929855350862;14063.507777227953;14083.366248518636;14085.2253126077;14086.859131408759;13160.14459060158;13184.73630527384;13218.867811321763;13283.93358033223;13342.599722008355;5322.175062865262;5325.3875804282225;5341.919871201935;5349.331333583302;5438.619296649275;1073.0932362153967;1076.3918386111823;1090.650991682654;1103.0568863621647;1107.6621630402803;24588.139415120742;30985.380292394027;31393.686063139077;31415.842920785708;32155.035348939567;1148.2478976270556;1151.1711567671264;1162.1690491298762;1165.947532361046;1166.3585028234438;13004.41039114128;13260.469581216836;13312.600621981355;13359.198448092951;13492.19046857172;265816;269684;270398;270646;271024;52586;53064.469355306726;53141;53269.733651331495;53310.46689533055;1454.7090581883665;1475.7343678138038;1513.4551561437875;1519.620094976256;1534.700733357007;24716.50566988614;30138.54792178163;30146.397072057996;30722.231944201572;30936.69063309428;54986.17520737272;54997;55094.44905550893;55132.17301740397;55269.17096243479;225479;227389;228169;228703;229853;32758.836205818818;33235.83382083074;33600.83199584084;35549.644503554635;42725.572744273406;51885.48114518807;52057.47942520678;52554.73722631362;52759.472405275454;53571.7321413406;37820.43269351017;38009.049773755876;38176.04559886025;38257.6174238254;38270;37591.81204093962;37908.81045594755;38231.808840955615;38267.808660956514;38314;42902.35646465243;43530.34704479372;43934.78032609817;44105.338419923086;44108.558914410445;36401.635983639826;36499.45250821186;36613.26773464462;36616.267674645824;36908.077298067765;27335.179944601692;27410;28056.579151312337;28095.297617559725;28716.712832871402 03:32:10 INFO - PID 12500 | |2;jquery.html;561.9831405057847;566.2921348314607;571.8541771848178;576.7692922830867;591.9526437884969;22422.215222467217;23258.534829303426;23306.18428355008;23340;23342.41643958902;26155.215343539723;26644.067457638987;26928.865355673242;26940.191794246155;27125.321866953334;6202.937970620293;6330.461910737593;6367.8408039798915;6376.776812811529;6382.648954307511;5813.82558523245;6313.084602732601;6330.240371155468;6332.841678958017;6344.7462101515885;6237.126802247689;6275.435210831024;6294.8111556653375;6295.811125666214;6301.8109456716375;6134.631922084667;6213.130161777355;6221.284552276478;6289.308176100625;6290.779822706229;5801.216835727165;5806.332271788756;5814.738336774855;5841.620294680833;5859.941400586024;30372.69627303743;30652.69347306543;31189.532157017664;31313.530297045563;31453.37093258145;2205.9558808823735;2244.876531790751;2254.740704818934;2255.898484568182;2258.412812668718;20474.18103275867;20840.166393344247;21780.782192178034;21799.564008719735;21813.23653672114;2445.9755402445926;2510.6736124303907;2531.2153232497985;2539.9365015874564;2542.8855701493476;154634;160396;161542;162052;162165.18917405457;15637.921810390875;15643.687126257639;16251.187440628159;16299.22913104775;16350.661162807053;24690.382740431633;24700.876495617766;24707.25878223656;24800.875995619906;24927.376815579755;10981.286216395909;11009.449527523591;11174.497147628375;11210.551577936954;11460.140489463156;9181.908180918239;10349.223808214414;10428.947855260827;10438.843417348746;10578.788424231472;8495.447795893248;9691.176250018687;9842.80314393708;10007.299489035844;10040.14658754014;2886.235147685865;2909.854507274628;2921.386508833169;2926.956095658567;3039.7568194544383;1032.1484775060605;1044.8484969679355;1045.639254457211;1050.4275170032352;1060.5386656804314;21396.358109256747;21684.24105156312;21736.565268694536;22083;22196.556068878534;1103.8013157631704;1118.0273162348808;1118.0552433193939;1123.0566324287638;1132.184826924613;11624.418779061014;11817.409129543488;11982;12010.879891200977;12047.096467764954;521376;590237;607762;625969;629048;118909;127547.36226318995;129618;131650;131657;1299.9545015924398;1323.556608536151;1355.6407551998727;1373.0663149058935;1391.8190635217356;22563.323100307018;22945.541089178456;22955.540889182455;22986.885065574566;23130.306090817303;61965;63646.3635363659;64491.35508644854;65132;67036;82230;82762;83858.58070709852;86368.5681571588;87356.56321718605;13397;13794;14923.179225142721;15309.23453827282;15731.528054158394;24542;24650.753492464846;24807.379815504755;24812.875935620206;24889.502209956063;19250.8074919249;19256.614867702847;19457.929813860374;19676.704849427555;19686;17590.472285831445;17699.73450398271;17920.551986200448;18144.364947226783;18146.909265454116;20311.79688203099;20523.58952820965;20624.865632390363;20695;20763.896180519;15537.533873983799;15555.222238887784;15587.376504939675;15594.532164035098;15631.06213627186;19942.90028549906;20030.599388011866;20164;20183.192672292942;20394.898025509778 03:32:10 INFO - PID 12500 | |3;mootools.html;1455.279636579893;1510.9320080596372;1515.9014664046829;1540.7842901993715;1548.5199588127684;14867.182304973236;15349.923250383761;15468.69062618747;15492.92253538732;15519.84480155198;15099.77350339743;15856.920715396436;15869.761953570705;15880.126593037377;15882.682346353065;2763.8341699498046;2807.4806160860308;2808.2277373722186;2810.18504633656;2811.732885375886;2663.161104252164;2679.102500662271;2732.781377489806;2782.5130602144645;2859.6997315281906;2734.8769305381206;2781.902633407831;2783.1233161554146;2784.0812531864435;2794.6506686664165;2573.189445324717;2652.191081720084;2654.3894904172053;2657.2028391482477;2708.2281549758422;2584.4443444659487;2633.0389407866182;2647.377866201441;2648.9933825146513;2651.668541432321;15216.771748423782;15236.314365853563;15254.542363729106;15255.38978440861;15256.23718814066;7922.881156782653;8184.468009579358;8195.549244791535;8207.917920820835;8212.63043163059;5312.150055991023;5606.467385598362;5741.138829175616;5753.82738517841;5755.539556835443;1934.8258656720964;1982.9107690153833;2024.8683835550642;2026.7669218039966;2068.803463670949;26613.068542600915;26851.597226041624;26942;26947.19158425231;26950.326241843915;7313.89029164563;7396.0754905636795;7413.332800048021;7542.208068152875;7633.503822251647;16561.6687666246;17491.125443727764;18083;18136;18267.63464730698;7710.614469276514;7893.289603935674;7907.9604601976625;7936.365090792723;7945.523268603903;7221.42228621709;7242.818929526804;7257.709691612276;7294.197638259787;7294.452916031319;5417.729113544307;5581.916271255935;5616.213730077792;5637.202343847401;5664.037113690682;1608.6139326561774;1628.0557276779439;1633.8529532342147;1651.2486818497796;1660.5018494451617;955.617752898846;964.6961207219844;964.9096520931442;986.7089208683456;998.1216529454034;8265.090840007595;8265.173482651808;8287.875681864776;8302.460340077876;8332.583370831435;763.0271403959996;775.0583041604477;778.283978739561;779.3336697123991;785.4148659248782;5077.289179514871;5148.459411761786;5674.943250567524;5679.119736440858;5761;21669.24157654506;22723.318300451014;22787.088516459156;22815;22852.2001729942;21661.56676866454;22257.220997265344;22571.322860314216;22585.0965961363;22777.202797901995;12242.265464072185;12305.32320722351;12309.630711078682;12336.259824410565;12350.38248087592;8690.404947137393;9120.361574689974;9162.862557061517;9198.540072996457;9443.95278023633;18998.525036874187;19040.428787136407;19358.322458713876;19552.120154592794;19718.60562788765;19689.80310196937;19933.401997940084;19985;20033;20135.194592216147;11314.321140731583;11362.091032717197;11367.772644547229;11383.146264030396;11390.487428065922;14257.786133207803;14293.213873237071;14314.069585476911;14331.78502322487;14447.927760361132;10938.890611093788;11052.889471105185;11069.889301107209;11180.329180249211;11224.94387528057;11171.888281117084;11221;11248.325100493996;11260.831087533857;11477.885221148015;9959.551820168255;10021.298509104292;10062.39625622465;10213.489325533843;10248.897511024794;8065.112837587743;8071.959640201996;8092.190780921861;8245;8277.710280140167;7503.7748867534065;7524.247575242432;7538.547687138789;7602;7728.4203684725 03:32:10 INFO - PID 12500 | |4;prototype.html;515.806572535299;528.735632183908;536.5841472858534;544.1755740053817;552.7899398228673;6082.4453729433635;6124.969375153118;6138.232720909892;6185.381461853818;6243.31430513761;6068.453839154476;6086.147939288503;6091;6101.664408457533;6139.206660969259;4814.253790662436;4862.78117484714;4869.196582563873;4872.731999740013;4923.458419573844;4637.1421287062;4765.3566768486335;4842.159979207896;4842.66101372904;4858.319835223072;4678.251479763238;4700.29495575663;4727.596130785829;4730.455997560273;4734.976325118387;4691.788869500898;4733.83431579893;4736.810527578893;4740.241561350202;4767.809287628491;4159.563245859202;4243.702940794145;4254.404383386328;4269.765162916038;4272.893177670552;5963.254593175853;5974.731137098841;6019.608725432877;6028.698565071729;6037.154798328237;5612.719364031782;5704.857378565527;5712.401187252046;5717.571182161313;5734.111212761987;6553.606783592952;6554.279029306773;6564.343565643445;6574.8356291093105;6626.503012274099;4906.484819094015;4923.876903077416;4926.950730492721;4938.876528086791;4954.281629163751;6610.471162307004;6703.547672948435;6789.568345323722;6838.829029274259;6845.828854278583;4925.236588328815;4991.13187279861;5069.467705890902;5092.694438333712;5101;5054.342935418372;5085.466026067284;5097.388313402341;5136.768845401966;5161.225816127536;5664.915026274609;5666.829995100154;5672.631278966854;5685.204071430003;5720.74256658443;6438.227412710411;6495.3179916109075;6554.901676474761;6558.475321974231;6575.210974683068;1754.3245850347453;1769.7169552074643;1775.8579313654877;1791.1850108200738;1800.8739388242698;1176.452949378543;1239.3926975781983;1264.4246867675186;1268.7145392286661;1271.7265787855656;6210.7515699372425;6226.941419958618;6257.499400047986;6273.654948977759;6295.307516173218;6664.300248473937;6741.056252124707;6748.29142939994;6753.628550429676;6802.523823332319;6133.29467111279;6183.474404675653;6187.412195841388;6229.127922090911;6300.842478938063;3502.562179727534;3542.6634469725336;3548.875789347412;3556.1287484566446;3560.3088532946645;7032.578045317297;7058.505904586732;7065.823354416078;7079.398251148607;7106.538075025107;6466.515011374166;6717.193936727624;6827.795166145023;6863.931360686429;6883.931160688429;6928.584284942919;6973.755918542826;7052.717891284291;7095.942176768679;7118.60847653384;6573.80278591643;6618.709351676377;6623;6723.193216814014;6732.124823772878;6496.155499784998;6514.250861150838;6646.870032094459;6650.767223147167;6661.233958094881;7023.754168604074;7076.22161562238;7086.574805511686;7100;7113.751018714527;5029.698218106925;5056.544910958031;5078.365204349457;5084.466131056186;5111.156659151198;6353.29855906635;6523.347665233438;6642.501812363996;6663.966680166568;6676.6995485202315;6490.870182596416;6521.315261897433;6521.771737989147;6559.836004099936;6581.2102547694585;6414.422701956846;6489.610623362613;6522;6523.9347606525225;6571.277159512354;6448.645324507197;6517.315681853337;6519.576227545194;6541.313162118099;6544.181977252843;6519.73921043172;6593.439557637655;6594.670266486753;6596.934030659632;6644.103046088716;6312.779052733133;6377.681115944091;6416.13382193398;6440.67796610177;6466.515011374072 03:32:10 INFO - PID 12500 | |5;yui.html;944.9149576538113;946.8911075226351;962.8218779525788;964.6045121500186;974.9902500974988;17405.738913916302;18259.45221643351;18293.634127317444;18293.634127317444;20329.085191166396;20830.791692083076;20986.475338116554;21001.369958901218;21374.465638359048;21387.144514219413;988.0070529118226;988.6737376665683;989.6833013435703;989.8020395920809;1004.8542961270612;982.9115379615833;1055.2665897201448;1058.8147074262013;1058.9417582032986;1059.0838924330437;1101.2951710905027;1111.0667039686662;1111.8999290063894;1112.8608923884515;1113.0427832064418;1110.5779803674552;1112.821948488238;1114.0029673442264;1115.1747706697026;1120.4957769003981;806.310604433207;817.0154963269306;817.4686453805015;817.4768148385039;819.8770184472318;20482.897585512124;20595.48511287215;20695.379138625864;20712.275070372463;21435.464113397134;22029.779702202934;22095.889520552457;22244.221452249094;22513.77486225133;22691.659625105636;16573.50279491617;16901.91549042259;16951.321947122102;16958.236879340337;17183.484495465156;3708.7033037356946;3749.793761343125;3756.1360886996144;3763.5483741950866;3765.4728338032696;142961;143480;143741.28129359285;144391.2780436091;146031;17141.314347425963;17301.4809555711;17331.960082394846;17385.217665205095;17392.21735021927;31841.52237716436;32429.675703243138;32516;32743.67256327454;33011;9565.90434095664;9592.808143837085;9638.277129215337;9638.566264518113;9683.515824208762;4651;4719.10337035962;4741.5021422750115;4762.833300834454;4766.523347665206;5233.842984710464;5362.249285100089;5370.087085195526;5407.972960135174;5411.026015317202;1123.7920984617872;1136.0400461609927;1153.429052618959;1156.346664134761;1172.7947609168361;660.389140045456;667.7262322447871;678.328454829715;680.8876535371708;686.8591938652564;12596.874031259571;12853.93573032129;13085.411156497981;13515.59453216405;13639.386227619781;695.4992405468055;703.1456780012207;706.4772068669148;719.8812195987604;723.5080145501005;5854.970725146347;5867.735951882176;5898.342618592794;6001.819945401645;6042.093685947055;126727.36636316759;126976.36511817382;128562;129891.35054324857;135421.3228933849;108262.91737082528;114028.42985785018;115318;116228.41885790517;119616.40191798985;98543.50728246456;100911.49544252231;101464.49267753614;102629;102638;13271.934463524849;13510.256935868621;13513.459461621818;13515.86484135146;13650.317484125953;44797;45505.317420239386;46038.539614603425;46139.538604613525;47309.29036064393;57695.71152144212;58589.121163181735;59984.700076499335;84905.1509484922;86629.1337086621;19812.50468738293;20020.49948751293;20061.09725062405;20245.785252884874;20269.59460810746;19879.11282968646;20707;20775.168993240706;20820.895895520425;20984.68522972126;19844.801551984874;19974.1011654473;20010.099545520778;20051.59896802085;20368.59262814765;21573.46066348291;21662.783372166075;21785.78214217901;21990.45023874416;22061.779382205972;19337.51656208606;19525.51186220356;19577;19616.509587260432;19887.10508027171;15288.923555382597;15329.693406131591;15419.61450963735;15917.52247432579;16005.199740013186;15451.536453906401;16017.67964640724;16143.434979775651;16372.83627163713;16606.335746570487 03:32:10 INFO - PID 12500 | __end_tp_report 03:32:10 INFO - PID 12500 | __start_cc_report 03:32:10 INFO - PID 12500 | _x_x_mozilla_cycle_collect,325 03:32:10 INFO - PID 12500 | __end_cc_report 03:32:10 INFO - PID 12500 | __startTimestamp1502015530437__endTimestamp 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | ------- Summary: start ------- 03:32:10 INFO - PID 12500 | Number of tests: 6 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | [#0] dojo.html Cycles:165 Average:6194.96 Median:6491.35 stddev:807.85 (12.4%) stddev-sans-first:781.38 03:32:10 INFO - PID 12500 | Values: 3463.2 3475.8 3523.1 3533.6 3563.5 6181.7 6233.0 6239.3 6316.8 6330.1 6121.5 6205.8 6218.0 6221.1 6260.4 5434.7 5436.7 5449.5 5453.5 5500.8 5484.9 5495.6 5496.9 5503.2 5566.1 5497.3 5506.6 5543.9 5551.1 5614.6 5338.1 5394.6 5429.8 5466.6 5523.4 5352.2 5385.5 5390.1 5406.4 5417.9 6134.5 6135.0 6169.3 6252.3 6273.4 6554.2 6641.3 6731.6 6749.8 6762.2 6780.4 6785.5 6866.0 6875.3 6898.4 6264.0 6298.3 6316.8 6330.1 6343.4 6897.6 6924.9 6927.4 6962.1 7017.4 6561.7 6618.1 6623.1 6638.2 6687.4 6701.8 6741.8 6793.7 6794.7 6818.5 6736.7 6779.1 6795.3 6807.9 6818.5 6706.5 6733.8 6760.6 6835.8 6839.3 4797.3 4882.3 4883.1 4937.4 4939.2 4304.8 4373.3 4403.1 4415.6 4438.6 6146.7 6301.9 6356.5 6359.8 6364.8 6711.1 6722.4 6733.8 6750.7 6753.5 6308.8 6357.1 6357.4 6359.6 6466.5 5418.3 5483.0 5484.7 5484.7 5486.9 7148.5 7151.6 7180.8 7216.6 7229.7 6676.1 6746.7 6756.1 6763.0 6771.4 7009.7 7035.0 7072.4 7074.6 7093.5 6613.8 6656.9 6663.2 6686.5 6779.3 6710.5 6716.2 6791.1 6804.8 6810.7 6491.5 6566.3 6576.0 6580.1 6581.4 6440.0 6535.5 6542.1 6544.1 6548.1 6477.5 6491.4 6502.0 6505.6 6576.9 6609.5 6654.1 6671.2 6715.7 6721.1 6164.8 6285.9 6343.4 6426.0 6465.5 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | [#1] ext.html Cycles:180 Average:41878.70 Median:37864.62 stddev:62026.87 (163.8%) stddev-sans-first:62124.42 03:32:10 INFO - PID 12500 | Values: 864.2 898.6 926.9 929.6 933.0 41382.6 42358.8 42538.0 42561.4 42637.8 38530.0 38542.0 38849.2 38893.0 38945.6 6775.8 6875.5 6894.7 6904.9 6941.1 6743.0 6831.8 6832.4 6833.5 6838.7 6788.3 6800.2 6810.5 6810.5 6839.8 6765.9 6774.5 6776.5 6779.1 6782.3 6322.0 6325.6 6379.6 6408.6 6412.8 33883.0 34114.0 34116.3 34132.5 34184.3 3225.5 3251.8 3253.4 3257.7 3257.8 27128.5 27592.9 27816.9 27864.6 27945.7 4558.9 4595.8 4596.1 4607.9 4632.2 211940.0 213960.0 214215.0 214292.0 216724.9 50871.2 50924.0 50939.0 50989.5 51009.7 53015.5 53382.2 53426.5 53437.7 53538.5 16410.5 16529.6 16548.7 16558.3 16920.6 14028.9 14063.5 14083.4 14085.2 14086.9 13160.1 13184.7 13218.9 13283.9 13342.6 5322.2 5325.4 5341.9 5349.3 5438.6 1073.1 1076.4 1090.7 1103.1 1107.7 24588.1 30985.4 31393.7 31415.8 32155.0 1148.2 1151.2 1162.2 1165.9 1166.4 13004.4 13260.5 13312.6 13359.2 13492.2 265816.0 269684.0 270398.0 270646.0 271024.0 52586.0 53064.5 53141.0 53269.7 53310.5 1454.7 1475.7 1513.5 1519.6 1534.7 24716.5 30138.5 30146.4 30722.2 30936.7 54986.2 54997.0 55094.4 55132.2 55269.2 225479.0 227389.0 228169.0 228703.0 229853.0 32758.8 33235.8 33600.8 35549.6 42725.6 51885.5 52057.5 52554.7 52759.5 53571.7 37820.4 38009.0 38176.0 38257.6 38270.0 37591.8 37908.8 38231.8 38267.8 38314.0 42902.4 43530.3 43934.8 44105.3 44108.6 36401.6 36499.5 36613.3 36616.3 36908.1 27335.2 27410.0 28056.6 28095.3 28716.7 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | [#2] jquery.html Cycles:180 Average:39951.33 Median:12409.61 stddev:100156.34 (807.1%) stddev-sans-first:100393.63 03:32:10 INFO - PID 12500 | Values: 562.0 566.3 571.9 576.8 592.0 22422.2 23258.5 23306.2 23340.0 23342.4 26155.2 26644.1 26928.9 26940.2 27125.3 6202.9 6330.5 6367.8 6376.8 6382.6 5813.8 6313.1 6330.2 6332.8 6344.7 6237.1 6275.4 6294.8 6295.8 6301.8 6134.6 6213.1 6221.3 6289.3 6290.8 5801.2 5806.3 5814.7 5841.6 5859.9 30372.7 30652.7 31189.5 31313.5 31453.4 2206.0 2244.9 2254.7 2255.9 2258.4 20474.2 20840.2 21780.8 21799.6 21813.2 2446.0 2510.7 2531.2 2539.9 2542.9 154634.0 160396.0 161542.0 162052.0 162165.2 15637.9 15643.7 16251.2 16299.2 16350.7 24690.4 24700.9 24707.3 24800.9 24927.4 10981.3 11009.4 11174.5 11210.6 11460.1 9181.9 10349.2 10428.9 10438.8 10578.8 8495.4 9691.2 9842.8 10007.3 10040.1 2886.2 2909.9 2921.4 2927.0 3039.8 1032.1 1044.8 1045.6 1050.4 1060.5 21396.4 21684.2 21736.6 22083.0 22196.6 1103.8 1118.0 1118.1 1123.1 1132.2 11624.4 11817.4 11982.0 12010.9 12047.1 521376.0 590237.0 607762.0 625969.0 629048.0 118909.0 127547.4 129618.0 131650.0 131657.0 1300.0 1323.6 1355.6 1373.1 1391.8 22563.3 22945.5 22955.5 22986.9 23130.3 61965.0 63646.4 64491.4 65132.0 67036.0 82230.0 82762.0 83858.6 86368.6 87356.6 13397.0 13794.0 14923.2 15309.2 15731.5 24542.0 24650.8 24807.4 24812.9 24889.5 19250.8 19256.6 19457.9 19676.7 19686.0 17590.5 17699.7 17920.6 18144.4 18146.9 20311.8 20523.6 20624.9 20695.0 20763.9 15537.5 15555.2 15587.4 15594.5 15631.1 19942.9 20030.6 20164.0 20183.2 20394.9 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | [#3] mootools.html Cycles:180 Average:9629.31 Median:2653.29 stddev:6862.81 (258.7%) stddev-sans-first:6854.59 03:32:10 INFO - PID 12500 | Values: 1455.3 1510.9 1515.9 1540.8 1548.5 14867.2 15349.9 15468.7 15492.9 15519.8 15099.8 15856.9 15869.8 15880.1 15882.7 2763.8 2807.5 2808.2 2810.2 2811.7 2663.2 2679.1 2732.8 2782.5 2859.7 2734.9 2781.9 2783.1 2784.1 2794.7 2573.2 2652.2 2654.4 2657.2 2708.2 2584.4 2633.0 2647.4 2649.0 2651.7 15216.8 15236.3 15254.5 15255.4 15256.2 7922.9 8184.5 8195.5 8207.9 8212.6 5312.2 5606.5 5741.1 5753.8 5755.5 1934.8 1982.9 2024.9 2026.8 2068.8 26613.1 26851.6 26942.0 26947.2 26950.3 7313.9 7396.1 7413.3 7542.2 7633.5 16561.7 17491.1 18083.0 18136.0 18267.6 7710.6 7893.3 7908.0 7936.4 7945.5 7221.4 7242.8 7257.7 7294.2 7294.5 5417.7 5581.9 5616.2 5637.2 5664.0 1608.6 1628.1 1633.9 1651.2 1660.5 955.6 964.7 964.9 986.7 998.1 8265.1 8265.2 8287.9 8302.5 8332.6 763.0 775.1 778.3 779.3 785.4 5077.3 5148.5 5674.9 5679.1 5761.0 21669.2 22723.3 22787.1 22815.0 22852.2 21661.6 22257.2 22571.3 22585.1 22777.2 12242.3 12305.3 12309.6 12336.3 12350.4 8690.4 9120.4 9162.9 9198.5 9444.0 18998.5 19040.4 19358.3 19552.1 19718.6 19689.8 19933.4 19985.0 20033.0 20135.2 11314.3 11362.1 11367.8 11383.1 11390.5 14257.8 14293.2 14314.1 14331.8 14447.9 10938.9 11052.9 11069.9 11180.3 11224.9 11171.9 11221.0 11248.3 11260.8 11477.9 9959.6 10021.3 10062.4 10213.5 10248.9 8065.1 8072.0 8092.2 8245.0 8277.7 7503.8 7524.2 7538.5 7602.0 7728.4 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | [#4] prototype.html Cycles:180 Average:5544.04 Median:6186.40 stddev:1587.53 (25.7%) stddev-sans-first:1546.47 03:32:10 INFO - PID 12500 | Values: 515.8 528.7 536.6 544.2 552.8 6082.4 6125.0 6138.2 6185.4 6243.3 6068.5 6086.1 6091.0 6101.7 6139.2 4814.3 4862.8 4869.2 4872.7 4923.5 4637.1 4765.4 4842.2 4842.7 4858.3 4678.3 4700.3 4727.6 4730.5 4735.0 4691.8 4733.8 4736.8 4740.2 4767.8 4159.6 4243.7 4254.4 4269.8 4272.9 5963.3 5974.7 6019.6 6028.7 6037.2 5612.7 5704.9 5712.4 5717.6 5734.1 6553.6 6554.3 6564.3 6574.8 6626.5 4906.5 4923.9 4927.0 4938.9 4954.3 6610.5 6703.5 6789.6 6838.8 6845.8 4925.2 4991.1 5069.5 5092.7 5101.0 5054.3 5085.5 5097.4 5136.8 5161.2 5664.9 5666.8 5672.6 5685.2 5720.7 6438.2 6495.3 6554.9 6558.5 6575.2 1754.3 1769.7 1775.9 1791.2 1800.9 1176.5 1239.4 1264.4 1268.7 1271.7 6210.8 6226.9 6257.5 6273.7 6295.3 6664.3 6741.1 6748.3 6753.6 6802.5 6133.3 6183.5 6187.4 6229.1 6300.8 3502.6 3542.7 3548.9 3556.1 3560.3 7032.6 7058.5 7065.8 7079.4 7106.5 6466.5 6717.2 6827.8 6863.9 6883.9 6928.6 6973.8 7052.7 7095.9 7118.6 6573.8 6618.7 6623.0 6723.2 6732.1 6496.2 6514.3 6646.9 6650.8 6661.2 7023.8 7076.2 7086.6 7100.0 7113.8 5029.7 5056.5 5078.4 5084.5 5111.2 6353.3 6523.3 6642.5 6664.0 6676.7 6490.9 6521.3 6521.8 6559.8 6581.2 6414.4 6489.6 6522.0 6523.9 6571.3 6448.6 6517.3 6519.6 6541.3 6544.2 6519.7 6593.4 6594.7 6596.9 6644.1 6312.8 6377.7 6416.1 6440.7 6466.5 03:32:10 INFO - PID 12500 | 03:32:10 INFO - PID 12500 | [#5] yui.html Cycles:180 Average:26472.66 Median:20539.19 stddev:37141.84 (180.8%) stddev-sans-first:37196.57 03:32:10 INFO - PID 12500 | Values: 944.9 946.9 962.8 964.6 975.0 17405.7 18259.5 18293.6 18293.6 20329.1 20830.8 20986.5 21001.4 21374.5 21387.1 988.0 988.7 989.7 989.8 1004.9 982.9 1055.3 1058.8 1058.9 1059.1 1101.3 1111.1 1111.9 1112.9 1113.0 1110.6 1112.8 1114.0 1115.2 1120.5 806.3 817.0 817.5 817.5 819.9 20482.9 20595.5 20695.4 20712.3 21435.5 22029.8 22095.9 22244.2 22513.8 22691.7 16573.5 16901.9 16951.3 16958.2 17183.5 3708.7 3749.8 3756.1 3763.5 3765.5 142961.0 143480.0 143741.3 144391.3 146031.0 17141.3 17301.5 17332.0 17385.2 17392.2 31841.5 32429.7 32516.0 32743.7 33011.0 9565.9 9592.8 9638.3 9638.6 9683.5 4651.0 4719.1 4741.5 4762.8 4766.5 5233.8 5362.2 5370.1 5408.0 5411.0 1123.8 1136.0 1153.4 1156.3 1172.8 660.4 667.7 678.3 680.9 686.9 12596.9 12853.9 13085.4 13515.6 13639.4 695.5 703.1 706.5 719.9 723.5 5855.0 5867.7 5898.3 6001.8 6042.1 126727.4 126976.4 128562.0 129891.4 135421.3 108262.9 114028.4 115318.0 116228.4 119616.4 98543.5 100911.5 101464.5 102629.0 102638.0 13271.9 13510.3 13513.5 13515.9 13650.3 44797.0 45505.3 46038.5 46139.5 47309.3 57695.7 58589.1 59984.7 84905.2 86629.1 19812.5 20020.5 20061.1 20245.8 20269.6 19879.1 20707.0 20775.2 20820.9 20984.7 19844.8 19974.1 20010.1 20051.6 20368.6 21573.5 21662.8 21785.8 21990.5 22061.8 19337.5 19525.5 19577.0 19616.5 19887.1 15288.9 15329.7 15419.6 15917.5 16005.2 15451.5 16017.7 16143.4 16372.8 16606.3 03:32:10 INFO - PID 12500 | -------- Summary: end -------- 03:32:10 INFO - PID 12500 | 03:32:11 INFO - TEST-INFO | 12500: exit 0 03:32:11 INFO - TEST-OK | dromaeo_css | took 1110258ms 03:32:11 INFO - TEST-START | kraken 03:32:11 INFO - Initialising browser for kraken test... 03:32:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60976/getInfo.html -profile /tmp/tmpGccg99/profile 03:32:11 INFO - TEST-INFO | started process 12867 (/builds/slave/test/build/application/firefox/firefox http://localhost:60976/getInfo.html) 03:32:16 INFO - TEST-INFO | 12867: exit 0 03:32:16 INFO - Browser initialized. 03:32:16 INFO - Running cycle 1/1 for kraken test... 03:32:16 INFO - TEST-INFO | started process 13076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGccg99/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:17 INFO - PID 13076 | 03:32:17 INFO - PID 13076 | (/builds/slave/test/build/application/firefox/firefox:13124): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:32:17 INFO - PID 13076 | 03:32:28 INFO - PID 13076 | RSS: Main: 164331520 03:32:28 INFO - PID 13076 | 03:32:30 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-beat-detection) 03:32:31 INFO - PID 13076 | RSS: Main: 169025536 03:32:31 INFO - PID 13076 | 03:32:34 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-dft) 03:32:34 INFO - PID 13076 | RSS: Main: 170532864 03:32:34 INFO - PID 13076 | 03:32:37 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-fft) 03:32:38 INFO - PID 13076 | RSS: Main: 163680256 03:32:38 INFO - PID 13076 | 03:32:40 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-oscillator) 03:32:40 INFO - PID 13076 | RSS: Main: 164823040 03:32:40 INFO - PID 13076 | 03:32:43 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:32:43 INFO - PID 13076 | RSS: Main: 165019648 03:32:43 INFO - PID 13076 | 03:32:46 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-darkroom) 03:32:47 INFO - PID 13076 | RSS: Main: 165367808 03:32:47 INFO - PID 13076 | 03:32:50 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-desaturate) 03:32:51 INFO - PID 13076 | RSS: Main: 169762816 03:32:51 INFO - PID 13076 | 03:32:54 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60976/tests/kraken/driver.html?testName=json-parse-financial) 03:32:54 INFO - PID 13076 | RSS: Main: 167936000 03:32:54 INFO - PID 13076 | 03:32:56 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:32:56 INFO - PID 13076 | RSS: Main: 167919616 03:32:56 INFO - PID 13076 | 03:32:58 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:32:59 INFO - PID 13076 | RSS: Main: 167890944 03:32:59 INFO - PID 13076 | 03:33:01 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:33:02 INFO - PID 13076 | RSS: Main: 165195776 03:33:02 INFO - PID 13076 | 03:33:04 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:33:05 INFO - PID 13076 | RSS: Main: 164904960 03:33:05 INFO - PID 13076 | 03:33:08 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:33:08 INFO - PID 13076 | RSS: Main: 165892096 03:33:08 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60976/tests/kraken/driver.html?testName=ai-astar) 03:33:10 INFO - PID 13076 | RSS: Main: 167624704 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | __start_tp_report 03:33:10 INFO - PID 13076 | _x_x_mozilla_page_load 03:33:10 INFO - PID 13076 | _x_x_mozilla_page_load_details 03:33:10 INFO - PID 13076 | |i|pagename|runs| 03:33:10 INFO - PID 13076 | |0;ai-astar;98;105;99;105;106;108;107;103;105;109 03:33:10 INFO - PID 13076 | |1;audio-beat-detection;138;115;136;179;114;138;144;114;173;113 03:33:10 INFO - PID 13076 | |2;audio-dft;162;164;163;162;164;166;161;160;165;168 03:33:10 INFO - PID 13076 | |3;audio-fft;75;75;74;185;76;74;74;74;145;76 03:33:10 INFO - PID 13076 | |4;audio-oscillator;78;77;127;78;78;77;127;79;78;124 03:33:10 INFO - PID 13076 | |5;imaging-gaussian-blur;113;114;118;115;121;113;113;116;113;113 03:33:10 INFO - PID 13076 | |6;imaging-darkroom;150;148;161;149;149;148;148;148;148;149 03:33:10 INFO - PID 13076 | |7;imaging-desaturate;94;97;94;94;94;94;94;95;94;94 03:33:10 INFO - PID 13076 | |8;json-parse-financial;49;49;49;49;48;54;50;49;48;49 03:33:10 INFO - PID 13076 | |9;json-stringify-tinderbox;55;55;55;55;55;56;55;55;56;58 03:33:10 INFO - PID 13076 | |10;stanford-crypto-aes;78;75;75;76;76;75;81;76;76;75 03:33:10 INFO - PID 13076 | |11;stanford-crypto-ccm;120;120;125;119;114;120;117;119;116;171 03:33:10 INFO - PID 13076 | |12;stanford-crypto-pbkdf2;171;172;179;162;161;164;170;161;164;161 03:33:10 INFO - PID 13076 | |13;stanford-crypto-sha256-iterative;63;64;63;61;60;61;60;60;61;60 03:33:10 INFO - PID 13076 | __end_tp_report 03:33:10 INFO - PID 13076 | __start_cc_report 03:33:10 INFO - PID 13076 | _x_x_mozilla_cycle_collect,850 03:33:10 INFO - PID 13076 | __end_cc_report 03:33:10 INFO - PID 13076 | __startTimestamp1502015590701__endTimestamp 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | ------- Summary: start ------- 03:33:10 INFO - PID 13076 | Number of tests: 14 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#0] ai-astar Cycles:10 Average:104.50 Median:107.50 stddev:3.60 (3.3%) stddev-sans-first:2.95 03:33:10 INFO - PID 13076 | Values: 98.0 105.0 99.0 105.0 106.0 108.0 107.0 103.0 105.0 109.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:138.00 stddev:24.10 (17.5%) stddev-sans-first:25.55 03:33:10 INFO - PID 13076 | Values: 138.0 115.0 136.0 179.0 114.0 138.0 144.0 114.0 173.0 113.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.42 (1.5%) stddev-sans-first:2.50 03:33:10 INFO - PID 13076 | Values: 162.0 164.0 163.0 162.0 164.0 166.0 161.0 160.0 165.0 168.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.50 stddev:39.21 (52.6%) stddev-sans-first:41.06 03:33:10 INFO - PID 13076 | Values: 75.0 75.0 74.0 185.0 76.0 74.0 74.0 74.0 145.0 76.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:78.00 stddev:23.28 (29.8%) stddev-sans-first:24.11 03:33:10 INFO - PID 13076 | Values: 78.0 77.0 127.0 78.0 78.0 77.0 127.0 79.0 78.0 124.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:2.73 (2.4%) stddev-sans-first:2.80 03:33:10 INFO - PID 13076 | Values: 113.0 114.0 118.0 115.0 121.0 113.0 113.0 116.0 113.0 113.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.00 stddev:3.99 (2.7%) stddev-sans-first:4.24 03:33:10 INFO - PID 13076 | Values: 150.0 148.0 161.0 149.0 149.0 148.0 148.0 148.0 148.0 149.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 03:33:10 INFO - PID 13076 | Values: 94.0 97.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:1.71 (3.5%) stddev-sans-first:1.81 03:33:10 INFO - PID 13076 | Values: 49.0 49.0 49.0 49.0 48.0 54.0 50.0 49.0 48.0 49.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 03:33:10 INFO - PID 13076 | Values: 55.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 56.0 58.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.89 (2.5%) stddev-sans-first:1.90 03:33:10 INFO - PID 13076 | Values: 78.0 75.0 75.0 76.0 76.0 75.0 81.0 76.0 76.0 75.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:120.00 stddev:16.74 (13.9%) stddev-sans-first:17.69 03:33:10 INFO - PID 13076 | Values: 120.0 120.0 125.0 119.0 114.0 120.0 117.0 119.0 116.0 171.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.00 stddev:6.17 (3.7%) stddev-sans-first:6.32 03:33:10 INFO - PID 13076 | Values: 171.0 172.0 179.0 162.0 161.0 164.0 170.0 161.0 164.0 161.0 03:33:10 INFO - PID 13076 | 03:33:10 INFO - PID 13076 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.49 (2.4%) stddev-sans-first:1.45 03:33:10 INFO - PID 13076 | Values: 63.0 64.0 63.0 61.0 60.0 61.0 60.0 60.0 61.0 60.0 03:33:10 INFO - PID 13076 | -------- Summary: end -------- 03:33:10 INFO - PID 13076 | 03:33:11 INFO - PID 13076 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:33:11 INFO - TEST-INFO | 13076: exit 0 03:33:11 INFO - TEST-OK | kraken | took 60298ms 03:33:11 INFO - SUITE-END | took 1170s 03:33:11 INFO - Completed test suite (00:19:31) 03:33:11 INFO - javascript benchmark 03:33:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8864.05719156609, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.168839478524, 3475.7566970312087, 3523.083998160478, 3533.646635336465, 3563.518924945133, 6181.6600086995195, 6233.0, 6239.344868788774, 6316.810495685131, 6330.145430366899, 6121.540884433674, 6205.81382558524, 6218.036204388316, 6221.066839973995, 6260.405261500162, 5434.728263586825, 5436.673799572019, 5449.455054494539, 5453.536449401786, 5500.80747173847, 5484.91772623411, 5495.6427832190975, 5496.945030549683, 5503.174523821419, 5566.109422492402, 5497.340319161686, 5506.614536982413, 5543.889122217553, 5551.084071128259, 5614.606977511576, 5338.065838478289, 5394.568434525228, 5429.809956651518, 5466.617336786427, 5523.392426833045, 5352.223927530486, 5385.542228910547, 5390.056740070472, 5406.351237851483, 5417.945820541783, 6134.539909506805, 6134.96932515339, 6169.321374648785, 6252.3122456529745, 6273.435390814849, 6554.24626167992, 6641.302663220389, 6731.562448440835, 6749.763758268437, 6762.154730658668, 6780.355866192704, 6785.491088168407, 6866.0, 6875.346842049998, 6898.413634841045, 6264.029075493306, 6298.338674439164, 6316.842078948017, 6330.050492426127, 6343.429091381798, 6897.62063086525, 6924.861502769916, 6927.376536111774, 6962.1297337832775, 7017.368436840607, 6561.737530498726, 6618.073469714244, 6623.07276981223, 6638.20341559016, 6687.431568316748, 6701.765438209639, 6741.797746067626, 6793.728250870009, 6794.660266986631, 6818.454523638097, 6736.696848641823, 6779.0509328694025, 6795.320467953264, 6807.897881531781, 6818.488613353919, 6706.463482921355, 6733.7643182489355, 6760.560563563353, 6835.7949261522235, 6839.316068393121, 4797.304390863375, 4882.316475693406, 4883.121038213156, 4937.432195297515, 4939.234418665113, 4304.78476076195, 4373.278409062469, 4403.053343531156, 4415.558444155558, 4438.622717069021, 6146.661933593606, 6301.936980630227, 6356.523260755462, 6359.8092057238355, 6364.777232796922, 6711.094002309724, 6722.361375669304, 6733.797986060426, 6750.696218670171, 6753.527253092335, 6308.810735677937, 6357.078223657636, 6357.427831495188, 6359.586626869239, 6466.4503517201565, 5418.295621569249, 5482.972585137129, 5484.670919744828, 5484.725763711878, 5486.862828429321, 7148.499605027599, 7151.642417879085, 7180.78457646261, 7216.567005979553, 7229.674664640103, 6676.132102826601, 6746.69639866217, 6756.054152418764, 6763.0, 6771.3905748482875, 7009.684564194726, 7035.0, 7072.3634872861685, 7074.646267686492, 7093.538919970186, 6613.834654133492, 6656.900146497709, 6663.167104111986, 6686.531942764154, 6779.288174741779, 6710.4631629470505, 6716.227633822173, 6791.083203767428, 6804.795856124324, 6810.693518791567, 6491.545591808528, 6566.277709452052, 6576.013597960345, 6580.1116849226655, 6581.407673309425, 6440.0, 6535.477161826947, 6542.1168142300185, 6544.149260596092, 6548.0832683425315, 6477.481801455778, 6491.350864913471, 6502.0, 6505.60966342021, 6576.901346479903, 6609.504287178384, 6654.13496245485, 6671.166104236971, 6715.731370745116, 6721.092652492047, 6164.753409863555, 6285.905711414241, 6343.429091381798, 6426.0, 6465.547411681137], "value": 6133.052320136291, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.1841071437017, 898.6435662799445, 926.8887733471983, 929.5723966975191, 932.9830484771597, 41382.58617413825, 42358.788206059005, 42538.0, 42561.36157957629, 42637.78681106598, 38530.0, 38542.0, 38849.223015539676, 38893.0, 38945.61054389455, 6775.796726098212, 6875.484338674594, 6894.655267236643, 6904.861902761942, 6941.097657304544, 6743.0, 6831.829204269909, 6832.385085342318, 6833.521653484258, 6838.7264509419565, 6788.253292137861, 6800.217974932896, 6810.455163586926, 6810.455163586926, 6839.760608378708, 6765.93234067658, 6774.491913106512, 6776.491763117761, 6779.0509328694025, 6782.253952065269, 6322.0200868865395, 6325.620462772203, 6379.649119298437, 6408.58344207625, 6412.807615771534, 33883.0, 34114.0, 34116.317673646634, 34132.48801267983, 34184.31631367384, 3225.5000474926424, 3251.788633738823, 3253.3655937092276, 3257.690519400653, 3257.7719559630837, 27128.45743085127, 27592.862035689894, 27816.860915695495, 27864.582031269547, 27945.720542794515, 4558.931616025762, 4595.816167353302, 4596.126735920165, 4607.861764147081, 4632.166210082184, 211940.0, 213960.0, 214215.0, 214292.0, 216724.9163754187, 50871.23693144606, 50924.0, 50939.0, 50989.49010509922, 51009.744951275745, 53015.46984530183, 53382.19926701103, 53426.46573534293, 53437.73281133569, 53538.464615354125, 16410.507684769476, 16529.586760330847, 16548.669026619402, 16558.254878530493, 16920.57698557546, 14028.929855350862, 14063.507777227953, 14083.366248518636, 14085.2253126077, 14086.859131408759, 13160.14459060158, 13184.73630527384, 13218.867811321763, 13283.93358033223, 13342.599722008355, 5322.175062865262, 5325.3875804282225, 5341.919871201935, 5349.331333583302, 5438.619296649275, 1073.0932362153967, 1076.3918386111823, 1090.650991682654, 1103.0568863621647, 1107.6621630402803, 24588.139415120742, 30985.380292394027, 31393.686063139077, 31415.842920785708, 32155.035348939567, 1148.2478976270556, 1151.1711567671264, 1162.1690491298762, 1165.947532361046, 1166.3585028234438, 13004.41039114128, 13260.469581216836, 13312.600621981355, 13359.198448092951, 13492.19046857172, 265816.0, 269684.0, 270398.0, 270646.0, 271024.0, 52586.0, 53064.469355306726, 53141.0, 53269.733651331495, 53310.46689533055, 1454.7090581883665, 1475.7343678138038, 1513.4551561437875, 1519.620094976256, 1534.700733357007, 24716.50566988614, 30138.54792178163, 30146.397072057996, 30722.231944201572, 30936.69063309428, 54986.17520737272, 54997.0, 55094.44905550893, 55132.17301740397, 55269.17096243479, 225479.0, 227389.0, 228169.0, 228703.0, 229853.0, 32758.836205818818, 33235.83382083074, 33600.83199584084, 35549.644503554635, 42725.572744273406, 51885.48114518807, 52057.47942520678, 52554.73722631362, 52759.472405275454, 53571.7321413406, 37820.43269351017, 38009.049773755876, 38176.04559886025, 38257.6174238254, 38270.0, 37591.81204093962, 37908.81045594755, 38231.808840955615, 38267.808660956514, 38314.0, 42902.35646465243, 43530.34704479372, 43934.78032609817, 44105.338419923086, 44108.558914410445, 36401.635983639826, 36499.45250821186, 36613.26773464462, 36616.267674645824, 36908.077298067765, 27335.179944601692, 27410.0, 28056.579151312337, 28095.297617559725, 28716.712832871402], "value": 17934.078138108813, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9831405057847, 566.2921348314607, 571.8541771848178, 576.7692922830867, 591.9526437884969, 22422.215222467217, 23258.534829303426, 23306.18428355008, 23340.0, 23342.41643958902, 26155.215343539723, 26644.067457638987, 26928.865355673242, 26940.191794246155, 27125.321866953334, 6202.937970620293, 6330.461910737593, 6367.8408039798915, 6376.776812811529, 6382.648954307511, 5813.82558523245, 6313.084602732601, 6330.240371155468, 6332.841678958017, 6344.7462101515885, 6237.126802247689, 6275.435210831024, 6294.8111556653375, 6295.811125666214, 6301.8109456716375, 6134.631922084667, 6213.130161777355, 6221.284552276478, 6289.308176100625, 6290.779822706229, 5801.216835727165, 5806.332271788756, 5814.738336774855, 5841.620294680833, 5859.941400586024, 30372.69627303743, 30652.69347306543, 31189.532157017664, 31313.530297045563, 31453.37093258145, 2205.9558808823735, 2244.876531790751, 2254.740704818934, 2255.898484568182, 2258.412812668718, 20474.18103275867, 20840.166393344247, 21780.782192178034, 21799.564008719735, 21813.23653672114, 2445.9755402445926, 2510.6736124303907, 2531.2153232497985, 2539.9365015874564, 2542.8855701493476, 154634.0, 160396.0, 161542.0, 162052.0, 162165.18917405457, 15637.921810390875, 15643.687126257639, 16251.187440628159, 16299.22913104775, 16350.661162807053, 24690.382740431633, 24700.876495617766, 24707.25878223656, 24800.875995619906, 24927.376815579755, 10981.286216395909, 11009.449527523591, 11174.497147628375, 11210.551577936954, 11460.140489463156, 9181.908180918239, 10349.223808214414, 10428.947855260827, 10438.843417348746, 10578.788424231472, 8495.447795893248, 9691.176250018687, 9842.80314393708, 10007.299489035844, 10040.14658754014, 2886.235147685865, 2909.854507274628, 2921.386508833169, 2926.956095658567, 3039.7568194544383, 1032.1484775060605, 1044.8484969679355, 1045.639254457211, 1050.4275170032352, 1060.5386656804314, 21396.358109256747, 21684.24105156312, 21736.565268694536, 22083.0, 22196.556068878534, 1103.8013157631704, 1118.0273162348808, 1118.0552433193939, 1123.0566324287638, 1132.184826924613, 11624.418779061014, 11817.409129543488, 11982.0, 12010.879891200977, 12047.096467764954, 521376.0, 590237.0, 607762.0, 625969.0, 629048.0, 118909.0, 127547.36226318995, 129618.0, 131650.0, 131657.0, 1299.9545015924398, 1323.556608536151, 1355.6407551998727, 1373.0663149058935, 1391.8190635217356, 22563.323100307018, 22945.541089178456, 22955.540889182455, 22986.885065574566, 23130.306090817303, 61965.0, 63646.3635363659, 64491.35508644854, 65132.0, 67036.0, 82230.0, 82762.0, 83858.58070709852, 86368.5681571588, 87356.56321718605, 13397.0, 13794.0, 14923.179225142721, 15309.23453827282, 15731.528054158394, 24542.0, 24650.753492464846, 24807.379815504755, 24812.875935620206, 24889.502209956063, 19250.8074919249, 19256.614867702847, 19457.929813860374, 19676.704849427555, 19686.0, 17590.472285831445, 17699.73450398271, 17920.551986200448, 18144.364947226783, 18146.909265454116, 20311.79688203099, 20523.58952820965, 20624.865632390363, 20695.0, 20763.896180519, 15537.533873983799, 15555.222238887784, 15587.376504939675, 15594.532164035098, 15631.06213627186, 19942.90028549906, 20030.599388011866, 20164.0, 20183.192672292942, 20394.898025509778], "value": 12825.131410788681, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.279636579893, 1510.9320080596372, 1515.9014664046829, 1540.7842901993715, 1548.5199588127684, 14867.182304973236, 15349.923250383761, 15468.69062618747, 15492.92253538732, 15519.84480155198, 15099.77350339743, 15856.920715396436, 15869.761953570705, 15880.126593037377, 15882.682346353065, 2763.8341699498046, 2807.4806160860308, 2808.2277373722186, 2810.18504633656, 2811.732885375886, 2663.161104252164, 2679.102500662271, 2732.781377489806, 2782.5130602144645, 2859.6997315281906, 2734.8769305381206, 2781.902633407831, 2783.1233161554146, 2784.0812531864435, 2794.6506686664165, 2573.189445324717, 2652.191081720084, 2654.3894904172053, 2657.2028391482477, 2708.2281549758422, 2584.4443444659487, 2633.0389407866182, 2647.377866201441, 2648.9933825146513, 2651.668541432321, 15216.771748423782, 15236.314365853563, 15254.542363729106, 15255.38978440861, 15256.23718814066, 7922.881156782653, 8184.468009579358, 8195.549244791535, 8207.917920820835, 8212.63043163059, 5312.150055991023, 5606.467385598362, 5741.138829175616, 5753.82738517841, 5755.539556835443, 1934.8258656720964, 1982.9107690153833, 2024.8683835550642, 2026.7669218039966, 2068.803463670949, 26613.068542600915, 26851.597226041624, 26942.0, 26947.19158425231, 26950.326241843915, 7313.89029164563, 7396.0754905636795, 7413.332800048021, 7542.208068152875, 7633.503822251647, 16561.6687666246, 17491.125443727764, 18083.0, 18136.0, 18267.63464730698, 7710.614469276514, 7893.289603935674, 7907.9604601976625, 7936.365090792723, 7945.523268603903, 7221.42228621709, 7242.818929526804, 7257.709691612276, 7294.197638259787, 7294.452916031319, 5417.729113544307, 5581.916271255935, 5616.213730077792, 5637.202343847401, 5664.037113690682, 1608.6139326561774, 1628.0557276779439, 1633.8529532342147, 1651.2486818497796, 1660.5018494451617, 955.617752898846, 964.6961207219844, 964.9096520931442, 986.7089208683456, 998.1216529454034, 8265.090840007595, 8265.173482651808, 8287.875681864776, 8302.460340077876, 8332.583370831435, 763.0271403959996, 775.0583041604477, 778.283978739561, 779.3336697123991, 785.4148659248782, 5077.289179514871, 5148.459411761786, 5674.943250567524, 5679.119736440858, 5761.0, 21669.24157654506, 22723.318300451014, 22787.088516459156, 22815.0, 22852.2001729942, 21661.56676866454, 22257.220997265344, 22571.322860314216, 22585.0965961363, 22777.202797901995, 12242.265464072185, 12305.32320722351, 12309.630711078682, 12336.259824410565, 12350.38248087592, 8690.404947137393, 9120.361574689974, 9162.862557061517, 9198.540072996457, 9443.95278023633, 18998.525036874187, 19040.428787136407, 19358.322458713876, 19552.120154592794, 19718.60562788765, 19689.80310196937, 19933.401997940084, 19985.0, 20033.0, 20135.194592216147, 11314.321140731583, 11362.091032717197, 11367.772644547229, 11383.146264030396, 11390.487428065922, 14257.786133207803, 14293.213873237071, 14314.069585476911, 14331.78502322487, 14447.927760361132, 10938.890611093788, 11052.889471105185, 11069.889301107209, 11180.329180249211, 11224.94387528057, 11171.888281117084, 11221.0, 11248.325100493996, 11260.831087533857, 11477.885221148015, 9959.551820168255, 10021.298509104292, 10062.39625622465, 10213.489325533843, 10248.897511024794, 8065.112837587743, 8071.959640201996, 8092.190780921861, 8245.0, 8277.710280140167, 7503.7748867534065, 7524.247575242432, 7538.547687138789, 7602.0, 7728.4203684725], "value": 6870.283117360582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.806572535299, 528.735632183908, 536.5841472858534, 544.1755740053817, 552.7899398228673, 6082.4453729433635, 6124.969375153118, 6138.232720909892, 6185.381461853818, 6243.31430513761, 6068.453839154476, 6086.147939288503, 6091.0, 6101.664408457533, 6139.206660969259, 4814.253790662436, 4862.78117484714, 4869.196582563873, 4872.731999740013, 4923.458419573844, 4637.1421287062, 4765.3566768486335, 4842.159979207896, 4842.66101372904, 4858.319835223072, 4678.251479763238, 4700.29495575663, 4727.596130785829, 4730.455997560273, 4734.976325118387, 4691.788869500898, 4733.83431579893, 4736.810527578893, 4740.241561350202, 4767.809287628491, 4159.563245859202, 4243.702940794145, 4254.404383386328, 4269.765162916038, 4272.893177670552, 5963.254593175853, 5974.731137098841, 6019.608725432877, 6028.698565071729, 6037.154798328237, 5612.719364031782, 5704.857378565527, 5712.401187252046, 5717.571182161313, 5734.111212761987, 6553.606783592952, 6554.279029306773, 6564.343565643445, 6574.8356291093105, 6626.503012274099, 4906.484819094015, 4923.876903077416, 4926.950730492721, 4938.876528086791, 4954.281629163751, 6610.471162307004, 6703.547672948435, 6789.568345323722, 6838.829029274259, 6845.828854278583, 4925.236588328815, 4991.13187279861, 5069.467705890902, 5092.694438333712, 5101.0, 5054.342935418372, 5085.466026067284, 5097.388313402341, 5136.768845401966, 5161.225816127536, 5664.915026274609, 5666.829995100154, 5672.631278966854, 5685.204071430003, 5720.74256658443, 6438.227412710411, 6495.3179916109075, 6554.901676474761, 6558.475321974231, 6575.210974683068, 1754.3245850347453, 1769.7169552074643, 1775.8579313654877, 1791.1850108200738, 1800.8739388242698, 1176.452949378543, 1239.3926975781983, 1264.4246867675186, 1268.7145392286661, 1271.7265787855656, 6210.7515699372425, 6226.941419958618, 6257.499400047986, 6273.654948977759, 6295.307516173218, 6664.300248473937, 6741.056252124707, 6748.29142939994, 6753.628550429676, 6802.523823332319, 6133.29467111279, 6183.474404675653, 6187.412195841388, 6229.127922090911, 6300.842478938063, 3502.562179727534, 3542.6634469725336, 3548.875789347412, 3556.1287484566446, 3560.3088532946645, 7032.578045317297, 7058.505904586732, 7065.823354416078, 7079.398251148607, 7106.538075025107, 6466.515011374166, 6717.193936727624, 6827.795166145023, 6863.931360686429, 6883.931160688429, 6928.584284942919, 6973.755918542826, 7052.717891284291, 7095.942176768679, 7118.60847653384, 6573.80278591643, 6618.709351676377, 6623.0, 6723.193216814014, 6732.124823772878, 6496.155499784998, 6514.250861150838, 6646.870032094459, 6650.767223147167, 6661.233958094881, 7023.754168604074, 7076.22161562238, 7086.574805511686, 7100.0, 7113.751018714527, 5029.698218106925, 5056.544910958031, 5078.365204349457, 5084.466131056186, 5111.156659151198, 6353.29855906635, 6523.347665233438, 6642.501812363996, 6663.966680166568, 6676.6995485202315, 6490.870182596416, 6521.315261897433, 6521.771737989147, 6559.836004099936, 6581.2102547694585, 6414.422701956846, 6489.610623362613, 6522.0, 6523.9347606525225, 6571.277159512354, 6448.645324507197, 6517.315681853337, 6519.576227545194, 6541.313162118099, 6544.181977252843, 6519.73921043172, 6593.439557637655, 6594.670266486753, 6596.934030659632, 6644.103046088716, 6312.779052733133, 6377.681115944091, 6416.13382193398, 6440.67796610177, 6466.515011374072], "value": 5083.591496389483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.9149576538113, 946.8911075226351, 962.8218779525788, 964.6045121500186, 974.9902500974988, 17405.738913916302, 18259.45221643351, 18293.634127317444, 18293.634127317444, 20329.085191166396, 20830.791692083076, 20986.475338116554, 21001.369958901218, 21374.465638359048, 21387.144514219413, 988.0070529118226, 988.6737376665683, 989.6833013435703, 989.8020395920809, 1004.8542961270612, 982.9115379615833, 1055.2665897201448, 1058.8147074262013, 1058.9417582032986, 1059.0838924330437, 1101.2951710905027, 1111.0667039686662, 1111.8999290063894, 1112.8608923884515, 1113.0427832064418, 1110.5779803674552, 1112.821948488238, 1114.0029673442264, 1115.1747706697026, 1120.4957769003981, 806.310604433207, 817.0154963269306, 817.4686453805015, 817.4768148385039, 819.8770184472318, 20482.897585512124, 20595.48511287215, 20695.379138625864, 20712.275070372463, 21435.464113397134, 22029.779702202934, 22095.889520552457, 22244.221452249094, 22513.77486225133, 22691.659625105636, 16573.50279491617, 16901.91549042259, 16951.321947122102, 16958.236879340337, 17183.484495465156, 3708.7033037356946, 3749.793761343125, 3756.1360886996144, 3763.5483741950866, 3765.4728338032696, 142961.0, 143480.0, 143741.28129359285, 144391.2780436091, 146031.0, 17141.314347425963, 17301.4809555711, 17331.960082394846, 17385.217665205095, 17392.21735021927, 31841.52237716436, 32429.675703243138, 32516.0, 32743.67256327454, 33011.0, 9565.90434095664, 9592.808143837085, 9638.277129215337, 9638.566264518113, 9683.515824208762, 4651.0, 4719.10337035962, 4741.5021422750115, 4762.833300834454, 4766.523347665206, 5233.842984710464, 5362.249285100089, 5370.087085195526, 5407.972960135174, 5411.026015317202, 1123.7920984617872, 1136.0400461609927, 1153.429052618959, 1156.346664134761, 1172.7947609168361, 660.389140045456, 667.7262322447871, 678.328454829715, 680.8876535371708, 686.8591938652564, 12596.874031259571, 12853.93573032129, 13085.411156497981, 13515.59453216405, 13639.386227619781, 695.4992405468055, 703.1456780012207, 706.4772068669148, 719.8812195987604, 723.5080145501005, 5854.970725146347, 5867.735951882176, 5898.342618592794, 6001.819945401645, 6042.093685947055, 126727.36636316759, 126976.36511817382, 128562.0, 129891.35054324857, 135421.3228933849, 108262.91737082528, 114028.42985785018, 115318.0, 116228.41885790517, 119616.40191798985, 98543.50728246456, 100911.49544252231, 101464.49267753614, 102629.0, 102638.0, 13271.934463524849, 13510.256935868621, 13513.459461621818, 13515.86484135146, 13650.317484125953, 44797.0, 45505.317420239386, 46038.539614603425, 46139.538604613525, 47309.29036064393, 57695.71152144212, 58589.121163181735, 59984.700076499335, 84905.1509484922, 86629.1337086621, 19812.50468738293, 20020.49948751293, 20061.09725062405, 20245.785252884874, 20269.59460810746, 19879.11282968646, 20707.0, 20775.168993240706, 20820.895895520425, 20984.68522972126, 19844.801551984874, 19974.1011654473, 20010.099545520778, 20051.59896802085, 20368.59262814765, 21573.46066348291, 21662.783372166075, 21785.78214217901, 21990.45023874416, 22061.779382205972, 19337.51656208606, 19525.51186220356, 19577.0, 19616.509587260432, 19887.10508027171, 15288.923555382597, 15329.693406131591, 15419.61450963735, 15917.52247432579, 16005.199740013186, 15451.536453906401, 16017.67964640724, 16143.434979775651, 16372.83627163713, 16606.335746570487], "value": 9844.752313937659, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 105.0, 99.0, 105.0, 106.0, 108.0, 107.0, 103.0, 105.0, 109.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 115.0, 136.0, 179.0, 114.0, 138.0, 144.0, 114.0, 173.0, 113.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 164.0, 166.0, 161.0, 160.0, 165.0, 168.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 185.0, 76.0, 74.0, 74.0, 74.0, 145.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 127.0, 78.0, 78.0, 77.0, 127.0, 79.0, 78.0, 124.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 118.0, 115.0, 121.0, 113.0, 113.0, 116.0, 113.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 161.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 49.0, 48.0, 54.0, 50.0, 49.0, 48.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 58.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 76.0, 76.0, 75.0, 81.0, 76.0, 76.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 125.0, 119.0, 114.0, 120.0, 117.0, 119.0, 116.0, 171.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 179.0, 162.0, 161.0, 164.0, 170.0, 161.0, 164.0, 161.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0], "value": 61.3, "unit": "score"}]}]} 03:33:11 INFO - Return code: 0 03:33:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:33:12 INFO - # TBPL SUCCESS # 03:33:12 INFO - Running post-action listener: _package_coverage_data 03:33:12 INFO - Running post-action listener: _resource_record_post_action 03:33:12 INFO - [mozharness: 2017-08-06 10:33:12.027402Z] Finished run-tests step (success) 03:33:12 INFO - Running post-run listener: _resource_record_post_run 03:33:12 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 425287680; Read time: 0; Write time: 528676 03:33:12 INFO - TinderboxPrint: CPU usage
13.1% 03:33:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:33:12 INFO - TinderboxPrint: I/O write bytes / time
425,287,680 / 528,676 03:33:12 INFO - TinderboxPrint: CPU idle
8,240.4 (86.9%) 03:33:12 INFO - TinderboxPrint: CPU user
1,189.9 (12.5%) 03:33:12 INFO - TinderboxPrint: Swap in / out
0 / 0 03:33:12 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 107503616; Read time: 0; Write time: 178316 03:33:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:33:12 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 316661760; Read time: 0; Write time: 350288 03:33:12 INFO - Running post-run listener: _upload_blobber_files 03:33:12 INFO - Blob upload gear active. 03:33:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:33:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:33:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:33:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:13 INFO - (blobuploader) - INFO - Done attempting. 03:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:33:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:20 INFO - (blobuploader) - INFO - Done attempting. 03:33:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:33:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:33:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:21 INFO - (blobuploader) - INFO - Done attempting. 03:33:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:33:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:33:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:22 INFO - (blobuploader) - INFO - Done attempting. 03:33:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:33:22 INFO - Return code: 0 03:33:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:33:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:33:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a31288a3c5bd97b1543f00138ad92babacc056f1f19500468dd1687ef1098cbc47fc2f347852b6edab2fdd8a9a702eba4c6a0b01e257ec283bfb345f7ae833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e976f57921fb455089b8fdf93dff0c0d3accc550123b6051611fed71c6bac664785a8f7426b496473d4e17996b2adaa6f0a517ebfb0fec13545b91903b9910", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1857664980cccd96536c44cdb8845b13baffb7dfd664f62c13ca141dee198a207ea6d721db908019f784d1d107b30fc99c52123a4e9364cf149fbb99b36ee8a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5eaba7f4db0e7fa024ce9b44b724031b8cb225201e201f014b21e4419c61d2276c8c18f232b99e8940bd7d44ecdc4c1ad632cae24a40d2bb18b6ca2de9e7a7"} 03:33:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:33:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:33:22 INFO - Contents: 03:33:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a31288a3c5bd97b1543f00138ad92babacc056f1f19500468dd1687ef1098cbc47fc2f347852b6edab2fdd8a9a702eba4c6a0b01e257ec283bfb345f7ae833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e976f57921fb455089b8fdf93dff0c0d3accc550123b6051611fed71c6bac664785a8f7426b496473d4e17996b2adaa6f0a517ebfb0fec13545b91903b9910", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1857664980cccd96536c44cdb8845b13baffb7dfd664f62c13ca141dee198a207ea6d721db908019f784d1d107b30fc99c52123a4e9364cf149fbb99b36ee8a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5eaba7f4db0e7fa024ce9b44b724031b8cb225201e201f014b21e4419c61d2276c8c18f232b99e8940bd7d44ecdc4c1ad632cae24a40d2bb18b6ca2de9e7a7"} 03:33:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:33:22 INFO - Copying logs to upload dir... 03:33:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:33:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.583543 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-06 03:33:22.427014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:33:22.434612) ========= 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=5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a31288a3c5bd97b1543f00138ad92babacc056f1f19500468dd1687ef1098cbc47fc2f347852b6edab2fdd8a9a702eba4c6a0b01e257ec283bfb345f7ae833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e976f57921fb455089b8fdf93dff0c0d3accc550123b6051611fed71c6bac664785a8f7426b496473d4e17996b2adaa6f0a517ebfb0fec13545b91903b9910", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1857664980cccd96536c44cdb8845b13baffb7dfd664f62c13ca141dee198a207ea6d721db908019f784d1d107b30fc99c52123a4e9364cf149fbb99b36ee8a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5eaba7f4db0e7fa024ce9b44b724031b8cb225201e201f014b21e4419c61d2276c8c18f232b99e8940bd7d44ecdc4c1ad632cae24a40d2bb18b6ca2de9e7a7"} build_url:https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/RrmsT3M2RgivG5vR4dxB5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a31288a3c5bd97b1543f00138ad92babacc056f1f19500468dd1687ef1098cbc47fc2f347852b6edab2fdd8a9a702eba4c6a0b01e257ec283bfb345f7ae833", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e976f57921fb455089b8fdf93dff0c0d3accc550123b6051611fed71c6bac664785a8f7426b496473d4e17996b2adaa6f0a517ebfb0fec13545b91903b9910", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1857664980cccd96536c44cdb8845b13baffb7dfd664f62c13ca141dee198a207ea6d721db908019f784d1d107b30fc99c52123a4e9364cf149fbb99b36ee8a9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b5eaba7f4db0e7fa024ce9b44b724031b8cb225201e201f014b21e4419c61d2276c8c18f232b99e8940bd7d44ecdc4c1ad632cae24a40d2bb18b6ca2de9e7a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:33:22.460092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:33:22.460405) ========= 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=5bd038846534b2fdfa68eeae000001e2-1502013879.997193-714184843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:33:22.546318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:33:22.546641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:33:22.546933) ========= ========= Total master_lag: 0.20 =========