builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1502276360.37 results: success (0) revision: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.373340) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.373728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.374023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.392987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.393254) ========= 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=930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 03:59:20-- 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% 42.8M=0s 2017-08-09 03:59:21 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.557724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.558139) ========= 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=930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.607624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:20.607927) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c5fbf49376351679dcc49f4cff26c3c2e055ccc --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 4c5fbf49376351679dcc49f4cff26c3c2e055ccc --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=930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 03:59:21,209 truncating revision to first 12 chars 2017-08-09 03:59:21,209 Setting DEBUG logging. 2017-08-09 03:59:21,209 attempt 1/10 2017-08-09 03:59:21,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c5fbf493763?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-09 03:59:21,709 unpacking tar archive at: mozilla-central-4c5fbf493763/testing/mozharness/ program finished with exit code 0 elapsedTime=0.851498 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:21.471729) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:21.472054) ========= script_repo_revision: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:21.472443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:21.472716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 03:59:21.479974) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-08-09 03:59:21.480252) ========= /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=930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:22 INFO - MultiFileLogger online at 20170809 03:59:22 in /builds/slave/test 03:59:22 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:59:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:22 INFO - {'append_to_log': False, 03:59:22 INFO - 'base_work_dir': '/builds/slave/test', 03:59:22 INFO - 'blob_upload_branch': 'Firefox', 03:59:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:22 INFO - 'branch': 'Firefox', 03:59:22 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:22 INFO - 'code_coverage': False, 03:59:22 INFO - 'config_files': ('talos/linux_config.py',), 03:59:22 INFO - 'default_actions': ('clobber', 03:59:22 INFO - 'read-buildbot-config', 03:59:22 INFO - 'download-and-extract', 03:59:22 INFO - 'populate-webroot', 03:59:22 INFO - 'create-virtualenv', 03:59:22 INFO - 'install', 03:59:22 INFO - 'setup-mitmproxy', 03:59:22 INFO - 'run-tests'), 03:59:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:22 INFO - 'disable_ccov_upload': False, 03:59:22 INFO - 'download_minidump_stackwalk': True, 03:59:22 INFO - 'download_symbols': 'ondemand', 03:59:22 INFO - 'enable_stylo': False, 03:59:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:22 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:22 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:22 INFO - 'gecko_profile': False, 03:59:22 INFO - 'gecko_profile_interval': 0, 03:59:22 INFO - 'installer_path': 'installer.exe', 03:59:22 INFO - 'log_level': 'info', 03:59:22 INFO - 'log_name': 'talos', 03:59:22 INFO - 'log_to_console': True, 03:59:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:22 INFO - 'opt_config_files': (), 03:59:22 INFO - 'pip_index': False, 03:59:22 INFO - 'suite': 'dromaeojs-e10s', 03:59:22 INFO - 'system_bits': '32', 03:59:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:22 INFO - 'title': 'talos-linux64-ix-022', 03:59:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:22 INFO - 'use_talos_json': True, 03:59:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:22 INFO - 'work_dir': 'build'} 03:59:22 INFO - [mozharness: 2017-08-09 10:59:22.177664Z] Running clobber step. 03:59:22 INFO - Running pre-action listener: _resource_record_pre_action 03:59:22 INFO - Running main action method: clobber 03:59:22 INFO - rmtree: /builds/slave/test/build 03:59:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:23 INFO - Running post-action listener: _resource_record_post_action 03:59:23 INFO - [mozharness: 2017-08-09 10:59:23.736630Z] Finished clobber step (success) 03:59:23 INFO - [mozharness: 2017-08-09 10:59:23.736732Z] Running read-buildbot-config step. 03:59:23 INFO - Running pre-action listener: _resource_record_pre_action 03:59:23 INFO - Running main action method: read_buildbot_config 03:59:23 INFO - Using buildbot properties: 03:59:23 INFO - { 03:59:23 INFO - "project": "", 03:59:23 INFO - "product": "firefox", 03:59:23 INFO - "who": "cbook@mozilla.com", 03:59:23 INFO - "installer_path": "public/build/target.tar.bz2", 03:59:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:59:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:59:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:59:23 INFO - "stage_platform": "linux64-pgo", 03:59:23 INFO - "basedir": "/builds/slave/test", 03:59:23 INFO - "buildnumber": 115, 03:59:23 INFO - "platform": "ubuntu64_hw", 03:59:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:23 INFO - "slavebuilddir": "test", 03:59:23 INFO - "taskId": "ZfAaStK_S8aZ5jrbD101jA", 03:59:23 INFO - "branch": "mozilla-central", 03:59:23 INFO - "script_repo_revision": "production", 03:59:23 INFO - "revision": "4c5fbf49376351679dcc49f4cff26c3c2e055ccc", 03:59:23 INFO - "slavename": "talos-linux64-ix-022", 03:59:23 INFO - "repo_path": "mozilla-central" 03:59:23 INFO - } 03:59:23 INFO - Finding installer, test and symbols from parent task. 03:59:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZfAaStK_S8aZ5jrbD101jA'}, attempt #1 03:59:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZfAaStK_S8aZ5jrbD101jA'}, attempt #1 03:59:24 INFO - Task dependencies: b6_t7mZnTm6xRxmqjuSdEg 03:59:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg'}, attempt #1 03:59:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2 03:59:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.test_packages.json 03:59:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.crashreporter-symbols.zip 03:59:25 INFO - Running post-action listener: _resource_record_post_action 03:59:25 INFO - [mozharness: 2017-08-09 10:59:25.081432Z] Finished read-buildbot-config step (success) 03:59:25 INFO - [mozharness: 2017-08-09 10:59:25.081655Z] Running download-and-extract step. 03:59:25 INFO - Running pre-action listener: _resource_record_pre_action 03:59:25 INFO - Running main action method: download_and_extract 03:59:25 INFO - mkdir: /builds/slave/test/build/tests 03:59:25 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:59:25 INFO - trying https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.test_packages.json 03:59:25 INFO - Downloading https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:59:25 INFO - Downloaded 989 bytes. 03:59:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:59:25 INFO - Using the following test package requirements: 03:59:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:59:25 INFO - u'common': [u'target.common.tests.zip'], 03:59:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:59:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:59:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:59:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:59:25 INFO - u'mozbase': [u'target.common.tests.zip'], 03:59:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:59:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:59:25 INFO - u'web-platform': [u'target.common.tests.zip', 03:59:25 INFO - u'target.web-platform.tests.tar.gz'], 03:59:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:59:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:59:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.common.tests.zip 03:59:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:25 INFO - Fetch https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.common.tests.zip into memory 03:59:26 INFO - Content-Length response header: 54901103 03:59:26 INFO - Bytes received: 54901103 03:59:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:59:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.common.tests.zip 03:59:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:37 INFO - Fetch https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.common.tests.zip into memory 03:59:38 INFO - Content-Length response header: 54901103 03:59:38 INFO - Bytes received: 54901103 03:59:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.talos.tests.zip 03:59:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:59:52 INFO - Fetch https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.talos.tests.zip into memory 03:59:53 INFO - Content-Length response header: 14496008 03:59:53 INFO - Bytes received: 14496008 03:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:53 INFO - trying https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2 03:59:53 INFO - Downloading https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:59:54 INFO - Downloaded 62695184 bytes. 03:59:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2 03:59:54 INFO - mkdir: /builds/slave/test/properties 03:59:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:54 INFO - Contents: 03:59:54 INFO - build_url:https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2 03:59:54 INFO - Running post-action listener: _resource_record_post_action 03:59:54 INFO - Running post-action listener: set_extra_try_arguments 03:59:54 INFO - [mozharness: 2017-08-09 10:59:54.694395Z] Finished download-and-extract step (success) 03:59:54 INFO - [mozharness: 2017-08-09 10:59:54.694493Z] Running populate-webroot step. 03:59:54 INFO - Running pre-action listener: _resource_record_pre_action 03:59:54 INFO - Running main action method: populate_webroot 03:59:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:59:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:59:54 INFO - 'tests': ['damp', 'tps']}, 03:59:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:59:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:59:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:59:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:54 INFO - 'ts_paint', 03:59:54 INFO - 'tpaint', 03:59:54 INFO - 'sessionrestore', 03:59:54 INFO - 'sessionrestore_many_windows', 03:59:54 INFO - 'sessionrestore_no_auto_restore', 03:59:54 INFO - 'tabpaint']}, 03:59:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:59:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:59:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:54 INFO - 'tsvgr_opacity', 03:59:54 INFO - 'tart', 03:59:54 INFO - 'tscrollx', 03:59:54 INFO - 'tsvg_static']}, 03:59:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:59:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:54 INFO - 'talos_options': ['--mitmproxy', 03:59:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:54 INFO - '--firstNonBlankPaint'], 03:59:54 INFO - 'tests': ['tp6_google', 03:59:54 INFO - 'tp6_youtube', 03:59:54 INFO - 'tp6_amazon', 03:59:54 INFO - 'tp6_facebook']}, 03:59:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:54 INFO - 'talos_options': ['--stylo', 03:59:54 INFO - '--mitmproxy', 03:59:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:54 INFO - '--firstNonBlankPaint'], 03:59:54 INFO - 'tests': ['tp6_google', 03:59:54 INFO - 'tp6_youtube', 03:59:54 INFO - 'tp6_amazon', 03:59:54 INFO - 'tp6_facebook']}, 03:59:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:54 INFO - 'talos_options': ['--stylo', 03:59:54 INFO - '--stylo-threads=1', 03:59:54 INFO - '--mitmproxy', 03:59:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:54 INFO - '--firstNonBlankPaint'], 03:59:54 INFO - 'tests': ['tp6_google', 03:59:54 INFO - 'tp6_youtube', 03:59:54 INFO - 'tp6_amazon', 03:59:54 INFO - 'tp6_facebook']}, 03:59:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:59:54 INFO - 'talos_options': ['--xperf_path', 03:59:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:54 INFO - 'tests': ['tp5n']}}} 03:59:54 INFO - Running post-action listener: _resource_record_post_action 03:59:54 INFO - [mozharness: 2017-08-09 10:59:54.702937Z] Finished populate-webroot step (success) 03:59:54 INFO - [mozharness: 2017-08-09 10:59:54.703027Z] Running create-virtualenv step. 03:59:54 INFO - Running pre-action listener: _resource_record_pre_action 03:59:54 INFO - Running main action method: create_virtualenv 03:59:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:54 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:59:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:59:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:54 INFO - Using real prefix '/usr' 03:59:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:57 INFO - Installing pip.................done. 03:59:57 INFO - Return code: 0 03:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:59:57 INFO - Reading from file tmpfile_stdout 03:59:57 INFO - Output received: 03:59:57 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:59:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:57 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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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:59:57 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:59:57 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:59:57 INFO - Using env: {'DISPLAY': ':0', 03:59:57 INFO - 'HOME': '/home/cltbld', 03:59:57 INFO - 'LANG': 'en_US.UTF-8', 03:59:57 INFO - 'LANGUAGE': 'en_US:en', 03:59:57 INFO - 'LOGNAME': 'cltbld', 03:59:57 INFO - 'MAIL': '/var/mail/cltbld', 03:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:57 INFO - 'MOZ_NO_REMOTE': '1', 03:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:57 INFO - 'NO_EM_RESTART': '1', 03:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:57 INFO - 'PWD': '/builds/slave/test', 03:59:57 INFO - 'SHELL': '/bin/bash', 03:59:57 INFO - 'SHLVL': '1', 03:59:57 INFO - 'TERM': 'linux', 03:59:57 INFO - 'TMOUT': '86400', 03:59:57 INFO - 'USER': 'cltbld', 03:59:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 03:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:57 INFO - '_': '/tools/buildbot/bin/python'} 03:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:57 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:59:57 INFO - Cleaning up... 03:59:57 INFO - Return code: 0 03:59:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:57 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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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:59:57 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:59:57 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:59:57 INFO - Using env: {'DISPLAY': ':0', 03:59:57 INFO - 'HOME': '/home/cltbld', 03:59:57 INFO - 'LANG': 'en_US.UTF-8', 03:59:57 INFO - 'LANGUAGE': 'en_US:en', 03:59:57 INFO - 'LOGNAME': 'cltbld', 03:59:57 INFO - 'MAIL': '/var/mail/cltbld', 03:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:57 INFO - 'MOZ_NO_REMOTE': '1', 03:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:57 INFO - 'NO_EM_RESTART': '1', 03:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:57 INFO - 'PWD': '/builds/slave/test', 03:59:57 INFO - 'SHELL': '/bin/bash', 03:59:57 INFO - 'SHLVL': '1', 03:59:57 INFO - 'TERM': 'linux', 03:59:57 INFO - 'TMOUT': '86400', 03:59:57 INFO - 'USER': 'cltbld', 03:59:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 03:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:57 INFO - '_': '/tools/buildbot/bin/python'} 03:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:57 INFO - Downloading/unpacking psutil>=3.1.1 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:59 INFO - Installing collected packages: psutil 03:59:59 INFO - Running setup.py install for psutil 03:59:59 INFO - building 'psutil._psutil_linux' extension 03:59:59 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:59:59 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:59:59 INFO - building 'psutil._psutil_posix' extension 03:59:59 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:59:59 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:59:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:59 INFO - Successfully installed psutil 03:59:59 INFO - Cleaning up... 03:59:59 INFO - Return code: 0 03:59:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:59:59 INFO - Using env: {'DISPLAY': ':0', 03:59:59 INFO - 'HOME': '/home/cltbld', 03:59:59 INFO - 'LANG': 'en_US.UTF-8', 03:59:59 INFO - 'LANGUAGE': 'en_US:en', 03:59:59 INFO - 'LOGNAME': 'cltbld', 03:59:59 INFO - 'MAIL': '/var/mail/cltbld', 03:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:59 INFO - 'MOZ_NO_REMOTE': '1', 03:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:59 INFO - 'NO_EM_RESTART': '1', 03:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:59 INFO - 'PWD': '/builds/slave/test', 03:59:59 INFO - 'SHELL': '/bin/bash', 03:59:59 INFO - 'SHLVL': '1', 03:59:59 INFO - 'TERM': 'linux', 03:59:59 INFO - 'TMOUT': '86400', 03:59:59 INFO - 'USER': 'cltbld', 03:59:59 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 03:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:59 INFO - '_': '/tools/buildbot/bin/python'} 03:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59:59 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:59:59 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:59:59 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:59:59 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 04:00:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:01 INFO - Installing collected packages: mozsystemmonitor 04:00:01 INFO - Running setup.py install for mozsystemmonitor 04:00:01 INFO - Successfully installed mozsystemmonitor 04:00:01 INFO - Cleaning up... 04:00:01 INFO - Return code: 0 04:00:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:00:01 INFO - Using env: {'DISPLAY': ':0', 04:00:01 INFO - 'HOME': '/home/cltbld', 04:00:01 INFO - 'LANG': 'en_US.UTF-8', 04:00:01 INFO - 'LANGUAGE': 'en_US:en', 04:00:01 INFO - 'LOGNAME': 'cltbld', 04:00:01 INFO - 'MAIL': '/var/mail/cltbld', 04:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:01 INFO - 'MOZ_NO_REMOTE': '1', 04:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:01 INFO - 'NO_EM_RESTART': '1', 04:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:01 INFO - 'PWD': '/builds/slave/test', 04:00:01 INFO - 'SHELL': '/bin/bash', 04:00:01 INFO - 'SHLVL': '1', 04:00:01 INFO - 'TERM': 'linux', 04:00:01 INFO - 'TMOUT': '86400', 04:00:01 INFO - 'USER': 'cltbld', 04:00:01 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:01 INFO - '_': '/tools/buildbot/bin/python'} 04:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:03 INFO - warning: no files found matching '*.txt' 04:00:03 INFO - no previously-included directories found matching 'build' 04:00:03 INFO - no previously-included directories found matching 'dist' 04:00:03 INFO - no previously-included directories found matching '.git*' 04:00:03 INFO - Installing collected packages: jsonschema, functools32 04:00:03 INFO - Running setup.py install for functools32 04:00:03 INFO - warning: no files found matching '*.txt' 04:00:03 INFO - no previously-included directories found matching 'build' 04:00:03 INFO - no previously-included directories found matching 'dist' 04:00:03 INFO - no previously-included directories found matching '.git*' 04:00:03 INFO - Successfully installed jsonschema functools32 04:00:03 INFO - Cleaning up... 04:00:03 INFO - Return code: 0 04:00:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:00:03 INFO - Using env: {'DISPLAY': ':0', 04:00:03 INFO - 'HOME': '/home/cltbld', 04:00:03 INFO - 'LANG': 'en_US.UTF-8', 04:00:03 INFO - 'LANGUAGE': 'en_US:en', 04:00:03 INFO - 'LOGNAME': 'cltbld', 04:00:03 INFO - 'MAIL': '/var/mail/cltbld', 04:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:03 INFO - 'MOZ_NO_REMOTE': '1', 04:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:03 INFO - 'NO_EM_RESTART': '1', 04:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:03 INFO - 'PWD': '/builds/slave/test', 04:00:03 INFO - 'SHELL': '/bin/bash', 04:00:03 INFO - 'SHLVL': '1', 04:00:03 INFO - 'TERM': 'linux', 04:00:03 INFO - 'TMOUT': '86400', 04:00:03 INFO - 'USER': 'cltbld', 04:00:03 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:03 INFO - '_': '/tools/buildbot/bin/python'} 04:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:00:04 INFO - Cleaning up... 04:00:04 INFO - Return code: 0 04:00:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:00:04 INFO - Using env: {'DISPLAY': ':0', 04:00:04 INFO - 'HOME': '/home/cltbld', 04:00:04 INFO - 'LANG': 'en_US.UTF-8', 04:00:04 INFO - 'LANGUAGE': 'en_US:en', 04:00:04 INFO - 'LOGNAME': 'cltbld', 04:00:04 INFO - 'MAIL': '/var/mail/cltbld', 04:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:04 INFO - 'MOZ_NO_REMOTE': '1', 04:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:04 INFO - 'NO_EM_RESTART': '1', 04:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:04 INFO - 'PWD': '/builds/slave/test', 04:00:04 INFO - 'SHELL': '/bin/bash', 04:00:04 INFO - 'SHLVL': '1', 04:00:04 INFO - 'TERM': 'linux', 04:00:04 INFO - 'TMOUT': '86400', 04:00:04 INFO - 'USER': 'cltbld', 04:00:04 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:04 INFO - '_': '/tools/buildbot/bin/python'} 04:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:05 INFO - Downloading docopt-0.6.1.tar.gz 04:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:06 INFO - Running setup.py install for blobuploader 04:00:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:06 INFO - Running setup.py install for requests 04:00:06 INFO - Running setup.py install for docopt 04:00:06 INFO - Successfully installed blobuploader requests docopt 04:00:06 INFO - Cleaning up... 04:00:06 INFO - Return code: 0 04:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:06 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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:06 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 04:00:06 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 04:00:06 INFO - Using env: {'DISPLAY': ':0', 04:00:06 INFO - 'HOME': '/home/cltbld', 04:00:06 INFO - 'LANG': 'en_US.UTF-8', 04:00:06 INFO - 'LANGUAGE': 'en_US:en', 04:00:06 INFO - 'LOGNAME': 'cltbld', 04:00:06 INFO - 'MAIL': '/var/mail/cltbld', 04:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:06 INFO - 'MOZ_NO_REMOTE': '1', 04:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:06 INFO - 'NO_EM_RESTART': '1', 04:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:06 INFO - 'PWD': '/builds/slave/test', 04:00:06 INFO - 'SHELL': '/bin/bash', 04:00:06 INFO - 'SHLVL': '1', 04:00:06 INFO - 'TERM': 'linux', 04:00:06 INFO - 'TMOUT': '86400', 04:00:06 INFO - 'USER': 'cltbld', 04:00:06 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:06 INFO - '_': '/tools/buildbot/bin/python'} 04:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:06 INFO - Running setup.py (path:/tmp/pip-5M75an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:06 INFO - Running setup.py (path:/tmp/pip-Jqr4H5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:06 INFO - Running setup.py (path:/tmp/pip-TekQOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:07 INFO - Running setup.py (path:/tmp/pip-WAb67B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:07 INFO - Running setup.py (path:/tmp/pip-3HGLBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:07 INFO - Running setup.py (path:/tmp/pip-h5tFd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:07 INFO - Running setup.py (path:/tmp/pip-Ba4Ppe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:07 INFO - Running setup.py (path:/tmp/pip-vLylw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:07 INFO - Running setup.py (path:/tmp/pip-zKg7ZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:07 INFO - Running setup.py (path:/tmp/pip-LO3Fz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:07 INFO - Running setup.py (path:/tmp/pip-LnEixT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:07 INFO - Running setup.py (path:/tmp/pip-6KVX4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:07 INFO - Running setup.py (path:/tmp/pip-Mfdo2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:07 INFO - Running setup.py (path:/tmp/pip-kbXhPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:07 INFO - Running setup.py (path:/tmp/pip-KnsPIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:07 INFO - Running setup.py (path:/tmp/pip-bk_bxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:08 INFO - Running setup.py (path:/tmp/pip-7SA8jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:08 INFO - Running setup.py install for manifestparser 04:00:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Running setup.py install for mozcrash 04:00:08 INFO - Running setup.py install for mozdebug 04:00:08 INFO - Running setup.py install for mozdevice 04:00:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Running setup.py install for mozfile 04:00:08 INFO - Running setup.py install for mozhttpd 04:00:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Running setup.py install for mozinfo 04:00:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Running setup.py install for mozInstall 04:00:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:08 INFO - Running setup.py install for mozleak 04:00:08 INFO - Running setup.py install for mozlog 04:00:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Running setup.py install for moznetwork 04:00:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Running setup.py install for mozprocess 04:00:09 INFO - Running setup.py install for mozprofile 04:00:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Running setup.py install for mozrunner 04:00:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Running setup.py install for mozscreenshot 04:00:09 INFO - Running setup.py install for moztest 04:00:09 INFO - Running setup.py install for mozversion 04:00:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:09 INFO - Cleaning up... 04:00:09 INFO - Return code: 0 04:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:09 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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:09 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 04:00:09 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 04:00:09 INFO - Using env: {'DISPLAY': ':0', 04:00:09 INFO - 'HOME': '/home/cltbld', 04:00:09 INFO - 'LANG': 'en_US.UTF-8', 04:00:09 INFO - 'LANGUAGE': 'en_US:en', 04:00:09 INFO - 'LOGNAME': 'cltbld', 04:00:09 INFO - 'MAIL': '/var/mail/cltbld', 04:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:09 INFO - 'MOZ_NO_REMOTE': '1', 04:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:09 INFO - 'NO_EM_RESTART': '1', 04:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:09 INFO - 'PWD': '/builds/slave/test', 04:00:09 INFO - 'SHELL': '/bin/bash', 04:00:09 INFO - 'SHLVL': '1', 04:00:09 INFO - 'TERM': 'linux', 04:00:09 INFO - 'TMOUT': '86400', 04:00:09 INFO - 'USER': 'cltbld', 04:00:09 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:09 INFO - '_': '/tools/buildbot/bin/python'} 04:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:10 INFO - Running setup.py (path:/tmp/pip-tGcjrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:10 INFO - Running setup.py (path:/tmp/pip-IQwEFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:10 INFO - Running setup.py (path:/tmp/pip-fEBDai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:10 INFO - Running setup.py (path:/tmp/pip-jhGVkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:10 INFO - Running setup.py (path:/tmp/pip-uD6u7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:10 INFO - Running setup.py (path:/tmp/pip-p5IVPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:10 INFO - Running setup.py (path:/tmp/pip-GKgLTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:10 INFO - Running setup.py (path:/tmp/pip-n5IqNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:10 INFO - Running setup.py (path:/tmp/pip-84S16g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:10 INFO - Running setup.py (path:/tmp/pip-m0s7GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:10 INFO - Running setup.py (path:/tmp/pip-BHT5jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:10 INFO - Running setup.py (path:/tmp/pip-ctbKtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:10 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)) 04:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:10 INFO - Running setup.py (path:/tmp/pip-4Da8hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:11 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)) 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:11 INFO - Running setup.py (path:/tmp/pip-jyhfmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:11 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)) 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:11 INFO - Running setup.py (path:/tmp/pip-aFZs4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:11 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)) 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:11 INFO - Running setup.py (path:/tmp/pip-5g75xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:11 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)) 04:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:11 INFO - Running setup.py (path:/tmp/pip-v9hjp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:11 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)) 04:00:11 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)) 04:00:11 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)) 04:00:11 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)) 04:00:11 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)) 04:00:11 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)) 04:00:11 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)) 04:00:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:12 INFO - Downloading blessings-1.6.tar.gz 04:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:12 INFO - Installing collected packages: blessings 04:00:12 INFO - Running setup.py install for blessings 04:00:12 INFO - Successfully installed blessings 04:00:12 INFO - Cleaning up... 04:00:12 INFO - Return code: 0 04:00:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:12 INFO - Reading from file tmpfile_stdout 04:00:12 INFO - Current package versions: 04:00:12 INFO - argparse == 1.2.1 04:00:12 INFO - blessings == 1.6 04:00:12 INFO - blobuploader == 1.2.4 04:00:12 INFO - docopt == 0.6.1 04:00:12 INFO - functools32 == 3.2.3-2 04:00:12 INFO - jsonschema == 2.5.1 04:00:12 INFO - manifestparser == 1.1 04:00:12 INFO - mozInstall == 1.13 04:00:12 INFO - mozcrash == 1.0 04:00:12 INFO - mozdebug == 0.1 04:00:12 INFO - mozdevice == 0.51 04:00:12 INFO - mozfile == 1.2 04:00:12 INFO - mozhttpd == 0.7 04:00:12 INFO - mozinfo == 0.10 04:00:12 INFO - mozleak == 0.1 04:00:12 INFO - mozlog == 3.5 04:00:12 INFO - moznetwork == 0.27 04:00:12 INFO - mozprocess == 0.25 04:00:12 INFO - mozprofile == 0.28 04:00:12 INFO - mozrunner == 6.13 04:00:12 INFO - mozscreenshot == 0.1 04:00:12 INFO - mozsystemmonitor == 0.3 04:00:12 INFO - moztest == 0.8 04:00:12 INFO - mozversion == 1.4 04:00:12 INFO - psutil == 3.1.1 04:00:12 INFO - requests == 1.2.3 04:00:12 INFO - wsgiref == 0.1.2 04:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:12 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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:12 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 04:00:12 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 04:00:12 INFO - Using env: {'DISPLAY': ':0', 04:00:12 INFO - 'HOME': '/home/cltbld', 04:00:12 INFO - 'LANG': 'en_US.UTF-8', 04:00:12 INFO - 'LANGUAGE': 'en_US:en', 04:00:12 INFO - 'LOGNAME': 'cltbld', 04:00:12 INFO - 'MAIL': '/var/mail/cltbld', 04:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:12 INFO - 'MOZ_NO_REMOTE': '1', 04:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:12 INFO - 'NO_EM_RESTART': '1', 04:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:12 INFO - 'PWD': '/builds/slave/test', 04:00:12 INFO - 'SHELL': '/bin/bash', 04:00:12 INFO - 'SHLVL': '1', 04:00:12 INFO - 'TERM': 'linux', 04:00:12 INFO - 'TMOUT': '86400', 04:00:12 INFO - 'USER': 'cltbld', 04:00:12 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:12 INFO - '_': '/tools/buildbot/bin/python'} 04:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 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)) 04:00:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:00:14 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)) 04:00:14 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)) 04:00:14 INFO - Installing collected packages: simplejson 04:00:14 INFO - Running setup.py install for simplejson 04:00:14 INFO - building 'simplejson._speedups' extension 04:00:14 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 04:00:15 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 04:00:15 INFO - Successfully installed simplejson 04:00:15 INFO - Cleaning up... 04:00:15 INFO - Return code: 0 04:00:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:15 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 0x21db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, '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': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', '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 04:00:15 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 04:00:15 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 04:00:15 INFO - Using env: {'DISPLAY': ':0', 04:00:15 INFO - 'HOME': '/home/cltbld', 04:00:15 INFO - 'LANG': 'en_US.UTF-8', 04:00:15 INFO - 'LANGUAGE': 'en_US:en', 04:00:15 INFO - 'LOGNAME': 'cltbld', 04:00:15 INFO - 'MAIL': '/var/mail/cltbld', 04:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:15 INFO - 'MOZ_NO_REMOTE': '1', 04:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:15 INFO - 'NO_EM_RESTART': '1', 04:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:15 INFO - 'PWD': '/builds/slave/test', 04:00:15 INFO - 'SHELL': '/bin/bash', 04:00:15 INFO - 'SHLVL': '1', 04:00:15 INFO - 'TERM': 'linux', 04:00:15 INFO - 'TMOUT': '86400', 04:00:15 INFO - 'USER': 'cltbld', 04:00:15 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:15 INFO - '_': '/tools/buildbot/bin/python'} 04:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:15 INFO - Cleaning up... 04:00:15 INFO - Return code: 0 04:00:15 INFO - Running post-action listener: _resource_record_post_action 04:00:15 INFO - Running post-action listener: _start_resource_monitoring 04:00:15 INFO - Starting resource monitoring. 04:00:15 INFO - [mozharness: 2017-08-09 11:00:15.745472Z] Finished create-virtualenv step (success) 04:00:15 INFO - [mozharness: 2017-08-09 11:00:15.745942Z] Running install step. 04:00:15 INFO - Running pre-action listener: _resource_record_pre_action 04:00:15 INFO - Running main action method: install 04:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:15 INFO - Reading from file tmpfile_stdout 04:00:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:16 INFO - Reading from file tmpfile_stdout 04:00:16 INFO - Output received: 04:00:16 INFO - Usage: mozinstall [options] installer 04:00:16 INFO - Options: 04:00:16 INFO - -h, --help show this help message and exit 04:00:16 INFO - -d DEST, --destination=DEST 04:00:16 INFO - Directory to install application into. [default: 04:00:16 INFO - "/builds/slave/test"] 04:00:16 INFO - --app=APP Application being installed. [default: firefox] 04:00:16 INFO - mkdir: /builds/slave/test/build/application 04:00:16 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'] 04:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:00:33 INFO - Reading from file tmpfile_stdout 04:00:33 INFO - Output received: 04:00:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:33 INFO - Running post-action listener: _resource_record_post_action 04:00:33 INFO - [mozharness: 2017-08-09 11:00:33.886155Z] Finished install step (success) 04:00:33 INFO - [mozharness: 2017-08-09 11:00:33.886438Z] Running setup-mitmproxy step. 04:00:33 INFO - Running pre-action listener: _resource_record_pre_action 04:00:33 INFO - Running main action method: setup_mitmproxy 04:00:33 INFO - Skipping: mitmproxy is not required 04:00:33 INFO - Running post-action listener: _resource_record_post_action 04:00:33 INFO - [mozharness: 2017-08-09 11:00:33.887603Z] Finished setup-mitmproxy step (success) 04:00:33 INFO - [mozharness: 2017-08-09 11:00:33.887922Z] Running run-tests step. 04:00:33 INFO - Running pre-action listener: _resource_record_pre_action 04:00:33 INFO - Running pre-action listener: _set_gcov_prefix 04:00:33 INFO - Running main action method: run_tests 04:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:33 INFO - Python 2.7.3 04:00:33 INFO - Return code: 0 04:00:33 INFO - grabbing minidump binary from tooltool 04:00: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')]} 04:00:33 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 0x25478a0>, '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 0x25487a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2548c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:33 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 04:00:33 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 04:00:33 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 04:00:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:34 INFO - Return code: 0 04:00:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:34 INFO - ENV: RUST_BACKTRACE is now full 04:00:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:34 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/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:00:34 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/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 04:00:34 INFO - Using env: {'DISPLAY': ':0', 04:00:34 INFO - 'HOME': '/home/cltbld', 04:00:34 INFO - 'LANG': 'en_US.UTF-8', 04:00:34 INFO - 'LANGUAGE': 'en_US:en', 04:00:34 INFO - 'LOGNAME': 'cltbld', 04:00:34 INFO - 'MAIL': '/var/mail/cltbld', 04:00:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:34 INFO - 'MOZ_NO_REMOTE': '1', 04:00:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:34 INFO - 'NO_EM_RESTART': '1', 04:00:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:34 INFO - 'PWD': '/builds/slave/test', 04:00:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:34 INFO - 'RUST_BACKTRACE': 'full', 04:00:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:00:34 INFO - 'SHELL': '/bin/bash', 04:00:34 INFO - 'SHLVL': '1', 04:00:34 INFO - 'TERM': 'linux', 04:00:34 INFO - 'TMOUT': '86400', 04:00:34 INFO - 'USER': 'cltbld', 04:00:34 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024', 04:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:34 INFO - '_': '/tools/buildbot/bin/python'} 04:00:34 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/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:00:34 INFO - mozversion application_buildid: 20170809093721 04:00:34 INFO - mozversion application_changeset: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc 04:00:34 INFO - mozversion application_display_name: Nightly 04:00:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:34 INFO - mozversion application_name: Firefox 04:00:34 INFO - mozversion application_remotingname: firefox 04:00:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:00:34 INFO - mozversion application_vendor: Mozilla 04:00:34 INFO - mozversion application_version: 57.0a1 04:00:34 INFO - mozversion platform_buildid: 20170809093721 04:00:34 INFO - mozversion platform_changeset: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc 04:00:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:00:34 INFO - mozversion platform_version: 57.0a1 04:00:34 INFO - using testdate: 1502276434 04:00:34 INFO - actual date: 1502276434 04:00:34 INFO - starting webserver on 'localhost:35040' 04:00:34 INFO - SUITE-START | Running 2 tests 04:00:34 INFO - TEST-START | dromaeo_css 04:00:34 INFO - Initialising browser for dromaeo_css test... 04:00:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35040/getInfo.html -profile /tmp/tmpLmnkOr/profile 04:00:34 INFO - TEST-INFO | started process 27446 (/builds/slave/test/build/application/firefox/firefox http://localhost:35040/getInfo.html) 04:00:40 INFO - TEST-INFO | 27446: exit 0 04:00:40 INFO - Browser initialized. 04:00:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:40 INFO - TEST-INFO | started process 27657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLmnkOr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:41 INFO - PID 27657 | 04:00:41 INFO - PID 27657 | (/builds/slave/test/build/application/firefox/firefox:27706): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:00:41 INFO - PID 27657 | 04:00:51 INFO - PID 27657 | RSS: Main: 161357824 04:00:51 INFO - PID 27657 | 04:03:50 INFO - PID 27657 | Cycle 1(1): loaded http://localhost:35040/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35040/tests/dromaeo/cssquery-ext.html) 04:03:51 INFO - PID 27657 | RSS: Main: 164098048 04:03:51 INFO - PID 27657 | 04:06:53 INFO - PID 27657 | Cycle 1(1): loaded http://localhost:35040/tests/dromaeo/cssquery-ext.html (next: http://localhost:35040/tests/dromaeo/cssquery-jquery.html) 04:06:53 INFO - PID 27657 | RSS: Main: 163729408 04:06:53 INFO - PID 27657 | 04:09:55 INFO - PID 27657 | Cycle 1(1): loaded http://localhost:35040/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35040/tests/dromaeo/cssquery-mootools.html) 04:09:56 INFO - PID 27657 | RSS: Main: 165535744 04:09:56 INFO - PID 27657 | 04:12:57 INFO - PID 27657 | Cycle 1(1): loaded http://localhost:35040/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35040/tests/dromaeo/cssquery-prototype.html) 04:12:58 INFO - PID 27657 | RSS: Main: 164118528 04:12:58 INFO - PID 27657 | 04:16:01 INFO - PID 27657 | Cycle 1(1): loaded http://localhost:35040/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35040/tests/dromaeo/cssquery-yui.html) 04:16:02 INFO - PID 27657 | RSS: Main: 167600128 04:16:02 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | Cycle 1(1): loaded http://localhost:35040/tests/dromaeo/cssquery-yui.html (next: http://localhost:35040/tests/dromaeo/cssquery-dojo.html) 04:19:03 INFO - PID 27657 | RSS: Main: 168804352 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | __start_tp_report 04:19:03 INFO - PID 27657 | _x_x_mozilla_page_load 04:19:03 INFO - PID 27657 | _x_x_mozilla_page_load_details 04:19:03 INFO - PID 27657 | |i|pagename|runs| 04:19:03 INFO - PID 27657 | |0;dojo.html;3515.7714748541357;3515.9824200878998;3536.646335366462;3546;3556.8043757593337;6214.53390995676;6294.276158241803;6312.77905273315;6347.016212487072;6360.681965901704;6207.348228436017;6288.8742225155465;6299.842503937404;6309.49524038077;6314.747410103601;5487.75305111271;5512.062949298609;5518.558515318785;5530.115181570949;5546.251256080438;5549.084401073818;5554.944450555503;5611.523020543259;5644.238027866247;5670.234518340033;5517.503424691777;5551.916721249185;5571.693556854371;5574;5590.524805391547;5415.296011518478;5482.314710661168;5482.753276102585;5499.615026948115;5544.667319960775;5378.731063446812;5442.428545002796;5449.237106805051;5474.945250547484;5491;6082.178905847698;6210.937890621126;6220.191375121205;6283.120363149163;6302.054691796221;6674.69963851623;6706.362895524917;6739.2249891262645;6739.831504212385;6881.41507971823;6793.184817821843;6856.485763567753;6916.688749006256;6957.199922008983;6978.267281935375;6310.148130002391;6316.115743795872;6377.457916077139;6391.584547004476;6395.712192951329;6981.685824137926;7019.087518622547;7090.539114957512;7092.716291348288;7097.254788247263;6584.934150658528;6633.800985970429;6646.900296495556;6686.264510903797;6690.59856408617;6747.932520674829;6909.7581584644295;6927.376536111673;6927.480438967098;6949.7567585134275;6744.393004629607;6768.2216545097945;6780.830479238059;6839.897401538981;6875.312468753084;6682.766103186365;6824.2152152503095;6826.965865170642;6886.586804791728;6899.827504312432;4927.876803079952;4945.307656928033;4979.6265280104135;4991.425986011583;4999.900002000012;4427.247367947457;4428.3800267962515;4440.888977775581;4445.377647129404;4468.128714900628;6339.492840572743;6383.6808159592765;6475.4819614430735;6481.254655714559;6565.376289252514;6861.142357205349;6924.930750692429;6926.896096558556;6930.792076237721;6937.167539895245;6490.740370385226;6496.512761542903;6505.512086593524;6577.046328282372;6584.703688334036;5447.264619276347;5521;5534.75093620788;5583.3858275589655;5583.748731307101;7261.491695581259;7280.381167600707;7304.977303177666;7310.122785265802;7316.890246646304;6721.327867213239;6801.761938332333;6867.313268673092;6870.587764734132;6885.51801373899;7020.227774944854;7198.964005179941;7202.315780000891;7261.927380726336;7294;6659.5671281368495;6706.0611514389;6786.558873673195;6801.18385793708;6801.2178599461695;6842.897356539556;6865.759698410531;6903.792886213421;6913.343232392915;6927.7228910845015;6607.603543787388;6628.5691430056895;6641.269460359454;6686.431653309523;6700.396964273239;6490.350964903472;6560.671966401756;6563.146790917151;6608.867822643617;6675.4325882300545;6573.5398522103;6587.077809106633;6613.107230523818;6689.732410703517;6700.4639628830555;6659.633720145439;6662.766803161866;6696.330366963265;6737.494687898526;6778;6467.126937863328;6485.481161507162;6543.869122617616;6548.148740663683;6572.34276572339 04:19:03 INFO - PID 27657 | |1;ext.html;747.249014740186;805.198827166969;827.8634025385811;829.746927187208;1206.1556910162888;34471;35081;44369.77815110924;44959.77520112395;45022;44971.55028449715;45073.7746311268;45373.77313113438;45500.31749523751;45619;7166.498345115844;7617.504862183954;7689.538627682357;7727.265909738566;7740.187280335568;7556.47104702671;7620.580868052255;7643.044619422572;7679;7684.692612295501;7578.317951384374;7604.581748003858;7666;7688.500247483896;7720.806979825493;7614.543127412346;7638.770836874903;7653.119891212526;7656.617169141548;7661.118971318314;7580.090389153282;7586.58273794941;7617.428692848059;7644.541327520366;7644.579548124851;40755.38866916999;40967.59032409667;41003;41022.179556409006;41041;3551.786892786441;3570.62508436613;3574.7318951078773;3595.0832537702718;3595.694365978895;31772.36455270905;31867;31904.361912761615;31975.040748777574;32142;4980.078685443204;5018.096742586333;5038.345015148044;5051.6716413433005;5064.392272927273;215367;216218;216255;216257;218232.9088354564;51467.74266128645;51470;51600.22599661008;51726.741366292925;51787.48212517826;53848.73075634675;53934.730326348115;54015.919681606145;54116;54278.18582721263;14222.857771422154;16951;17324.913375433043;17329.393471228446;17366.39217627402;11511.827322590168;13870.930645346709;14096.224707640973;14105.083169593943;14105.929470352583;14250.857491424953;14274.857251427353;14351.990721299026;14451.638709032148;14489.609214479493;5625.662460252398;5698.145278208219;5702.344230413472;5807.738651760681;5823.767049318065;1067.9092277156528;1081.2647399768234;1100.9394483303495;1105.8838821923582;1108.7228192951761;24607.753922460903;24725.629115563283;24726.629100563507;24836.627450588254;24896.626550601755;1202.8496437945257;1210.0863847794858;1217.7199244173712;1225.454672670653;1226.6565361698738;13256.138351007154;13312.400941957636;13315.46738130464;13382.46470141203;17504.299828006737;273877;273932;274613;275152;275264;61208.08187877185;61292.69353653293;61669.691651541456;61721.69139154276;62916.370836291964;1479.3564799312333;1523.6800271943016;1534.8388419216044;1545.9690806184037;1546.5824227458522;30321;30564.388712226075;30670.539941900442;31018.744581411163;31148.53277200889;55881.16178257248;56267.718661406434;56295.43704562902;56408.435915640315;56434.306970790945;237990;240017;241384;241829;241956;37401.6259837409;38745;39618.2076358477;39773.60226397699;39776.80111599423;47030;47877;47971;48688;48961;35772;35831.10422239465;36153.819230903675;36264.63735362612;36649.45025824561;35913;36038.8198059008;36239.275214495035;36417.27165456729;36440.81779591085;41925.58074419339;41941.37087943744;42178.15643687048;42361;42504.14991700087;45182.32226516671;45885.31172032355;46130.538694612624;46168;46349;29923.70076299209;32991.340173195924;33023.50464743079;33180.66819331776;33314 04:19:03 INFO - PID 27657 | |2;jquery.html;560.728046897255;569.4675478427667;573.6156774960778;575.6891278709497;594.088074805174;22697.886510567445;23596.174133905315;23647.17234896779;23675.76324236757;24697.87651061742;26561.86719066402;27342.863285683594;27414.177574672744;27439.17682469524;27480.45039099217;6104.511639068886;6279.30927597965;6418.679066046702;6422.197225346832;6423.132877061607;6250.249970003583;6328.493720502349;6329.335419780926;6330.27201871786;6357.554971152022;6299.622022678654;6319.115323854664;6322.936770632304;6353.364663533633;6358.968205158968;6309.652969086698;6320.336364681688;6328.90506642403;6332.841678958017;6358.745650173987;5851.912221316684;5881.3530511643685;5888.146218798293;5898.852528686774;5934.228550288478;29794.702052979625;30800.075997720105;32258;32389.51415728766;32414;2209.5249521352825;2230.9330720078424;2231.3306008197474;2234.7094877665963;2243.4391402149463;19592.510187245432;20222.19111235549;20240.089195986217;20266.493337666678;20282.188712451632;2359.5634807560655;2417.528581926525;2450.9877450612635;2481.1812102006475;2493.713222979344;154346;162123.18938405233;162153;162348;162545;15172.848271517365;15564.533064008097;15736.370545178064;15884.682306353809;16449.25978330978;24182.879085604458;24316.635250471256;24344.147954821496;24415.267541973768;24428;10011.749706257402;10115.949420252851;10141.594336226615;10154.543045562967;10225.48872556384;9022.774430639156;9206.447613143233;9576.090271424204;10010.399376037461;10310.484475776331;9554.713358599252;9852.901470985342;10114.898851011396;10132.189424845994;10176.949115254376;2874.3676391193903;2874.4107457971068;2900.5794159846705;2902.6081479000486;2979.687132851019;1034.2605037398296;1046.602291129366;1049.7060822969581;1050.7163065972145;1054.9419781911915;20976.89511552463;21462.570748585254;21557.46106347354;21895.781042189374;21948.561028779335;1098.555085190499;1119.7928383249125;1122.1247427006786;1130.5873356224918;1131.7170707323169;11514.30914145154;11965.880341196476;12211.877881221251;12222.694432639255;12226;582295;599461;610794;618912;623883;129630;130550.34724826315;131379;132873;137160;1240.8448943882195;1255.265669583304;1276.5787290194214;1277.2081309588116;1288.8646692097382;19203.90398048057;19416.902915485898;19419.70870436973;19437.31969381065;19927;64301.67849160724;65941.34058659352;66248;66466.33533664602;67849.3215067843;85603;85963;86241;87246;87670;14642;15042.097474151149;15049.54851354461;15061.623459413164;15073.547793566211;23757.524849503257;24025.75974240305;24038.759612404352;24194.153204637754;24689.25932222036;20819.167233310498;20847.687284690437;20897.58204835925;21009.054592543067;21305.467363316042;18673.15970781345;18842.717359239898;18863.43409697711;18954;19196.13617387193;21206.25778097759;21522.784772152077;21731.130754770264;21900;21978.89010554937;15113.773293400387;15147.621309467351;15156.621084472976;15299.694006120038;15376.154311512526;19337;20097.799022009593;20193.6970945433;20304.289349872684;20399.898000509904 04:19:03 INFO - PID 27657 | |3;mootools.html;1427.885769138469;1501.2343704710595;1509.592410049286;1515.0833745583918;1528.4726769264607;15151.92424037881;15788.605284867856;15850.445234416784;15858.841411585881;15891.761623575656;15385.307661155246;16439;16476.588085297873;16483.917580412082;16486.67026659469;2458.778709916103;2499.0503608628787;2500.5624015797252;2501.187114187887;2501.7498250174926;2580.406506503505;2636.4990651776197;2682.543967525525;2728.9317767055786;2729.508688436081;2664.2806442260576;2720.8095433319677;2722.414680843618;2750.8899644014214;2751.8899244030213;2318.1654604342425;2330.33585428153;2333.0900948630047;2339.9181028663916;2348.7768661977084;2392.880355982194;2436.610142377211;2438.451348446603;2442.413820683041;2546.1088618983395;15326.463573774976;15339.309731062018;15476.303566339542;15484.92257538705;15504.379824806994;7991.2807847294025;8276.048254450756;8300.626471808782;8302.169783021709;8302.66789328426;5124.256982737519;5199.402068762103;5375.623706340558;5376.542993845528;5408.35099788024;1893.3562588719763;1949.191085699433;1965.9187446904145;2007.5784085342095;2025.2101680344676;27164.728352716615;27243.591346129822;27281.31796705098;27320.180394587995;27439.725602743918;6571.605703657796;6628.668566571652;6695.497837662195;6747.628880411527;6785.796426107126;18203.180856861472;18252;18275.63448731018;18287.817121828877;18313.542161445803;8150.51096934174;8311.916880831115;8313.542755148404;8317.085120636724;8322.958385208156;7329.9267007329245;7439.479236453396;7575.166731659513;7650.73222437212;7656;5007.549320561094;5052.646314758005;5114.6931184128325;5218.843434696965;5225.50357716024;1538.853808888154;1553.495114087926;1568.7646852972146;1570.5052908334067;1585.3262363495699;898.1377877237794;902.8916530016309;904.1184844776291;915.7390143808982;921.4379228670506;8810.735677929672;9084.682036128705;9180.44917304964;9201.90798092024;9223.44659320443;1017.6692574913183;1022.4274406332478;1036.5231993283023;1040.9739756506149;1043.3531210649446;4658.208104622222;4758.976205118952;4762.571368576845;4803.639727020487;5285.127953887642;21483.355499335044;21859.890700546715;21919.890400547894;22070.66893996591;22293.219737309115;22139.44651383696;22140.889295553417;22184;22426.439339016655;22465.213717519808;11895;12249.877501225052;12320.507179712891;12361.07291953107;12506.062045346453;8277.490745492301;8342.457740246864;8403.453775504573;8428.747137585882;8549.786255343666;18714.532136696693;18908.716369254747;19248;19262.13320400557;19476.14976577223;19773.307934222234;19853.900730496254;20122.195112195936;20164.59670806605;20241.19035238574;11721.413929303671;11971.042316614825;11977.281363118242;11981.820272696092;11982.580609678967;14317.64205894861;14497.420103195755;14639.780403294171;14656.340464678902;14665.340059697553;11638.76722465529;11928.582499612472;12010.219335743499;12098.818517722417;12110.212836165621;11569.942150289195;11699.473523691624;11706.1220408468;11996.40017999114;12042.518299267931;9213.953930230306;9341.626334946526;9373;9381.765455863659;9382;7535.73624923125;7605.695772169051;7614.971978783015;7693.846123077619;7761.844763104819;7845.254700803414;7911.84176316459;7954.323882469824;7979.521228726295;8093.919060809317 04:19:03 INFO - PID 27657 | |4;prototype.html;511.9453924914674;529.2590373477132;538.3981165999465;541.3044238153973;543.8667526456018;6106.816795496131;6132.570720049593;6147.2008638877;6172.148355493357;6191.195144631203;6030.87938241236;6070.726817293222;6080.543959203055;6128.264608247016;6131.509479241661;4859.635527335455;4889.486603906592;4906.184711656692;4912.36139301892;4915.606751459874;4624.97687511562;4767.118083154627;4778.2115950868065;4860.513948605147;4911.533404326601;4651.209294419957;4673.943464875444;4696.131215725085;4728.4798672146035;4771.117343291502;4669.929951050737;4678.836240731575;4719.088769048541;4730.290456431546;4758.61931045519;4289.442372491588;4503.144402563503;4562.657800664931;4584.312353147055;4586.862394128181;5805.477507024346;5891.469767720926;5924.348321684612;5925.614835035752;6002.819915402545;5832.492028427774;5834.3873893241025;5914.112883067532;5943.673097979609;5988.461038506555;6548.93451065488;6573.638449885254;6589.604623722544;6606.405423511907;6640.203175618908;5226.346706661668;5269.973650131725;5275.894482110375;5279.205070276086;5317.574594032468;6378.87242255157;6552.541322107454;6617.8014659560295;6728.293529179415;6736.696848641823;5315;5330.680159190461;5358.571314294847;5376.462353764592;5412.756425960842;5392.514673679388;5465.316835395575;5487.478689524489;5493.697846618475;5507.201455788968;5910.408959104141;5927.347991720907;5935.358765349464;5935.495482883917;5949.851253718605;6434.8391290218115;6496.928006878812;6539.8365040873405;6565.818152732459;6590.736370545221;1914.9521261968562;1918.7601549806275;1920.6254780317704;1927.4603111128906;1948.0162517928638;1360.3606305036617;1431.105559025609;1434.3043623842427;1442.8773554247796;1459.7445447046725;6159.737253862947;6205.379462053758;6244.718987645567;6261.311255761862;6308.432241098323;6492.870142597216;6503.674816259168;6527.2167339919515;6624.966875165594;6632.535722499379;6205.379462053849;6225.408586184305;6236.220472440945;6239.376062393724;6241.656708881055;3455.9459364893446;3457.792532448061;3458.1354661334667;3497.7376696747847;3508.9649103508636;6880.931190688129;6935.202451718016;6948.580107516145;6955.756548520778;6995.313140196081;6691;6740.494462915203;6750.797476075725;6812.931870681329;6817.931820681829;6816.113905192294;6830.5218634697085;6850.588964662136;6869.793906182823;6929.792106236821;6462.127612772216;6520.673966301761;6527.445167160845;6564.934350656624;6592;6430.710618022294;6469.579477334147;6495.142137459692;6570.8028759137305;6619.569727967667;6919.481038922;6967.3626697727;6977.441804655514;6988;6996.895046574407;5397.595180361567;5410.783568657367;5432.76244529252;5447.591430642638;5451.56387488992;6406.23125224976;6579.374959378852;6580.605163690194;6594.769183078761;6596.60420374779;6289.465395441439;6403.295637479967;6418.582792118497;6448.9032664511005;6466.708998095191;6375.979843225062;6386.489080873426;6415.935840641534;6421.229452465547;6422.133012043314;6431.356864313531;6439.8068057958335;6465.644389558432;6466.127072845105;6480.416762491398;6357.664890373074;6384.361563843579;6385.169927909342;6450.935700575771;6460.903086453613;6163.876722465615;6214.875702486015;6274.874502510015;6294.716737746904;6307.233974487151 04:19:03 INFO - PID 27657 | |5;yui.html;943.4245110482605;955.5380268189672;972.3728195314022;975.4391225045598;975.8487434447663;18388.54028649283;18670.253189872423;18770.2491900324;18905.33831315904;21004.57990840186;21482;21856.8907155464;21924.342269731893;22038.449038774037;22077.779222207773;1034.8809886863014;1048.1824177141802;1056.0179033498844;1061.8141825180562;1064.074255397805;1075.6504136155781;1087;1087.624769454541;1092.956281748729;1093.9890601094007;1130.372643183033;1142.0692135909248;1155.6070935881799;1156.4217891054473;1157.3056166300237;1117.2291119127817;1133.659902029392;1141.8287256911447;1142.4573327669332;1143.999000874235;838.5010918503481;843.3211264931728;844.2612713875359;844.5566077809137;845.8858054162671;20106.19044286007;20417.693734593846;20449.795502044937;20839.687404688942;21074.157033718788;22040.669389959163;22597.322080337617;22716.091356345725;22855.31434056981;23050.42373940648;16904.577385565335;17286.22212000463;17502.387416440364;17557.736633950502;17584.032878191694;3753.230587729509;3755.2301778135416;3772.302124107049;3781.1303400218103;3787.1857550626746;147057;148894.25552872274;149086.25456872754;150682;150686.24656876756;17045.659086818443;17337.306507739802;17415.651686966445;17477.475675729747;17873.7318940216;32529.861454848968;32957.50563741546;33077.66922330794;33094.83452582722;33189.17027074342;8216.671333146727;8570.4000719949;8905.287576993825;9004.41471304363;9285.210757085588;4494.617957473586;4555.043440877386;4579.107074120515;4582.037772067836;4584.7936842842155;5604.8038318658655;5613.494785469327;5630.831075067673;5727.5990680652785;5733.369329373765;1164.6389619218069;1168.4917061078459;1187.6912002879142;1190.5118901250446;1201.6635342104225;671.2113266911457;682.154128880185;692.2039654397483;697.4141720954321;732.1653315220652;13203.207807531579;13404.396802143927;13469.393877275546;13542.526011589547;13610.047296689334;662.5726406467801;682.7303215229956;712.5795780489536;719.0616245799177;732.2567593892204;6680.131582894192;6829.419499342513;6928.44572434204;7054.188768291609;7060.258672839381;120508;125342;128457.35771321083;128606;131813;109702.45148774204;111464.4426777861;111870.44064779623;112807.43596281965;114730;95046;96221;96865;99013.50493247632;100593.99406005992;13769.105008174436;13983.860161398663;14030.649233769238;14147.575572732834;14217.715645687234;45946.54053459423;46964.7651761739;47579.76210118927;50685.493145068074;51420.48579514307;82071;83641;84971.5751421239;85223;86998;20443.795562044783;21097.472563186042;21245.89377053105;21582.784172158077;21672;22548.549029019658;23287;23691;23993.640095398234;24401.877990609933;21099.261525847134;21259.681104783132;21509.247176348752;21839.454013649785;22064.2277520286;20602.587948240653;21125;21814.345569632937;21820.45448863791;21913.123475061457;20341.084651191028;20701.964901755153;21058.78941210568;21078.894605526875;21172.25897093594;14017.229052402216;14455.277236138361;14657.706845863237;14757.704845902806;14970.925145374204;15403.152826594645;15514.612134696723;15949.202539873191;16148.515544533682;16590 04:19:03 INFO - PID 27657 | __end_tp_report 04:19:03 INFO - PID 27657 | __start_cc_report 04:19:03 INFO - PID 27657 | _x_x_mozilla_cycle_collect,327 04:19:03 INFO - PID 27657 | __end_cc_report 04:19:03 INFO - PID 27657 | __startTimestamp1502277543959__endTimestamp 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | ------- Summary: start ------- 04:19:03 INFO - PID 27657 | Number of tests: 6 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | [#0] dojo.html Cycles:165 Average:6275.45 Median:6577.05 stddev:824.66 (12.5%) stddev-sans-first:798.27 04:19:03 INFO - PID 27657 | Values: 3515.8 3516.0 3536.6 3546.0 3556.8 6214.5 6294.3 6312.8 6347.0 6360.7 6207.3 6288.9 6299.8 6309.5 6314.7 5487.8 5512.1 5518.6 5530.1 5546.3 5549.1 5554.9 5611.5 5644.2 5670.2 5517.5 5551.9 5571.7 5574.0 5590.5 5415.3 5482.3 5482.8 5499.6 5544.7 5378.7 5442.4 5449.2 5474.9 5491.0 6082.2 6210.9 6220.2 6283.1 6302.1 6674.7 6706.4 6739.2 6739.8 6881.4 6793.2 6856.5 6916.7 6957.2 6978.3 6310.1 6316.1 6377.5 6391.6 6395.7 6981.7 7019.1 7090.5 7092.7 7097.3 6584.9 6633.8 6646.9 6686.3 6690.6 6747.9 6909.8 6927.4 6927.5 6949.8 6744.4 6768.2 6780.8 6839.9 6875.3 6682.8 6824.2 6827.0 6886.6 6899.8 4927.9 4945.3 4979.6 4991.4 4999.9 4427.2 4428.4 4440.9 4445.4 4468.1 6339.5 6383.7 6475.5 6481.3 6565.4 6861.1 6924.9 6926.9 6930.8 6937.2 6490.7 6496.5 6505.5 6577.0 6584.7 5447.3 5521.0 5534.8 5583.4 5583.7 7261.5 7280.4 7305.0 7310.1 7316.9 6721.3 6801.8 6867.3 6870.6 6885.5 7020.2 7199.0 7202.3 7261.9 7294.0 6659.6 6706.1 6786.6 6801.2 6801.2 6842.9 6865.8 6903.8 6913.3 6927.7 6607.6 6628.6 6641.3 6686.4 6700.4 6490.4 6560.7 6563.1 6608.9 6675.4 6573.5 6587.1 6613.1 6689.7 6700.5 6659.6 6662.8 6696.3 6737.5 6778.0 6467.1 6485.5 6543.9 6548.1 6572.3 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | [#1] ext.html Cycles:180 Average:43495.34 Median:39695.90 stddev:63697.08 (160.5%) stddev-sans-first:63794.90 04:19:03 INFO - PID 27657 | Values: 747.2 805.2 827.9 829.7 1206.2 34471.0 35081.0 44369.8 44959.8 45022.0 44971.6 45073.8 45373.8 45500.3 45619.0 7166.5 7617.5 7689.5 7727.3 7740.2 7556.5 7620.6 7643.0 7679.0 7684.7 7578.3 7604.6 7666.0 7688.5 7720.8 7614.5 7638.8 7653.1 7656.6 7661.1 7580.1 7586.6 7617.4 7644.5 7644.6 40755.4 40967.6 41003.0 41022.2 41041.0 3551.8 3570.6 3574.7 3595.1 3595.7 31772.4 31867.0 31904.4 31975.0 32142.0 4980.1 5018.1 5038.3 5051.7 5064.4 215367.0 216218.0 216255.0 216257.0 218232.9 51467.7 51470.0 51600.2 51726.7 51787.5 53848.7 53934.7 54015.9 54116.0 54278.2 14222.9 16951.0 17324.9 17329.4 17366.4 11511.8 13870.9 14096.2 14105.1 14105.9 14250.9 14274.9 14352.0 14451.6 14489.6 5625.7 5698.1 5702.3 5807.7 5823.8 1067.9 1081.3 1100.9 1105.9 1108.7 24607.8 24725.6 24726.6 24836.6 24896.6 1202.8 1210.1 1217.7 1225.5 1226.7 13256.1 13312.4 13315.5 13382.5 17504.3 273877.0 273932.0 274613.0 275152.0 275264.0 61208.1 61292.7 61669.7 61721.7 62916.4 1479.4 1523.7 1534.8 1546.0 1546.6 30321.0 30564.4 30670.5 31018.7 31148.5 55881.2 56267.7 56295.4 56408.4 56434.3 237990.0 240017.0 241384.0 241829.0 241956.0 37401.6 38745.0 39618.2 39773.6 39776.8 47030.0 47877.0 47971.0 48688.0 48961.0 35772.0 35831.1 36153.8 36264.6 36649.5 35913.0 36038.8 36239.3 36417.3 36440.8 41925.6 41941.4 42178.2 42361.0 42504.1 45182.3 45885.3 46130.5 46168.0 46349.0 29923.7 32991.3 33023.5 33180.7 33314.0 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | [#2] jquery.html Cycles:180 Average:40472.06 Median:2220.23 stddev:102040.99 (4596.0%) stddev-sans-first:102283.24 04:19:03 INFO - PID 27657 | Values: 560.7 569.5 573.6 575.7 594.1 22697.9 23596.2 23647.2 23675.8 24697.9 26561.9 27342.9 27414.2 27439.2 27480.5 6104.5 6279.3 6418.7 6422.2 6423.1 6250.2 6328.5 6329.3 6330.3 6357.6 6299.6 6319.1 6322.9 6353.4 6359.0 6309.7 6320.3 6328.9 6332.8 6358.7 5851.9 5881.4 5888.1 5898.9 5934.2 29794.7 30800.1 32258.0 32389.5 32414.0 2209.5 2230.9 2231.3 2234.7 2243.4 19592.5 20222.2 20240.1 20266.5 20282.2 2359.6 2417.5 2451.0 2481.2 2493.7 154346.0 162123.2 162153.0 162348.0 162545.0 15172.8 15564.5 15736.4 15884.7 16449.3 24182.9 24316.6 24344.1 24415.3 24428.0 10011.7 10115.9 10141.6 10154.5 10225.5 9022.8 9206.4 9576.1 10010.4 10310.5 9554.7 9852.9 10114.9 10132.2 10176.9 2874.4 2874.4 2900.6 2902.6 2979.7 1034.3 1046.6 1049.7 1050.7 1054.9 20976.9 21462.6 21557.5 21895.8 21948.6 1098.6 1119.8 1122.1 1130.6 1131.7 11514.3 11965.9 12211.9 12222.7 12226.0 582295.0 599461.0 610794.0 618912.0 623883.0 129630.0 130550.3 131379.0 132873.0 137160.0 1240.8 1255.3 1276.6 1277.2 1288.9 19203.9 19416.9 19419.7 19437.3 19927.0 64301.7 65941.3 66248.0 66466.3 67849.3 85603.0 85963.0 86241.0 87246.0 87670.0 14642.0 15042.1 15049.5 15061.6 15073.5 23757.5 24025.8 24038.8 24194.2 24689.3 20819.2 20847.7 20897.6 21009.1 21305.5 18673.2 18842.7 18863.4 18954.0 19196.1 21206.3 21522.8 21731.1 21900.0 21978.9 15113.8 15147.6 15156.6 15299.7 15376.2 19337.0 20097.8 20193.7 20304.3 20399.9 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | [#3] mootools.html Cycles:180 Average:9635.84 Median:2414.75 stddev:6964.94 (288.4%) stddev-sans-first:6957.18 04:19:03 INFO - PID 27657 | Values: 1427.9 1501.2 1509.6 1515.1 1528.5 15151.9 15788.6 15850.4 15858.8 15891.8 15385.3 16439.0 16476.6 16483.9 16486.7 2458.8 2499.1 2500.6 2501.2 2501.7 2580.4 2636.5 2682.5 2728.9 2729.5 2664.3 2720.8 2722.4 2750.9 2751.9 2318.2 2330.3 2333.1 2339.9 2348.8 2392.9 2436.6 2438.5 2442.4 2546.1 15326.5 15339.3 15476.3 15484.9 15504.4 7991.3 8276.0 8300.6 8302.2 8302.7 5124.3 5199.4 5375.6 5376.5 5408.4 1893.4 1949.2 1965.9 2007.6 2025.2 27164.7 27243.6 27281.3 27320.2 27439.7 6571.6 6628.7 6695.5 6747.6 6785.8 18203.2 18252.0 18275.6 18287.8 18313.5 8150.5 8311.9 8313.5 8317.1 8323.0 7329.9 7439.5 7575.2 7650.7 7656.0 5007.5 5052.6 5114.7 5218.8 5225.5 1538.9 1553.5 1568.8 1570.5 1585.3 898.1 902.9 904.1 915.7 921.4 8810.7 9084.7 9180.4 9201.9 9223.4 1017.7 1022.4 1036.5 1041.0 1043.4 4658.2 4759.0 4762.6 4803.6 5285.1 21483.4 21859.9 21919.9 22070.7 22293.2 22139.4 22140.9 22184.0 22426.4 22465.2 11895.0 12249.9 12320.5 12361.1 12506.1 8277.5 8342.5 8403.5 8428.7 8549.8 18714.5 18908.7 19248.0 19262.1 19476.1 19773.3 19853.9 20122.2 20164.6 20241.2 11721.4 11971.0 11977.3 11981.8 11982.6 14317.6 14497.4 14639.8 14656.3 14665.3 11638.8 11928.6 12010.2 12098.8 12110.2 11569.9 11699.5 11706.1 11996.4 12042.5 9214.0 9341.6 9373.0 9381.8 9382.0 7535.7 7605.7 7615.0 7693.8 7761.8 7845.3 7911.8 7954.3 7979.5 8093.9 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | [#4] prototype.html Cycles:180 Average:5563.42 Median:6181.67 stddev:1523.16 (24.6%) stddev-sans-first:1479.49 04:19:03 INFO - PID 27657 | Values: 511.9 529.3 538.4 541.3 543.9 6106.8 6132.6 6147.2 6172.1 6191.2 6030.9 6070.7 6080.5 6128.3 6131.5 4859.6 4889.5 4906.2 4912.4 4915.6 4625.0 4767.1 4778.2 4860.5 4911.5 4651.2 4673.9 4696.1 4728.5 4771.1 4669.9 4678.8 4719.1 4730.3 4758.6 4289.4 4503.1 4562.7 4584.3 4586.9 5805.5 5891.5 5924.3 5925.6 6002.8 5832.5 5834.4 5914.1 5943.7 5988.5 6548.9 6573.6 6589.6 6606.4 6640.2 5226.3 5270.0 5275.9 5279.2 5317.6 6378.9 6552.5 6617.8 6728.3 6736.7 5315.0 5330.7 5358.6 5376.5 5412.8 5392.5 5465.3 5487.5 5493.7 5507.2 5910.4 5927.3 5935.4 5935.5 5949.9 6434.8 6496.9 6539.8 6565.8 6590.7 1915.0 1918.8 1920.6 1927.5 1948.0 1360.4 1431.1 1434.3 1442.9 1459.7 6159.7 6205.4 6244.7 6261.3 6308.4 6492.9 6503.7 6527.2 6625.0 6632.5 6205.4 6225.4 6236.2 6239.4 6241.7 3455.9 3457.8 3458.1 3497.7 3509.0 6880.9 6935.2 6948.6 6955.8 6995.3 6691.0 6740.5 6750.8 6812.9 6817.9 6816.1 6830.5 6850.6 6869.8 6929.8 6462.1 6520.7 6527.4 6564.9 6592.0 6430.7 6469.6 6495.1 6570.8 6619.6 6919.5 6967.4 6977.4 6988.0 6996.9 5397.6 5410.8 5432.8 5447.6 5451.6 6406.2 6579.4 6580.6 6594.8 6596.6 6289.5 6403.3 6418.6 6448.9 6466.7 6376.0 6386.5 6415.9 6421.2 6422.1 6431.4 6439.8 6465.6 6466.1 6480.4 6357.7 6384.4 6385.2 6450.9 6460.9 6163.9 6214.9 6274.9 6294.7 6307.2 04:19:03 INFO - PID 27657 | 04:19:03 INFO - PID 27657 | [#5] yui.html Cycles:180 Average:27115.58 Median:21209.08 stddev:37536.86 (177.0%) stddev-sans-first:37590.72 04:19:03 INFO - PID 27657 | Values: 943.4 955.5 972.4 975.4 975.8 18388.5 18670.3 18770.2 18905.3 21004.6 21482.0 21856.9 21924.3 22038.4 22077.8 1034.9 1048.2 1056.0 1061.8 1064.1 1075.7 1087.0 1087.6 1093.0 1094.0 1130.4 1142.1 1155.6 1156.4 1157.3 1117.2 1133.7 1141.8 1142.5 1144.0 838.5 843.3 844.3 844.6 845.9 20106.2 20417.7 20449.8 20839.7 21074.2 22040.7 22597.3 22716.1 22855.3 23050.4 16904.6 17286.2 17502.4 17557.7 17584.0 3753.2 3755.2 3772.3 3781.1 3787.2 147057.0 148894.3 149086.3 150682.0 150686.2 17045.7 17337.3 17415.7 17477.5 17873.7 32529.9 32957.5 33077.7 33094.8 33189.2 8216.7 8570.4 8905.3 9004.4 9285.2 4494.6 4555.0 4579.1 4582.0 4584.8 5604.8 5613.5 5630.8 5727.6 5733.4 1164.6 1168.5 1187.7 1190.5 1201.7 671.2 682.2 692.2 697.4 732.2 13203.2 13404.4 13469.4 13542.5 13610.0 662.6 682.7 712.6 719.1 732.3 6680.1 6829.4 6928.4 7054.2 7060.3 120508.0 125342.0 128457.4 128606.0 131813.0 109702.5 111464.4 111870.4 112807.4 114730.0 95046.0 96221.0 96865.0 99013.5 100594.0 13769.1 13983.9 14030.6 14147.6 14217.7 45946.5 46964.8 47579.8 50685.5 51420.5 82071.0 83641.0 84971.6 85223.0 86998.0 20443.8 21097.5 21245.9 21582.8 21672.0 22548.5 23287.0 23691.0 23993.6 24401.9 21099.3 21259.7 21509.2 21839.5 22064.2 20602.6 21125.0 21814.3 21820.5 21913.1 20341.1 20702.0 21058.8 21078.9 21172.3 14017.2 14455.3 14657.7 14757.7 14970.9 15403.2 15514.6 15949.2 16148.5 16590.0 04:19:03 INFO - PID 27657 | -------- Summary: end -------- 04:19:03 INFO - PID 27657 | 04:19:04 INFO - TEST-INFO | 27657: exit 0 04:19:04 INFO - TEST-OK | dromaeo_css | took 1110416ms 04:19:04 INFO - TEST-START | kraken 04:19:04 INFO - Initialising browser for kraken test... 04:19:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35040/getInfo.html -profile /tmp/tmp3uoJRm/profile 04:19:04 INFO - TEST-INFO | started process 28018 (/builds/slave/test/build/application/firefox/firefox http://localhost:35040/getInfo.html) 04:19:10 INFO - TEST-INFO | 28018: exit 0 04:19:10 INFO - Browser initialized. 04:19:10 INFO - Running cycle 1/1 for kraken test... 04:19:10 INFO - TEST-INFO | started process 28233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3uoJRm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:11 INFO - PID 28233 | 04:19:11 INFO - PID 28233 | (/builds/slave/test/build/application/firefox/firefox:28281): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:19:11 INFO - PID 28233 | 04:19:21 INFO - PID 28233 | RSS: Main: 161206272 04:19:21 INFO - PID 28233 | 04:19:24 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35040/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:25 INFO - PID 28233 | RSS: Main: 165724160 04:19:25 INFO - PID 28233 | 04:19:27 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35040/tests/kraken/driver.html?testName=audio-dft) 04:19:28 INFO - PID 28233 | RSS: Main: 166612992 04:19:28 INFO - PID 28233 | 04:19:31 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35040/tests/kraken/driver.html?testName=audio-fft) 04:19:31 INFO - PID 28233 | RSS: Main: 160837632 04:19:31 INFO - PID 28233 | 04:19:33 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35040/tests/kraken/driver.html?testName=audio-oscillator) 04:19:34 INFO - PID 28233 | RSS: Main: 161714176 04:19:34 INFO - PID 28233 | 04:19:36 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35040/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:37 INFO - PID 28233 | RSS: Main: 161869824 04:19:37 INFO - PID 28233 | 04:19:40 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35040/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:40 INFO - PID 28233 | RSS: Main: 165154816 04:19:40 INFO - PID 28233 | 04:19:44 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35040/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:44 INFO - PID 28233 | RSS: Main: 166916096 04:19:44 INFO - PID 28233 | 04:19:47 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35040/tests/kraken/driver.html?testName=json-parse-financial) 04:19:48 INFO - PID 28233 | RSS: Main: 164831232 04:19:48 INFO - PID 28233 | 04:19:49 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35040/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:50 INFO - PID 28233 | RSS: Main: 165593088 04:19:50 INFO - PID 28233 | 04:19:52 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:52 INFO - PID 28233 | RSS: Main: 165101568 04:19:52 INFO - PID 28233 | 04:19:54 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:55 INFO - PID 28233 | RSS: Main: 164962304 04:19:55 INFO - PID 28233 | 04:19:58 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:58 INFO - PID 28233 | RSS: Main: 164597760 04:19:58 INFO - PID 28233 | 04:20:01 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:02 INFO - PID 28233 | RSS: Main: 164999168 04:20:02 INFO - PID 28233 | 04:20:03 INFO - PID 28233 | Cycle 1(1): loaded http://localhost:35040/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35040/tests/kraken/driver.html?testName=ai-astar) 04:20:04 INFO - PID 28233 | RSS: Main: 166842368 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | __start_tp_report 04:20:04 INFO - PID 28233 | _x_x_mozilla_page_load 04:20:04 INFO - PID 28233 | _x_x_mozilla_page_load_details 04:20:04 INFO - PID 28233 | |i|pagename|runs| 04:20:04 INFO - PID 28233 | |0;ai-astar;97;115;100;109;106;107;108;99;107;109 04:20:04 INFO - PID 28233 | |1;audio-beat-detection;142;114;147;170;116;141;138;115;168;117 04:20:04 INFO - PID 28233 | |2;audio-dft;164;165;163;162;164;162;162;162;172;173 04:20:04 INFO - PID 28233 | |3;audio-fft;76;77;75;111;76;75;73;90;95;75 04:20:04 INFO - PID 28233 | |4;audio-oscillator;78;79;122;77;78;87;122;78;78;132 04:20:04 INFO - PID 28233 | |5;imaging-gaussian-blur;114;114;119;113;116;114;113;114;117;114 04:20:04 INFO - PID 28233 | |6;imaging-darkroom;148;148;148;148;147;149;148;147;150;151 04:20:04 INFO - PID 28233 | |7;imaging-desaturate;94;95;94;93;100;98;94;99;98;98 04:20:04 INFO - PID 28233 | |8;json-parse-financial;50;46;48;48;47;46;49;47;46;51 04:20:04 INFO - PID 28233 | |9;json-stringify-tinderbox;55;55;55;54;53;54;53;59;54;55 04:20:04 INFO - PID 28233 | |10;stanford-crypto-aes;75;82;73;74;75;73;74;82;73;73 04:20:04 INFO - PID 28233 | |11;stanford-crypto-ccm;132;120;117;119;126;126;114;123;124;162 04:20:04 INFO - PID 28233 | |12;stanford-crypto-pbkdf2;158;168;160;162;161;164;160;162;165;159 04:20:04 INFO - PID 28233 | |13;stanford-crypto-sha256-iterative;63;60;60;60;60;61;61;62;63;62 04:20:04 INFO - PID 28233 | __end_tp_report 04:20:04 INFO - PID 28233 | __start_cc_report 04:20:04 INFO - PID 28233 | _x_x_mozilla_cycle_collect,838 04:20:04 INFO - PID 28233 | __end_cc_report 04:20:04 INFO - PID 28233 | __startTimestamp1502277604209__endTimestamp 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | ------- Summary: start ------- 04:20:04 INFO - PID 28233 | Number of tests: 14 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#0] ai-astar Cycles:10 Average:105.70 Median:109.00 stddev:5.48 (5.0%) stddev-sans-first:4.82 04:20:04 INFO - PID 28233 | Values: 97.0 115.0 100.0 109.0 106.0 107.0 108.0 99.0 107.0 109.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:141.50 stddev:21.20 (15.0%) stddev-sans-first:22.40 04:20:04 INFO - PID 28233 | Values: 142.0 114.0 147.0 170.0 116.0 141.0 138.0 115.0 168.0 117.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:4.15 (2.5%) stddev-sans-first:4.39 04:20:04 INFO - PID 28233 | Values: 164.0 165.0 163.0 162.0 164.0 162.0 162.0 162.0 172.0 173.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:12.46 (16.4%) stddev-sans-first:13.01 04:20:04 INFO - PID 28233 | Values: 76.0 77.0 75.0 111.0 76.0 75.0 73.0 90.0 95.0 75.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:78.00 stddev:22.59 (29.0%) stddev-sans-first:23.29 04:20:04 INFO - PID 28233 | Values: 78.0 79.0 122.0 77.0 78.0 87.0 122.0 78.0 78.0 132.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.00 stddev:1.93 (1.7%) stddev-sans-first:2.03 04:20:04 INFO - PID 28233 | Values: 114.0 114.0 119.0 113.0 116.0 114.0 113.0 114.0 117.0 114.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.33 04:20:04 INFO - PID 28233 | Values: 148.0 148.0 148.0 148.0 147.0 149.0 148.0 147.0 150.0 151.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:2.54 (2.6%) stddev-sans-first:2.55 04:20:04 INFO - PID 28233 | Values: 94.0 95.0 94.0 93.0 100.0 98.0 94.0 99.0 98.0 98.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#8] json-parse-financial Cycles:10 Average:47.80 Median:48.00 stddev:1.75 (3.6%) stddev-sans-first:1.67 04:20:04 INFO - PID 28233 | Values: 50.0 46.0 48.0 48.0 47.0 46.0 49.0 47.0 46.0 51.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:1.70 (3.1%) stddev-sans-first:1.80 04:20:04 INFO - PID 28233 | Values: 55.0 55.0 55.0 54.0 53.0 54.0 53.0 59.0 54.0 55.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:74.50 stddev:3.57 (4.8%) stddev-sans-first:3.78 04:20:04 INFO - PID 28233 | Values: 75.0 82.0 73.0 74.0 75.0 73.0 74.0 82.0 73.0 73.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:125.00 stddev:13.56 (10.8%) stddev-sans-first:14.22 04:20:04 INFO - PID 28233 | Values: 132.0 120.0 117.0 119.0 126.0 126.0 114.0 123.0 124.0 162.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:3.03 (1.9%) stddev-sans-first:2.87 04:20:04 INFO - PID 28233 | Values: 158.0 168.0 160.0 162.0 161.0 164.0 160.0 162.0 165.0 159.0 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.50 stddev:1.23 (2.0%) stddev-sans-first:1.12 04:20:04 INFO - PID 28233 | Values: 63.0 60.0 60.0 60.0 60.0 61.0 61.0 62.0 63.0 62.0 04:20:04 INFO - PID 28233 | -------- Summary: end -------- 04:20:04 INFO - PID 28233 | 04:20:04 INFO - PID 28233 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:20:04 INFO - TEST-INFO | 28233: exit 0 04:20:04 INFO - TEST-OK | kraken | took 60167ms 04:20:04 INFO - SUITE-END | took 1170s 04:20:04 INFO - Completed test suite (00:19:30) 04:20:04 INFO - javascript benchmark 04:20:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8994.571818670873, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3515.7714748541357, 3515.9824200878998, 3536.646335366462, 3546.0, 3556.8043757593337, 6214.53390995676, 6294.276158241803, 6312.77905273315, 6347.016212487072, 6360.681965901704, 6207.348228436017, 6288.8742225155465, 6299.842503937404, 6309.49524038077, 6314.747410103601, 5487.75305111271, 5512.062949298609, 5518.558515318785, 5530.115181570949, 5546.251256080438, 5549.084401073818, 5554.944450555503, 5611.523020543259, 5644.238027866247, 5670.234518340033, 5517.503424691777, 5551.916721249185, 5571.693556854371, 5574.0, 5590.524805391547, 5415.296011518478, 5482.314710661168, 5482.753276102585, 5499.615026948115, 5544.667319960775, 5378.731063446812, 5442.428545002796, 5449.237106805051, 5474.945250547484, 5491.0, 6082.178905847698, 6210.937890621126, 6220.191375121205, 6283.120363149163, 6302.054691796221, 6674.69963851623, 6706.362895524917, 6739.2249891262645, 6739.831504212385, 6881.41507971823, 6793.184817821843, 6856.485763567753, 6916.688749006256, 6957.199922008983, 6978.267281935375, 6310.148130002391, 6316.115743795872, 6377.457916077139, 6391.584547004476, 6395.712192951329, 6981.685824137926, 7019.087518622547, 7090.539114957512, 7092.716291348288, 7097.254788247263, 6584.934150658528, 6633.800985970429, 6646.900296495556, 6686.264510903797, 6690.59856408617, 6747.932520674829, 6909.7581584644295, 6927.376536111673, 6927.480438967098, 6949.7567585134275, 6744.393004629607, 6768.2216545097945, 6780.830479238059, 6839.897401538981, 6875.312468753084, 6682.766103186365, 6824.2152152503095, 6826.965865170642, 6886.586804791728, 6899.827504312432, 4927.876803079952, 4945.307656928033, 4979.6265280104135, 4991.425986011583, 4999.900002000012, 4427.247367947457, 4428.3800267962515, 4440.888977775581, 4445.377647129404, 4468.128714900628, 6339.492840572743, 6383.6808159592765, 6475.4819614430735, 6481.254655714559, 6565.376289252514, 6861.142357205349, 6924.930750692429, 6926.896096558556, 6930.792076237721, 6937.167539895245, 6490.740370385226, 6496.512761542903, 6505.512086593524, 6577.046328282372, 6584.703688334036, 5447.264619276347, 5521.0, 5534.75093620788, 5583.3858275589655, 5583.748731307101, 7261.491695581259, 7280.381167600707, 7304.977303177666, 7310.122785265802, 7316.890246646304, 6721.327867213239, 6801.761938332333, 6867.313268673092, 6870.587764734132, 6885.51801373899, 7020.227774944854, 7198.964005179941, 7202.315780000891, 7261.927380726336, 7294.0, 6659.5671281368495, 6706.0611514389, 6786.558873673195, 6801.18385793708, 6801.2178599461695, 6842.897356539556, 6865.759698410531, 6903.792886213421, 6913.343232392915, 6927.7228910845015, 6607.603543787388, 6628.5691430056895, 6641.269460359454, 6686.431653309523, 6700.396964273239, 6490.350964903472, 6560.671966401756, 6563.146790917151, 6608.867822643617, 6675.4325882300545, 6573.5398522103, 6587.077809106633, 6613.107230523818, 6689.732410703517, 6700.4639628830555, 6659.633720145439, 6662.766803161866, 6696.330366963265, 6737.494687898526, 6778.0, 6467.126937863328, 6485.481161507162, 6543.869122617616, 6548.148740663683, 6572.34276572339], "value": 6211.734227816754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.249014740186, 805.198827166969, 827.8634025385811, 829.746927187208, 1206.1556910162888, 34471.0, 35081.0, 44369.77815110924, 44959.77520112395, 45022.0, 44971.55028449715, 45073.7746311268, 45373.77313113438, 45500.31749523751, 45619.0, 7166.498345115844, 7617.504862183954, 7689.538627682357, 7727.265909738566, 7740.187280335568, 7556.47104702671, 7620.580868052255, 7643.044619422572, 7679.0, 7684.692612295501, 7578.317951384374, 7604.581748003858, 7666.0, 7688.500247483896, 7720.806979825493, 7614.543127412346, 7638.770836874903, 7653.119891212526, 7656.617169141548, 7661.118971318314, 7580.090389153282, 7586.58273794941, 7617.428692848059, 7644.541327520366, 7644.579548124851, 40755.38866916999, 40967.59032409667, 41003.0, 41022.179556409006, 41041.0, 3551.786892786441, 3570.62508436613, 3574.7318951078773, 3595.0832537702718, 3595.694365978895, 31772.36455270905, 31867.0, 31904.361912761615, 31975.040748777574, 32142.0, 4980.078685443204, 5018.096742586333, 5038.345015148044, 5051.6716413433005, 5064.392272927273, 215367.0, 216218.0, 216255.0, 216257.0, 218232.9088354564, 51467.74266128645, 51470.0, 51600.22599661008, 51726.741366292925, 51787.48212517826, 53848.73075634675, 53934.730326348115, 54015.919681606145, 54116.0, 54278.18582721263, 14222.857771422154, 16951.0, 17324.913375433043, 17329.393471228446, 17366.39217627402, 11511.827322590168, 13870.930645346709, 14096.224707640973, 14105.083169593943, 14105.929470352583, 14250.857491424953, 14274.857251427353, 14351.990721299026, 14451.638709032148, 14489.609214479493, 5625.662460252398, 5698.145278208219, 5702.344230413472, 5807.738651760681, 5823.767049318065, 1067.9092277156528, 1081.2647399768234, 1100.9394483303495, 1105.8838821923582, 1108.7228192951761, 24607.753922460903, 24725.629115563283, 24726.629100563507, 24836.627450588254, 24896.626550601755, 1202.8496437945257, 1210.0863847794858, 1217.7199244173712, 1225.454672670653, 1226.6565361698738, 13256.138351007154, 13312.400941957636, 13315.46738130464, 13382.46470141203, 17504.299828006737, 273877.0, 273932.0, 274613.0, 275152.0, 275264.0, 61208.08187877185, 61292.69353653293, 61669.691651541456, 61721.69139154276, 62916.370836291964, 1479.3564799312333, 1523.6800271943016, 1534.8388419216044, 1545.9690806184037, 1546.5824227458522, 30321.0, 30564.388712226075, 30670.539941900442, 31018.744581411163, 31148.53277200889, 55881.16178257248, 56267.718661406434, 56295.43704562902, 56408.435915640315, 56434.306970790945, 237990.0, 240017.0, 241384.0, 241829.0, 241956.0, 37401.6259837409, 38745.0, 39618.2076358477, 39773.60226397699, 39776.80111599423, 47030.0, 47877.0, 47971.0, 48688.0, 48961.0, 35772.0, 35831.10422239465, 36153.819230903675, 36264.63735362612, 36649.45025824561, 35913.0, 36038.8198059008, 36239.275214495035, 36417.27165456729, 36440.81779591085, 41925.58074419339, 41941.37087943744, 42178.15643687048, 42361.0, 42504.14991700087, 45182.32226516671, 45885.31172032355, 46130.538694612624, 46168.0, 46349.0, 29923.70076299209, 32991.340173195924, 33023.50464743079, 33180.66819331776, 33314.0], "value": 18881.456691594234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.728046897255, 569.4675478427667, 573.6156774960778, 575.6891278709497, 594.088074805174, 22697.886510567445, 23596.174133905315, 23647.17234896779, 23675.76324236757, 24697.87651061742, 26561.86719066402, 27342.863285683594, 27414.177574672744, 27439.17682469524, 27480.45039099217, 6104.511639068886, 6279.30927597965, 6418.679066046702, 6422.197225346832, 6423.132877061607, 6250.249970003583, 6328.493720502349, 6329.335419780926, 6330.27201871786, 6357.554971152022, 6299.622022678654, 6319.115323854664, 6322.936770632304, 6353.364663533633, 6358.968205158968, 6309.652969086698, 6320.336364681688, 6328.90506642403, 6332.841678958017, 6358.745650173987, 5851.912221316684, 5881.3530511643685, 5888.146218798293, 5898.852528686774, 5934.228550288478, 29794.702052979625, 30800.075997720105, 32258.0, 32389.51415728766, 32414.0, 2209.5249521352825, 2230.9330720078424, 2231.3306008197474, 2234.7094877665963, 2243.4391402149463, 19592.510187245432, 20222.19111235549, 20240.089195986217, 20266.493337666678, 20282.188712451632, 2359.5634807560655, 2417.528581926525, 2450.9877450612635, 2481.1812102006475, 2493.713222979344, 154346.0, 162123.18938405233, 162153.0, 162348.0, 162545.0, 15172.848271517365, 15564.533064008097, 15736.370545178064, 15884.682306353809, 16449.25978330978, 24182.879085604458, 24316.635250471256, 24344.147954821496, 24415.267541973768, 24428.0, 10011.749706257402, 10115.949420252851, 10141.594336226615, 10154.543045562967, 10225.48872556384, 9022.774430639156, 9206.447613143233, 9576.090271424204, 10010.399376037461, 10310.484475776331, 9554.713358599252, 9852.901470985342, 10114.898851011396, 10132.189424845994, 10176.949115254376, 2874.3676391193903, 2874.4107457971068, 2900.5794159846705, 2902.6081479000486, 2979.687132851019, 1034.2605037398296, 1046.602291129366, 1049.7060822969581, 1050.7163065972145, 1054.9419781911915, 20976.89511552463, 21462.570748585254, 21557.46106347354, 21895.781042189374, 21948.561028779335, 1098.555085190499, 1119.7928383249125, 1122.1247427006786, 1130.5873356224918, 1131.7170707323169, 11514.30914145154, 11965.880341196476, 12211.877881221251, 12222.694432639255, 12226.0, 582295.0, 599461.0, 610794.0, 618912.0, 623883.0, 129630.0, 130550.34724826315, 131379.0, 132873.0, 137160.0, 1240.8448943882195, 1255.265669583304, 1276.5787290194214, 1277.2081309588116, 1288.8646692097382, 19203.90398048057, 19416.902915485898, 19419.70870436973, 19437.31969381065, 19927.0, 64301.67849160724, 65941.34058659352, 66248.0, 66466.33533664602, 67849.3215067843, 85603.0, 85963.0, 86241.0, 87246.0, 87670.0, 14642.0, 15042.097474151149, 15049.54851354461, 15061.623459413164, 15073.547793566211, 23757.524849503257, 24025.75974240305, 24038.759612404352, 24194.153204637754, 24689.25932222036, 20819.167233310498, 20847.687284690437, 20897.58204835925, 21009.054592543067, 21305.467363316042, 18673.15970781345, 18842.717359239898, 18863.43409697711, 18954.0, 19196.13617387193, 21206.25778097759, 21522.784772152077, 21731.130754770264, 21900.0, 21978.89010554937, 15113.773293400387, 15147.621309467351, 15156.621084472976, 15299.694006120038, 15376.154311512526, 19337.0, 20097.799022009593, 20193.6970945433, 20304.289349872684, 20399.898000509904], "value": 12784.715652836101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.885769138469, 1501.2343704710595, 1509.592410049286, 1515.0833745583918, 1528.4726769264607, 15151.92424037881, 15788.605284867856, 15850.445234416784, 15858.841411585881, 15891.761623575656, 15385.307661155246, 16439.0, 16476.588085297873, 16483.917580412082, 16486.67026659469, 2458.778709916103, 2499.0503608628787, 2500.5624015797252, 2501.187114187887, 2501.7498250174926, 2580.406506503505, 2636.4990651776197, 2682.543967525525, 2728.9317767055786, 2729.508688436081, 2664.2806442260576, 2720.8095433319677, 2722.414680843618, 2750.8899644014214, 2751.8899244030213, 2318.1654604342425, 2330.33585428153, 2333.0900948630047, 2339.9181028663916, 2348.7768661977084, 2392.880355982194, 2436.610142377211, 2438.451348446603, 2442.413820683041, 2546.1088618983395, 15326.463573774976, 15339.309731062018, 15476.303566339542, 15484.92257538705, 15504.379824806994, 7991.2807847294025, 8276.048254450756, 8300.626471808782, 8302.169783021709, 8302.66789328426, 5124.256982737519, 5199.402068762103, 5375.623706340558, 5376.542993845528, 5408.35099788024, 1893.3562588719763, 1949.191085699433, 1965.9187446904145, 2007.5784085342095, 2025.2101680344676, 27164.728352716615, 27243.591346129822, 27281.31796705098, 27320.180394587995, 27439.725602743918, 6571.605703657796, 6628.668566571652, 6695.497837662195, 6747.628880411527, 6785.796426107126, 18203.180856861472, 18252.0, 18275.63448731018, 18287.817121828877, 18313.542161445803, 8150.51096934174, 8311.916880831115, 8313.542755148404, 8317.085120636724, 8322.958385208156, 7329.9267007329245, 7439.479236453396, 7575.166731659513, 7650.73222437212, 7656.0, 5007.549320561094, 5052.646314758005, 5114.6931184128325, 5218.843434696965, 5225.50357716024, 1538.853808888154, 1553.495114087926, 1568.7646852972146, 1570.5052908334067, 1585.3262363495699, 898.1377877237794, 902.8916530016309, 904.1184844776291, 915.7390143808982, 921.4379228670506, 8810.735677929672, 9084.682036128705, 9180.44917304964, 9201.90798092024, 9223.44659320443, 1017.6692574913183, 1022.4274406332478, 1036.5231993283023, 1040.9739756506149, 1043.3531210649446, 4658.208104622222, 4758.976205118952, 4762.571368576845, 4803.639727020487, 5285.127953887642, 21483.355499335044, 21859.890700546715, 21919.890400547894, 22070.66893996591, 22293.219737309115, 22139.44651383696, 22140.889295553417, 22184.0, 22426.439339016655, 22465.213717519808, 11895.0, 12249.877501225052, 12320.507179712891, 12361.07291953107, 12506.062045346453, 8277.490745492301, 8342.457740246864, 8403.453775504573, 8428.747137585882, 8549.786255343666, 18714.532136696693, 18908.716369254747, 19248.0, 19262.13320400557, 19476.14976577223, 19773.307934222234, 19853.900730496254, 20122.195112195936, 20164.59670806605, 20241.19035238574, 11721.413929303671, 11971.042316614825, 11977.281363118242, 11981.820272696092, 11982.580609678967, 14317.64205894861, 14497.420103195755, 14639.780403294171, 14656.340464678902, 14665.340059697553, 11638.76722465529, 11928.582499612472, 12010.219335743499, 12098.818517722417, 12110.212836165621, 11569.942150289195, 11699.473523691624, 11706.1220408468, 11996.40017999114, 12042.518299267931, 9213.953930230306, 9341.626334946526, 9373.0, 9381.765455863659, 9382.0, 7535.73624923125, 7605.695772169051, 7614.971978783015, 7693.846123077619, 7761.844763104819, 7845.254700803414, 7911.84176316459, 7954.323882469824, 7979.521228726295, 8093.919060809317], "value": 6807.843163736762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.9453924914674, 529.2590373477132, 538.3981165999465, 541.3044238153973, 543.8667526456018, 6106.816795496131, 6132.570720049593, 6147.2008638877, 6172.148355493357, 6191.195144631203, 6030.87938241236, 6070.726817293222, 6080.543959203055, 6128.264608247016, 6131.509479241661, 4859.635527335455, 4889.486603906592, 4906.184711656692, 4912.36139301892, 4915.606751459874, 4624.97687511562, 4767.118083154627, 4778.2115950868065, 4860.513948605147, 4911.533404326601, 4651.209294419957, 4673.943464875444, 4696.131215725085, 4728.4798672146035, 4771.117343291502, 4669.929951050737, 4678.836240731575, 4719.088769048541, 4730.290456431546, 4758.61931045519, 4289.442372491588, 4503.144402563503, 4562.657800664931, 4584.312353147055, 4586.862394128181, 5805.477507024346, 5891.469767720926, 5924.348321684612, 5925.614835035752, 6002.819915402545, 5832.492028427774, 5834.3873893241025, 5914.112883067532, 5943.673097979609, 5988.461038506555, 6548.93451065488, 6573.638449885254, 6589.604623722544, 6606.405423511907, 6640.203175618908, 5226.346706661668, 5269.973650131725, 5275.894482110375, 5279.205070276086, 5317.574594032468, 6378.87242255157, 6552.541322107454, 6617.8014659560295, 6728.293529179415, 6736.696848641823, 5315.0, 5330.680159190461, 5358.571314294847, 5376.462353764592, 5412.756425960842, 5392.514673679388, 5465.316835395575, 5487.478689524489, 5493.697846618475, 5507.201455788968, 5910.408959104141, 5927.347991720907, 5935.358765349464, 5935.495482883917, 5949.851253718605, 6434.8391290218115, 6496.928006878812, 6539.8365040873405, 6565.818152732459, 6590.736370545221, 1914.9521261968562, 1918.7601549806275, 1920.6254780317704, 1927.4603111128906, 1948.0162517928638, 1360.3606305036617, 1431.105559025609, 1434.3043623842427, 1442.8773554247796, 1459.7445447046725, 6159.737253862947, 6205.379462053758, 6244.718987645567, 6261.311255761862, 6308.432241098323, 6492.870142597216, 6503.674816259168, 6527.2167339919515, 6624.966875165594, 6632.535722499379, 6205.379462053849, 6225.408586184305, 6236.220472440945, 6239.376062393724, 6241.656708881055, 3455.9459364893446, 3457.792532448061, 3458.1354661334667, 3497.7376696747847, 3508.9649103508636, 6880.931190688129, 6935.202451718016, 6948.580107516145, 6955.756548520778, 6995.313140196081, 6691.0, 6740.494462915203, 6750.797476075725, 6812.931870681329, 6817.931820681829, 6816.113905192294, 6830.5218634697085, 6850.588964662136, 6869.793906182823, 6929.792106236821, 6462.127612772216, 6520.673966301761, 6527.445167160845, 6564.934350656624, 6592.0, 6430.710618022294, 6469.579477334147, 6495.142137459692, 6570.8028759137305, 6619.569727967667, 6919.481038922, 6967.3626697727, 6977.441804655514, 6988.0, 6996.895046574407, 5397.595180361567, 5410.783568657367, 5432.76244529252, 5447.591430642638, 5451.56387488992, 6406.23125224976, 6579.374959378852, 6580.605163690194, 6594.769183078761, 6596.60420374779, 6289.465395441439, 6403.295637479967, 6418.582792118497, 6448.9032664511005, 6466.708998095191, 6375.979843225062, 6386.489080873426, 6415.935840641534, 6421.229452465547, 6422.133012043314, 6431.356864313531, 6439.8068057958335, 6465.644389558432, 6466.127072845105, 6480.416762491398, 6357.664890373074, 6384.361563843579, 6385.169927909342, 6450.935700575771, 6460.903086453613, 6163.876722465615, 6214.875702486015, 6274.874502510015, 6294.716737746904, 6307.233974487151], "value": 5132.33577481053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.4245110482605, 955.5380268189672, 972.3728195314022, 975.4391225045598, 975.8487434447663, 18388.54028649283, 18670.253189872423, 18770.2491900324, 18905.33831315904, 21004.57990840186, 21482.0, 21856.8907155464, 21924.342269731893, 22038.449038774037, 22077.779222207773, 1034.8809886863014, 1048.1824177141802, 1056.0179033498844, 1061.8141825180562, 1064.074255397805, 1075.6504136155781, 1087.0, 1087.624769454541, 1092.956281748729, 1093.9890601094007, 1130.372643183033, 1142.0692135909248, 1155.6070935881799, 1156.4217891054473, 1157.3056166300237, 1117.2291119127817, 1133.659902029392, 1141.8287256911447, 1142.4573327669332, 1143.999000874235, 838.5010918503481, 843.3211264931728, 844.2612713875359, 844.5566077809137, 845.8858054162671, 20106.19044286007, 20417.693734593846, 20449.795502044937, 20839.687404688942, 21074.157033718788, 22040.669389959163, 22597.322080337617, 22716.091356345725, 22855.31434056981, 23050.42373940648, 16904.577385565335, 17286.22212000463, 17502.387416440364, 17557.736633950502, 17584.032878191694, 3753.230587729509, 3755.2301778135416, 3772.302124107049, 3781.1303400218103, 3787.1857550626746, 147057.0, 148894.25552872274, 149086.25456872754, 150682.0, 150686.24656876756, 17045.659086818443, 17337.306507739802, 17415.651686966445, 17477.475675729747, 17873.7318940216, 32529.861454848968, 32957.50563741546, 33077.66922330794, 33094.83452582722, 33189.17027074342, 8216.671333146727, 8570.4000719949, 8905.287576993825, 9004.41471304363, 9285.210757085588, 4494.617957473586, 4555.043440877386, 4579.107074120515, 4582.037772067836, 4584.7936842842155, 5604.8038318658655, 5613.494785469327, 5630.831075067673, 5727.5990680652785, 5733.369329373765, 1164.6389619218069, 1168.4917061078459, 1187.6912002879142, 1190.5118901250446, 1201.6635342104225, 671.2113266911457, 682.154128880185, 692.2039654397483, 697.4141720954321, 732.1653315220652, 13203.207807531579, 13404.396802143927, 13469.393877275546, 13542.526011589547, 13610.047296689334, 662.5726406467801, 682.7303215229956, 712.5795780489536, 719.0616245799177, 732.2567593892204, 6680.131582894192, 6829.419499342513, 6928.44572434204, 7054.188768291609, 7060.258672839381, 120508.0, 125342.0, 128457.35771321083, 128606.0, 131813.0, 109702.45148774204, 111464.4426777861, 111870.44064779623, 112807.43596281965, 114730.0, 95046.0, 96221.0, 96865.0, 99013.50493247632, 100593.99406005992, 13769.105008174436, 13983.860161398663, 14030.649233769238, 14147.575572732834, 14217.715645687234, 45946.54053459423, 46964.7651761739, 47579.76210118927, 50685.493145068074, 51420.48579514307, 82071.0, 83641.0, 84971.5751421239, 85223.0, 86998.0, 20443.795562044783, 21097.472563186042, 21245.89377053105, 21582.784172158077, 21672.0, 22548.549029019658, 23287.0, 23691.0, 23993.640095398234, 24401.877990609933, 21099.261525847134, 21259.681104783132, 21509.247176348752, 21839.454013649785, 22064.2277520286, 20602.587948240653, 21125.0, 21814.345569632937, 21820.45448863791, 21913.123475061457, 20341.084651191028, 20701.964901755153, 21058.78941210568, 21078.894605526875, 21172.25897093594, 14017.229052402216, 14455.277236138361, 14657.706845863237, 14757.704845902806, 14970.925145374204, 15403.152826594645, 15514.612134696723, 15949.202539873191, 16148.515544533682, 16590.0], "value": 10106.257574730858, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1469.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 115.0, 100.0, 109.0, 106.0, 107.0, 108.0, 99.0, 107.0, 109.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 147.0, 170.0, 116.0, 141.0, 138.0, 115.0, 168.0, 117.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 162.0, 164.0, 162.0, 162.0, 162.0, 172.0, 173.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 111.0, 76.0, 75.0, 73.0, 90.0, 95.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 122.0, 77.0, 78.0, 87.0, 122.0, 78.0, 78.0, 132.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 119.0, 113.0, 116.0, 114.0, 113.0, 114.0, 117.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 147.0, 150.0, 151.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 93.0, 100.0, 98.0, 94.0, 99.0, 98.0, 98.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 46.0, 48.0, 48.0, 47.0, 46.0, 49.0, 47.0, 46.0, 51.0], "value": 47.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 53.0, 54.0, 53.0, 59.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 73.0, 74.0, 75.0, 73.0, 74.0, 82.0, 73.0, 73.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 120.0, 117.0, 119.0, 126.0, 126.0, 114.0, 123.0, 124.0, 162.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 168.0, 160.0, 162.0, 161.0, 164.0, 160.0, 162.0, 165.0, 159.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 62.0, 63.0, 62.0], "value": 61.2, "unit": "score"}]}]} 04:20:04 INFO - Return code: 0 04:20:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:05 INFO - # TBPL SUCCESS # 04:20:05 INFO - Running post-action listener: _package_coverage_data 04:20:05 INFO - Running post-action listener: _resource_record_post_action 04:20:05 INFO - [mozharness: 2017-08-09 11:20:05.020616Z] Finished run-tests step (success) 04:20:05 INFO - Running post-run listener: _resource_record_post_run 04:20:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 429600768; Read time: 20; Write time: 288360 04:20:05 INFO - TinderboxPrint: CPU usage
13.1% 04:20:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:20:05 INFO - TinderboxPrint: I/O write bytes / time
429,600,768 / 288,360 04:20:05 INFO - TinderboxPrint: CPU idle
8,240.8 (86.9%) 04:20:05 INFO - TinderboxPrint: CPU user
1,191.2 (12.6%) 04:20:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108040192; Read time: 0; Write time: 83376 04:20:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:20:05 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321024000; Read time: 20; Write time: 204980 04:20:05 INFO - Running post-run listener: _upload_blobber_files 04:20:05 INFO - Blob upload gear active. 04:20:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:05 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 04:20:05 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'] 04:20:05 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 04:20:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:19 INFO - (blobuploader) - INFO - Done attempting. 04:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:30 INFO - (blobuploader) - INFO - Done attempting. 04:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:40 INFO - (blobuploader) - INFO - Done attempting. 04:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:43 INFO - (blobuploader) - INFO - Done attempting. 04:20:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:43 INFO - Return code: 0 04:20:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73f472b6942654277c86086deb042a6c9360ae6ca2fd473073a52700ccf7ed5d1b358ee63bf128d47d8b98255bb17278db0f2939d22979f7d643b72403cbcfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d29ccc05faa6a00b92b5cbd99a06a5990b77474654bd80b0f24cc91dcb92d87bc8551e8ec4bcc3fc275111423c42b4d80b25fa09303a2cf221a7e666da33a60", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d2bbae4faac5539fb19a9475b6c69a18658787edc71f26879f772fc02ef797b9b5c2088c971d6a56fefee70ec1e758d2f73098ebbb009912deae573f248e5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6038a3c92aff1e6f48c6f64d0cb4e5adcec9f52e71acc4e065ce1501f297fe82a65b38773a6f29d3e465a741f89882af145aa58a982657b65b44be12f6e4f50d"} 04:20:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:43 INFO - Contents: 04:20:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73f472b6942654277c86086deb042a6c9360ae6ca2fd473073a52700ccf7ed5d1b358ee63bf128d47d8b98255bb17278db0f2939d22979f7d643b72403cbcfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d29ccc05faa6a00b92b5cbd99a06a5990b77474654bd80b0f24cc91dcb92d87bc8551e8ec4bcc3fc275111423c42b4d80b25fa09303a2cf221a7e666da33a60", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d2bbae4faac5539fb19a9475b6c69a18658787edc71f26879f772fc02ef797b9b5c2088c971d6a56fefee70ec1e758d2f73098ebbb009912deae573f248e5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6038a3c92aff1e6f48c6f64d0cb4e5adcec9f52e71acc4e065ce1501f297fe82a65b38773a6f29d3e465a741f89882af145aa58a982657b65b44be12f6e4f50d"} 04:20:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:43 INFO - Copying logs to upload dir... 04:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.895705 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-08-09 04:20:43.391016) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 04:20:43.394473) ========= 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=930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024 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/b73f472b6942654277c86086deb042a6c9360ae6ca2fd473073a52700ccf7ed5d1b358ee63bf128d47d8b98255bb17278db0f2939d22979f7d643b72403cbcfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d29ccc05faa6a00b92b5cbd99a06a5990b77474654bd80b0f24cc91dcb92d87bc8551e8ec4bcc3fc275111423c42b4d80b25fa09303a2cf221a7e666da33a60", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d2bbae4faac5539fb19a9475b6c69a18658787edc71f26879f772fc02ef797b9b5c2088c971d6a56fefee70ec1e758d2f73098ebbb009912deae573f248e5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6038a3c92aff1e6f48c6f64d0cb4e5adcec9f52e71acc4e065ce1501f297fe82a65b38773a6f29d3e465a741f89882af145aa58a982657b65b44be12f6e4f50d"} build_url:https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/b6_t7mZnTm6xRxmqjuSdEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b73f472b6942654277c86086deb042a6c9360ae6ca2fd473073a52700ccf7ed5d1b358ee63bf128d47d8b98255bb17278db0f2939d22979f7d643b72403cbcfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d29ccc05faa6a00b92b5cbd99a06a5990b77474654bd80b0f24cc91dcb92d87bc8551e8ec4bcc3fc275111423c42b4d80b25fa09303a2cf221a7e666da33a60", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69d2bbae4faac5539fb19a9475b6c69a18658787edc71f26879f772fc02ef797b9b5c2088c971d6a56fefee70ec1e758d2f73098ebbb009912deae573f248e5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6038a3c92aff1e6f48c6f64d0cb4e5adcec9f52e71acc4e065ce1501f297fe82a65b38773a6f29d3e465a741f89882af145aa58a982657b65b44be12f6e4f50d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 04:20:43.420349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 04:20:43.420694) ========= 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=930c87414c89fc706ee2024c000001c6-1502275859.782076-1568474024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 04:20:43.503190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 04:20:43.503500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 04:20:43.503816) ========= ========= Total master_lag: 0.17 =========