builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1502274790.62 results: success (0) revision: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.615831) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.616220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.616489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.674837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.675153) ========= 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=d2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 03:33:10-- 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% 45.5M=0s 2017-08-09 03:33:11 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.866217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.866493) ========= 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=d2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015887 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:10.921564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-09 03:33:10.921859) ========= 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=d2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 03:33:11,143 truncating revision to first 12 chars 2017-08-09 03:33:11,143 Setting DEBUG logging. 2017-08-09 03:33:11,143 attempt 1/10 2017-08-09 03:33:11,143 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:33:11,859 unpacking tar archive at: mozilla-central-4c5fbf493763/testing/mozharness/ program finished with exit code 0 elapsedTime=1.095919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-09 03:33:12.031266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:12.031590) ========= script_repo_revision: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:12.031957) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:12.032245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:12.041158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-09 03:33:12.041440) ========= /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=d2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:12 INFO - MultiFileLogger online at 20170809 03:33:12 in /builds/slave/test 03:33:12 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:33:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:12 INFO - {'append_to_log': False, 03:33:12 INFO - 'base_work_dir': '/builds/slave/test', 03:33:12 INFO - 'blob_upload_branch': 'Firefox', 03:33:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:12 INFO - 'branch': 'Firefox', 03:33:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:12 INFO - 'code_coverage': False, 03:33:12 INFO - 'config_files': ('talos/linux_config.py',), 03:33:12 INFO - 'default_actions': ('clobber', 03:33:12 INFO - 'read-buildbot-config', 03:33:12 INFO - 'download-and-extract', 03:33:12 INFO - 'populate-webroot', 03:33:12 INFO - 'create-virtualenv', 03:33:12 INFO - 'install', 03:33:12 INFO - 'setup-mitmproxy', 03:33:12 INFO - 'run-tests'), 03:33:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:12 INFO - 'disable_ccov_upload': False, 03:33:12 INFO - 'download_minidump_stackwalk': True, 03:33:12 INFO - 'download_symbols': 'ondemand', 03:33:12 INFO - 'enable_stylo': False, 03:33:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:12 INFO - 'gecko_profile': False, 03:33:12 INFO - 'gecko_profile_interval': 0, 03:33:12 INFO - 'installer_path': 'installer.exe', 03:33:12 INFO - 'log_level': 'info', 03:33:12 INFO - 'log_name': 'talos', 03:33:12 INFO - 'log_to_console': True, 03:33:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:12 INFO - 'opt_config_files': (), 03:33:12 INFO - 'pip_index': False, 03:33:12 INFO - 'suite': 'dromaeojs-e10s', 03:33:12 INFO - 'system_bits': '32', 03:33:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:12 INFO - 'title': 'talos-linux64-ix-043', 03:33:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:12 INFO - 'use_talos_json': True, 03:33:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:12 INFO - 'work_dir': 'build'} 03:33:12 INFO - [mozharness: 2017-08-09 10:33:12.362710Z] Running clobber step. 03:33:12 INFO - Running pre-action listener: _resource_record_pre_action 03:33:12 INFO - Running main action method: clobber 03:33:12 INFO - rmtree: /builds/slave/test/build 03:33:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:13 INFO - Running post-action listener: _resource_record_post_action 03:33:13 INFO - [mozharness: 2017-08-09 10:33:13.907981Z] Finished clobber step (success) 03:33:13 INFO - [mozharness: 2017-08-09 10:33:13.908083Z] Running read-buildbot-config step. 03:33:13 INFO - Running pre-action listener: _resource_record_pre_action 03:33:13 INFO - Running main action method: read_buildbot_config 03:33:13 INFO - Using buildbot properties: 03:33:13 INFO - { 03:33:13 INFO - "project": "", 03:33:13 INFO - "product": "firefox", 03:33:13 INFO - "who": "cbook@mozilla.com", 03:33:13 INFO - "installer_path": "public/build/target.tar.bz2", 03:33:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:33:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:33:13 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:33:13 INFO - "stage_platform": "linux64-stylosequential", 03:33:13 INFO - "basedir": "/builds/slave/test", 03:33:13 INFO - "buildnumber": 175, 03:33:13 INFO - "platform": "ubuntu64_hw_styloseq", 03:33:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:33:13 INFO - "slavebuilddir": "test", 03:33:13 INFO - "taskId": "RVoV1MRcRb6LJU5net3Enw", 03:33:13 INFO - "branch": "mozilla-central", 03:33:13 INFO - "script_repo_revision": "production", 03:33:13 INFO - "revision": "4c5fbf49376351679dcc49f4cff26c3c2e055ccc", 03:33:13 INFO - "slavename": "talos-linux64-ix-043", 03:33:13 INFO - "repo_path": "mozilla-central" 03:33:13 INFO - } 03:33:13 INFO - Finding installer, test and symbols from parent task. 03:33:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RVoV1MRcRb6LJU5net3Enw'}, attempt #1 03:33:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RVoV1MRcRb6LJU5net3Enw'}, attempt #1 03:33:14 INFO - Task dependencies: dDqfdbhSQbS4bo4eXSd8Dg 03:33:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg'}, attempt #1 03:33:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:33:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.test_packages.json 03:33:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.crashreporter-symbols.zip 03:33:15 INFO - Running post-action listener: _resource_record_post_action 03:33:15 INFO - [mozharness: 2017-08-09 10:33:15.250369Z] Finished read-buildbot-config step (success) 03:33:15 INFO - [mozharness: 2017-08-09 10:33:15.250592Z] Running download-and-extract step. 03:33:15 INFO - Running pre-action listener: _resource_record_pre_action 03:33:15 INFO - Running main action method: download_and_extract 03:33:15 INFO - mkdir: /builds/slave/test/build/tests 03:33: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')]} 03:33:15 INFO - trying https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.test_packages.json 03:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:33:15 INFO - Downloaded 989 bytes. 03:33:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:33:15 INFO - Using the following test package requirements: 03:33:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:33:15 INFO - u'common': [u'target.common.tests.zip'], 03:33:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:33:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:33:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:33:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:33:15 INFO - u'mozbase': [u'target.common.tests.zip'], 03:33:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:33:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:33:15 INFO - u'web-platform': [u'target.common.tests.zip', 03:33:15 INFO - u'target.web-platform.tests.tar.gz'], 03:33:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:33:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:33:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip 03:33:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:15 INFO - Fetch https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip into memory 03:33:16 INFO - Content-Length response header: 54285614 03:33:16 INFO - Bytes received: 54285614 03:33:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:33:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip 03:33:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:27 INFO - Fetch https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip into memory 03:33:28 INFO - Content-Length response header: 54285614 03:33:28 INFO - Bytes received: 54285614 03:33:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.talos.tests.zip 03:33:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:33:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.talos.tests.zip into memory 03:33:41 INFO - Content-Length response header: 14496008 03:33:41 INFO - Bytes received: 14496008 03:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:42 INFO - trying https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:33:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:33:44 INFO - Downloaded 61995509 bytes. 03:33:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:33:44 INFO - mkdir: /builds/slave/test/properties 03:33:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:44 INFO - Contents: 03:33:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:33:44 INFO - Running post-action listener: _resource_record_post_action 03:33:44 INFO - Running post-action listener: set_extra_try_arguments 03:33:44 INFO - [mozharness: 2017-08-09 10:33:44.226752Z] Finished download-and-extract step (success) 03:33:44 INFO - [mozharness: 2017-08-09 10:33:44.226981Z] Running populate-webroot step. 03:33:44 INFO - Running pre-action listener: _resource_record_pre_action 03:33:44 INFO - Running main action method: populate_webroot 03:33:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:44 INFO - 'tests': ['damp', 'tps']}, 03:33:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:33:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:33:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:33:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:44 INFO - 'ts_paint', 03:33:44 INFO - 'tpaint', 03:33:44 INFO - 'sessionrestore', 03:33:44 INFO - 'sessionrestore_many_windows', 03:33:44 INFO - 'sessionrestore_no_auto_restore', 03:33:44 INFO - 'tabpaint']}, 03:33:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:33:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:33:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:44 INFO - 'tsvgr_opacity', 03:33:44 INFO - 'tart', 03:33:44 INFO - 'tscrollx', 03:33:44 INFO - 'tsvg_static']}, 03:33:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:44 INFO - 'talos_options': ['--mitmproxy', 03:33:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:44 INFO - '--firstNonBlankPaint'], 03:33:44 INFO - 'tests': ['tp6_google', 03:33:44 INFO - 'tp6_youtube', 03:33:44 INFO - 'tp6_amazon', 03:33:44 INFO - 'tp6_facebook']}, 03:33:44 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:44 INFO - 'talos_options': ['--stylo', 03:33:44 INFO - '--mitmproxy', 03:33:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:44 INFO - '--firstNonBlankPaint'], 03:33:44 INFO - 'tests': ['tp6_google', 03:33:44 INFO - 'tp6_youtube', 03:33:44 INFO - 'tp6_amazon', 03:33:44 INFO - 'tp6_facebook']}, 03:33:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:44 INFO - 'talos_options': ['--stylo', 03:33:44 INFO - '--stylo-threads=1', 03:33:44 INFO - '--mitmproxy', 03:33:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:44 INFO - '--firstNonBlankPaint'], 03:33:44 INFO - 'tests': ['tp6_google', 03:33:44 INFO - 'tp6_youtube', 03:33:44 INFO - 'tp6_amazon', 03:33:44 INFO - 'tp6_facebook']}, 03:33:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:44 INFO - 'talos_options': ['--xperf_path', 03:33:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:44 INFO - 'tests': ['tp5n']}}} 03:33:44 INFO - Running post-action listener: _resource_record_post_action 03:33:44 INFO - [mozharness: 2017-08-09 10:33:44.236987Z] Finished populate-webroot step (success) 03:33:44 INFO - [mozharness: 2017-08-09 10:33:44.237077Z] Running create-virtualenv step. 03:33:44 INFO - Running pre-action listener: _resource_record_pre_action 03:33:44 INFO - Running main action method: create_virtualenv 03:33:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:44 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:33:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:33:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:44 INFO - Using real prefix '/usr' 03:33:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:46 INFO - Installing pip.................done. 03:33:46 INFO - Return code: 0 03:33:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:47 INFO - Reading from file tmpfile_stdout 03:33:47 INFO - Output received: 03:33:47 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:33:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:47 INFO - Using env: {'DISPLAY': ':0', 03:33:47 INFO - 'HOME': '/home/cltbld', 03:33:47 INFO - 'LANG': 'en_US.UTF-8', 03:33:47 INFO - 'LANGUAGE': 'en_US:en', 03:33:47 INFO - 'LOGNAME': 'cltbld', 03:33:47 INFO - 'MAIL': '/var/mail/cltbld', 03:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:47 INFO - 'MOZ_NO_REMOTE': '1', 03:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:47 INFO - 'NO_EM_RESTART': '1', 03:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:47 INFO - 'PWD': '/builds/slave/test', 03:33:47 INFO - 'SHELL': '/bin/bash', 03:33:47 INFO - 'SHLVL': '1', 03:33:47 INFO - 'TERM': 'linux', 03:33:47 INFO - 'TMOUT': '86400', 03:33:47 INFO - 'USER': 'cltbld', 03:33:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:47 INFO - '_': '/tools/buildbot/bin/python'} 03:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:47 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:33:47 INFO - Cleaning up... 03:33:47 INFO - Return code: 0 03:33:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:33:47 INFO - Using env: {'DISPLAY': ':0', 03:33:47 INFO - 'HOME': '/home/cltbld', 03:33:47 INFO - 'LANG': 'en_US.UTF-8', 03:33:47 INFO - 'LANGUAGE': 'en_US:en', 03:33:47 INFO - 'LOGNAME': 'cltbld', 03:33:47 INFO - 'MAIL': '/var/mail/cltbld', 03:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:47 INFO - 'MOZ_NO_REMOTE': '1', 03:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:47 INFO - 'NO_EM_RESTART': '1', 03:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:47 INFO - 'PWD': '/builds/slave/test', 03:33:47 INFO - 'SHELL': '/bin/bash', 03:33:47 INFO - 'SHLVL': '1', 03:33:47 INFO - 'TERM': 'linux', 03:33:47 INFO - 'TMOUT': '86400', 03:33:47 INFO - 'USER': 'cltbld', 03:33:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:47 INFO - '_': '/tools/buildbot/bin/python'} 03:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:47 INFO - Downloading/unpacking psutil>=3.1.1 03:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:48 INFO - Installing collected packages: psutil 03:33:48 INFO - Running setup.py install for psutil 03:33:48 INFO - building 'psutil._psutil_linux' extension 03:33:48 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:33:48 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:33:49 INFO - building 'psutil._psutil_posix' extension 03:33:49 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:33:49 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:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:49 INFO - Successfully installed psutil 03:33:49 INFO - Cleaning up... 03:33:49 INFO - Return code: 0 03:33:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:49 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:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:49 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:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:49 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:49 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:33:49 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:33:49 INFO - Using env: {'DISPLAY': ':0', 03:33:49 INFO - 'HOME': '/home/cltbld', 03:33:49 INFO - 'LANG': 'en_US.UTF-8', 03:33:49 INFO - 'LANGUAGE': 'en_US:en', 03:33:49 INFO - 'LOGNAME': 'cltbld', 03:33:49 INFO - 'MAIL': '/var/mail/cltbld', 03:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:49 INFO - 'MOZ_NO_REMOTE': '1', 03:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:49 INFO - 'NO_EM_RESTART': '1', 03:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:49 INFO - 'PWD': '/builds/slave/test', 03:33:49 INFO - 'SHELL': '/bin/bash', 03:33:49 INFO - 'SHLVL': '1', 03:33:49 INFO - 'TERM': 'linux', 03:33:49 INFO - 'TMOUT': '86400', 03:33:49 INFO - 'USER': 'cltbld', 03:33:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:49 INFO - '_': '/tools/buildbot/bin/python'} 03:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:50 INFO - Installing collected packages: mozsystemmonitor 03:33:50 INFO - Running setup.py install for mozsystemmonitor 03:33:50 INFO - Successfully installed mozsystemmonitor 03:33:50 INFO - Cleaning up... 03:33:51 INFO - Return code: 0 03:33:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:51 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:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:51 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:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:51 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:33:51 INFO - Using env: {'DISPLAY': ':0', 03:33:51 INFO - 'HOME': '/home/cltbld', 03:33:51 INFO - 'LANG': 'en_US.UTF-8', 03:33:51 INFO - 'LANGUAGE': 'en_US:en', 03:33:51 INFO - 'LOGNAME': 'cltbld', 03:33:51 INFO - 'MAIL': '/var/mail/cltbld', 03:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:51 INFO - 'MOZ_NO_REMOTE': '1', 03:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:51 INFO - 'NO_EM_RESTART': '1', 03:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:51 INFO - 'PWD': '/builds/slave/test', 03:33:51 INFO - 'SHELL': '/bin/bash', 03:33:51 INFO - 'SHLVL': '1', 03:33:51 INFO - 'TERM': 'linux', 03:33:51 INFO - 'TMOUT': '86400', 03:33:51 INFO - 'USER': 'cltbld', 03:33:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:51 INFO - '_': '/tools/buildbot/bin/python'} 03:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:51 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:33:51 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:33:51 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:33:51 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:33:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:52 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:33:52 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:33:52 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:33:52 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:33:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:52 INFO - warning: no files found matching '*.txt' 03:33:52 INFO - no previously-included directories found matching 'build' 03:33:52 INFO - no previously-included directories found matching 'dist' 03:33:52 INFO - no previously-included directories found matching '.git*' 03:33:52 INFO - Installing collected packages: jsonschema, functools32 03:33:52 INFO - Running setup.py install for functools32 03:33:52 INFO - warning: no files found matching '*.txt' 03:33:52 INFO - no previously-included directories found matching 'build' 03:33:52 INFO - no previously-included directories found matching 'dist' 03:33:52 INFO - no previously-included directories found matching '.git*' 03:33:52 INFO - Successfully installed jsonschema functools32 03:33:52 INFO - Cleaning up... 03:33:52 INFO - Return code: 0 03:33:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:52 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:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:52 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:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:52 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:33:52 INFO - Using env: {'DISPLAY': ':0', 03:33:52 INFO - 'HOME': '/home/cltbld', 03:33:52 INFO - 'LANG': 'en_US.UTF-8', 03:33:52 INFO - 'LANGUAGE': 'en_US:en', 03:33:52 INFO - 'LOGNAME': 'cltbld', 03:33:52 INFO - 'MAIL': '/var/mail/cltbld', 03:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:52 INFO - 'MOZ_NO_REMOTE': '1', 03:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:52 INFO - 'NO_EM_RESTART': '1', 03:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:52 INFO - 'PWD': '/builds/slave/test', 03:33:52 INFO - 'SHELL': '/bin/bash', 03:33:52 INFO - 'SHLVL': '1', 03:33:52 INFO - 'TERM': 'linux', 03:33:52 INFO - 'TMOUT': '86400', 03:33:52 INFO - 'USER': 'cltbld', 03:33:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:52 INFO - '_': '/tools/buildbot/bin/python'} 03:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:52 INFO - Cleaning up... 03:33:52 INFO - Return code: 0 03:33:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:52 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:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:52 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:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:52 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:33:52 INFO - Using env: {'DISPLAY': ':0', 03:33:52 INFO - 'HOME': '/home/cltbld', 03:33:52 INFO - 'LANG': 'en_US.UTF-8', 03:33:52 INFO - 'LANGUAGE': 'en_US:en', 03:33:52 INFO - 'LOGNAME': 'cltbld', 03:33:52 INFO - 'MAIL': '/var/mail/cltbld', 03:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:52 INFO - 'MOZ_NO_REMOTE': '1', 03:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:52 INFO - 'NO_EM_RESTART': '1', 03:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:52 INFO - 'PWD': '/builds/slave/test', 03:33:52 INFO - 'SHELL': '/bin/bash', 03:33:52 INFO - 'SHLVL': '1', 03:33:52 INFO - 'TERM': 'linux', 03:33:52 INFO - 'TMOUT': '86400', 03:33:52 INFO - 'USER': 'cltbld', 03:33:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:52 INFO - '_': '/tools/buildbot/bin/python'} 03:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:53 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:33:53 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:33:53 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:33:53 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:33:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:54 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:33:54 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:33:54 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:33:54 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:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:54 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:33:54 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:33:54 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:33:54 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:33:54 INFO - Downloading docopt-0.6.1.tar.gz 03:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:54 INFO - Running setup.py install for blobuploader 03:33:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:54 INFO - Running setup.py install for requests 03:33:55 INFO - Running setup.py install for docopt 03:33:55 INFO - Successfully installed blobuploader requests docopt 03:33:55 INFO - Cleaning up... 03:33:55 INFO - Return code: 0 03:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:55 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:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:55 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:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:55 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:55 INFO - Using env: {'DISPLAY': ':0', 03:33:55 INFO - 'HOME': '/home/cltbld', 03:33:55 INFO - 'LANG': 'en_US.UTF-8', 03:33:55 INFO - 'LANGUAGE': 'en_US:en', 03:33:55 INFO - 'LOGNAME': 'cltbld', 03:33:55 INFO - 'MAIL': '/var/mail/cltbld', 03:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:55 INFO - 'MOZ_NO_REMOTE': '1', 03:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:55 INFO - 'NO_EM_RESTART': '1', 03:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:55 INFO - 'PWD': '/builds/slave/test', 03:33:55 INFO - 'SHELL': '/bin/bash', 03:33:55 INFO - 'SHLVL': '1', 03:33:55 INFO - 'TERM': 'linux', 03:33:55 INFO - 'TMOUT': '86400', 03:33:55 INFO - 'USER': 'cltbld', 03:33:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:55 INFO - '_': '/tools/buildbot/bin/python'} 03:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:55 INFO - Running setup.py (path:/tmp/pip-2SSjl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:55 INFO - Running setup.py (path:/tmp/pip-gMGi5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:55 INFO - Running setup.py (path:/tmp/pip-Jg4ttY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:55 INFO - Running setup.py (path:/tmp/pip-KwtttP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:55 INFO - Running setup.py (path:/tmp/pip-yN9sHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:56 INFO - Running setup.py (path:/tmp/pip-hau6OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:56 INFO - Running setup.py (path:/tmp/pip-HsNnsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:56 INFO - Running setup.py (path:/tmp/pip-IXSybY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:56 INFO - Running setup.py (path:/tmp/pip-2LWovL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:56 INFO - Running setup.py (path:/tmp/pip-0XU6_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:56 INFO - Running setup.py (path:/tmp/pip-GOhAoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:56 INFO - Running setup.py (path:/tmp/pip-h7uEhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:56 INFO - Running setup.py (path:/tmp/pip-0j32m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:56 INFO - Running setup.py (path:/tmp/pip-mhY2LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:56 INFO - Running setup.py (path:/tmp/pip-q3W04z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:56 INFO - Running setup.py (path:/tmp/pip-1RQlM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:56 INFO - Running setup.py (path:/tmp/pip-fZA9Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:56 INFO - Running setup.py install for manifestparser 03:33:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:56 INFO - Running setup.py install for mozcrash 03:33:57 INFO - Running setup.py install for mozdebug 03:33:57 INFO - Running setup.py install for mozdevice 03:33:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Running setup.py install for mozfile 03:33:57 INFO - Running setup.py install for mozhttpd 03:33:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Running setup.py install for mozinfo 03:33:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Running setup.py install for mozInstall 03:33:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Running setup.py install for mozleak 03:33:57 INFO - Running setup.py install for mozlog 03:33:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Running setup.py install for moznetwork 03:33:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:57 INFO - Running setup.py install for mozprocess 03:33:58 INFO - Running setup.py install for mozprofile 03:33:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Running setup.py install for mozrunner 03:33:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Running setup.py install for mozscreenshot 03:33:58 INFO - Running setup.py install for moztest 03:33:58 INFO - Running setup.py install for mozversion 03:33:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:58 INFO - Cleaning up... 03:33:58 INFO - Return code: 0 03:33:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:58 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:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:58 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:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:58 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:58 INFO - Using env: {'DISPLAY': ':0', 03:33:58 INFO - 'HOME': '/home/cltbld', 03:33:58 INFO - 'LANG': 'en_US.UTF-8', 03:33:58 INFO - 'LANGUAGE': 'en_US:en', 03:33:58 INFO - 'LOGNAME': 'cltbld', 03:33:58 INFO - 'MAIL': '/var/mail/cltbld', 03:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:58 INFO - 'MOZ_NO_REMOTE': '1', 03:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:58 INFO - 'NO_EM_RESTART': '1', 03:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:58 INFO - 'PWD': '/builds/slave/test', 03:33:58 INFO - 'SHELL': '/bin/bash', 03:33:58 INFO - 'SHLVL': '1', 03:33:58 INFO - 'TERM': 'linux', 03:33:58 INFO - 'TMOUT': '86400', 03:33:58 INFO - 'USER': 'cltbld', 03:33:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:58 INFO - '_': '/tools/buildbot/bin/python'} 03:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:58 INFO - Running setup.py (path:/tmp/pip-0JuySI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:58 INFO - Running setup.py (path:/tmp/pip-hzoGZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:59 INFO - Running setup.py (path:/tmp/pip-FHQFKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:59 INFO - Running setup.py (path:/tmp/pip-RpuLX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:59 INFO - Running setup.py (path:/tmp/pip-40Mj33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:59 INFO - Running setup.py (path:/tmp/pip-dI7_6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:59 INFO - Running setup.py (path:/tmp/pip-_d8QHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:59 INFO - Running setup.py (path:/tmp/pip-GeWQb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:59 INFO - Running setup.py (path:/tmp/pip-4Jched-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:59 INFO - Running setup.py (path:/tmp/pip-3a9A5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:59 INFO - Running setup.py (path:/tmp/pip-fDXY8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:59 INFO - Running setup.py (path:/tmp/pip-8kMYr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:59 INFO - Running setup.py (path:/tmp/pip-2QbHl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:59 INFO - Running setup.py (path:/tmp/pip-BCT2t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:59 INFO - Running setup.py (path:/tmp/pip-NDNPHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:59 INFO - Running setup.py (path:/tmp/pip-layyGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:00 INFO - Running setup.py (path:/tmp/pip-91rN3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:34:00 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:34:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:00 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:34:00 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:34:00 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:34:00 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:34:01 INFO - Downloading blessings-1.6.tar.gz 03:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:01 INFO - Installing collected packages: blessings 03:34:01 INFO - Running setup.py install for blessings 03:34:01 INFO - Successfully installed blessings 03:34:01 INFO - Cleaning up... 03:34:01 INFO - Return code: 0 03:34:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:01 INFO - Reading from file tmpfile_stdout 03:34:01 INFO - Current package versions: 03:34:01 INFO - argparse == 1.2.1 03:34:01 INFO - blessings == 1.6 03:34:01 INFO - blobuploader == 1.2.4 03:34:01 INFO - docopt == 0.6.1 03:34:01 INFO - functools32 == 3.2.3-2 03:34:01 INFO - jsonschema == 2.5.1 03:34:01 INFO - manifestparser == 1.1 03:34:01 INFO - mozInstall == 1.13 03:34:01 INFO - mozcrash == 1.0 03:34:01 INFO - mozdebug == 0.1 03:34:01 INFO - mozdevice == 0.51 03:34:01 INFO - mozfile == 1.2 03:34:01 INFO - mozhttpd == 0.7 03:34:01 INFO - mozinfo == 0.10 03:34:01 INFO - mozleak == 0.1 03:34:01 INFO - mozlog == 3.5 03:34:01 INFO - moznetwork == 0.27 03:34:01 INFO - mozprocess == 0.25 03:34:01 INFO - mozprofile == 0.28 03:34:01 INFO - mozrunner == 6.13 03:34:01 INFO - mozscreenshot == 0.1 03:34:01 INFO - mozsystemmonitor == 0.3 03:34:01 INFO - moztest == 0.8 03:34:01 INFO - mozversion == 1.4 03:34:01 INFO - psutil == 3.1.1 03:34:01 INFO - requests == 1.2.3 03:34:01 INFO - wsgiref == 0.1.2 03:34:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:01 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 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:34:01 INFO - Using env: {'DISPLAY': ':0', 03:34:01 INFO - 'HOME': '/home/cltbld', 03:34:01 INFO - 'LANG': 'en_US.UTF-8', 03:34:01 INFO - 'LANGUAGE': 'en_US:en', 03:34:01 INFO - 'LOGNAME': 'cltbld', 03:34:01 INFO - 'MAIL': '/var/mail/cltbld', 03:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:01 INFO - 'MOZ_NO_REMOTE': '1', 03:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:01 INFO - 'NO_EM_RESTART': '1', 03:34:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:01 INFO - 'PWD': '/builds/slave/test', 03:34:01 INFO - 'SHELL': '/bin/bash', 03:34:01 INFO - 'SHLVL': '1', 03:34:01 INFO - 'TERM': 'linux', 03:34:01 INFO - 'TMOUT': '86400', 03:34:01 INFO - 'USER': 'cltbld', 03:34:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:01 INFO - '_': '/tools/buildbot/bin/python'} 03:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:34:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:34:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:34: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 03:34: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 03:34: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 03:34: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 03:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:34:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:34:03 INFO - Installing collected packages: simplejson 03:34:03 INFO - Running setup.py install for simplejson 03:34:03 INFO - building 'simplejson._speedups' extension 03:34:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:34:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:34:04 INFO - Successfully installed simplejson 03:34:04 INFO - Cleaning up... 03:34:04 INFO - Return code: 0 03:34:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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')]} 03:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xabc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc88a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe2b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, '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': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', '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:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:34:04 INFO - Using env: {'DISPLAY': ':0', 03:34:04 INFO - 'HOME': '/home/cltbld', 03:34:04 INFO - 'LANG': 'en_US.UTF-8', 03:34:04 INFO - 'LANGUAGE': 'en_US:en', 03:34:04 INFO - 'LOGNAME': 'cltbld', 03:34:04 INFO - 'MAIL': '/var/mail/cltbld', 03:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:04 INFO - 'MOZ_NO_REMOTE': '1', 03:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:04 INFO - 'NO_EM_RESTART': '1', 03:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:04 INFO - 'PWD': '/builds/slave/test', 03:34:04 INFO - 'SHELL': '/bin/bash', 03:34:04 INFO - 'SHLVL': '1', 03:34:04 INFO - 'TERM': 'linux', 03:34:04 INFO - 'TMOUT': '86400', 03:34:04 INFO - 'USER': 'cltbld', 03:34:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:04 INFO - '_': '/tools/buildbot/bin/python'} 03:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:04 INFO - Cleaning up... 03:34:04 INFO - Return code: 0 03:34:04 INFO - Running post-action listener: _resource_record_post_action 03:34:04 INFO - Running post-action listener: _start_resource_monitoring 03:34:04 INFO - Starting resource monitoring. 03:34:04 INFO - [mozharness: 2017-08-09 10:34:04.415587Z] Finished create-virtualenv step (success) 03:34:04 INFO - [mozharness: 2017-08-09 10:34:04.416099Z] Running install step. 03:34:04 INFO - Running pre-action listener: _resource_record_pre_action 03:34:04 INFO - Running main action method: install 03:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:04 INFO - Reading from file tmpfile_stdout 03:34:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:04 INFO - Reading from file tmpfile_stdout 03:34:04 INFO - Output received: 03:34:04 INFO - Usage: mozinstall [options] installer 03:34:04 INFO - Options: 03:34:04 INFO - -h, --help show this help message and exit 03:34:04 INFO - -d DEST, --destination=DEST 03:34:04 INFO - Directory to install application into. [default: 03:34:04 INFO - "/builds/slave/test"] 03:34:04 INFO - --app=APP Application being installed. [default: firefox] 03:34:04 INFO - mkdir: /builds/slave/test/build/application 03:34:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:34:22 INFO - Reading from file tmpfile_stdout 03:34:22 INFO - Output received: 03:34:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:22 INFO - Running post-action listener: _resource_record_post_action 03:34:22 INFO - [mozharness: 2017-08-09 10:34:22.884726Z] Finished install step (success) 03:34:22 INFO - [mozharness: 2017-08-09 10:34:22.884980Z] Running setup-mitmproxy step. 03:34:22 INFO - Running pre-action listener: _resource_record_pre_action 03:34:22 INFO - Running main action method: setup_mitmproxy 03:34:22 INFO - Skipping: mitmproxy is not required 03:34:22 INFO - Running post-action listener: _resource_record_post_action 03:34:22 INFO - [mozharness: 2017-08-09 10:34:22.886164Z] Finished setup-mitmproxy step (success) 03:34:22 INFO - [mozharness: 2017-08-09 10:34:22.886399Z] Running run-tests step. 03:34:22 INFO - Running pre-action listener: _resource_record_pre_action 03:34:22 INFO - Running pre-action listener: _set_gcov_prefix 03:34:22 INFO - Running main action method: run_tests 03:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:22 INFO - Python 2.7.3 03:34:22 INFO - Return code: 0 03:34:22 INFO - grabbing minidump binary from tooltool 03:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:22 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 0xe288a0>, '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 0xe297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe29c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:34:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:34:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:34:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:23 INFO - Return code: 0 03:34:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:23 INFO - ENV: RUST_BACKTRACE is now full 03:34:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:23 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/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:34:23 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/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:34:23 INFO - Using env: {'DISPLAY': ':0', 03:34:23 INFO - 'HOME': '/home/cltbld', 03:34:23 INFO - 'LANG': 'en_US.UTF-8', 03:34:23 INFO - 'LANGUAGE': 'en_US:en', 03:34:23 INFO - 'LOGNAME': 'cltbld', 03:34:23 INFO - 'MAIL': '/var/mail/cltbld', 03:34:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:23 INFO - 'MOZ_NO_REMOTE': '1', 03:34:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:23 INFO - 'NO_EM_RESTART': '1', 03:34:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:23 INFO - 'PWD': '/builds/slave/test', 03:34:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:23 INFO - 'RUST_BACKTRACE': 'full', 03:34:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:23 INFO - 'SHELL': '/bin/bash', 03:34:23 INFO - 'SHLVL': '1', 03:34:23 INFO - 'STYLO_FORCE_ENABLED': '1', 03:34:23 INFO - 'TERM': 'linux', 03:34:23 INFO - 'TMOUT': '86400', 03:34:23 INFO - 'USER': 'cltbld', 03:34:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952', 03:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:23 INFO - '_': '/tools/buildbot/bin/python'} 03:34:23 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/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:34:23 INFO - mozversion application_buildid: 20170809093721 03:34:23 INFO - mozversion application_changeset: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc 03:34:23 INFO - mozversion application_display_name: Nightly 03:34:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:23 INFO - mozversion application_name: Firefox 03:34:23 INFO - mozversion application_remotingname: firefox 03:34:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:34:23 INFO - mozversion application_vendor: Mozilla 03:34:23 INFO - mozversion application_version: 57.0a1 03:34:23 INFO - mozversion platform_buildid: 20170809093721 03:34:23 INFO - mozversion platform_changeset: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc 03:34:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:34:23 INFO - mozversion platform_version: 57.0a1 03:34:23 INFO - using testdate: 1502274863 03:34:23 INFO - actual date: 1502274863 03:34:23 INFO - starting webserver on 'localhost:59038' 03:34:23 INFO - SUITE-START | Running 2 tests 03:34:23 INFO - TEST-START | dromaeo_css 03:34:23 INFO - Initialising browser for dromaeo_css test... 03:34:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59038/getInfo.html -profile /tmp/tmp86emZq/profile 03:34:23 INFO - TEST-INFO | started process 10867 (/builds/slave/test/build/application/firefox/firefox http://localhost:59038/getInfo.html) 03:34:29 INFO - TEST-INFO | 10867: exit 0 03:34:29 INFO - Browser initialized. 03:34:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:29 INFO - TEST-INFO | started process 11095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp86emZq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:30 INFO - PID 11095 | 03:34:30 INFO - PID 11095 | (/builds/slave/test/build/application/firefox/firefox:11150): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:30 INFO - PID 11095 | 03:34:40 INFO - PID 11095 | RSS: Main: 171380736 03:34:40 INFO - PID 11095 | 03:37:40 INFO - PID 11095 | Cycle 1(1): loaded http://localhost:59038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59038/tests/dromaeo/cssquery-ext.html) 03:37:41 INFO - PID 11095 | RSS: Main: 175742976 03:37:41 INFO - PID 11095 | 03:40:43 INFO - PID 11095 | Cycle 1(1): loaded http://localhost:59038/tests/dromaeo/cssquery-ext.html (next: http://localhost:59038/tests/dromaeo/cssquery-jquery.html) 03:40:44 INFO - PID 11095 | RSS: Main: 173010944 03:40:44 INFO - PID 11095 | 03:43:46 INFO - PID 11095 | Cycle 1(1): loaded http://localhost:59038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59038/tests/dromaeo/cssquery-mootools.html) 03:43:46 INFO - PID 11095 | RSS: Main: 175034368 03:43:46 INFO - PID 11095 | 03:46:48 INFO - PID 11095 | Cycle 1(1): loaded http://localhost:59038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59038/tests/dromaeo/cssquery-prototype.html) 03:46:49 INFO - PID 11095 | RSS: Main: 173105152 03:46:49 INFO - PID 11095 | 03:49:52 INFO - PID 11095 | Cycle 1(1): loaded http://localhost:59038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59038/tests/dromaeo/cssquery-yui.html) 03:49:53 INFO - PID 11095 | RSS: Main: 176971776 03:49:53 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | Cycle 1(1): loaded http://localhost:59038/tests/dromaeo/cssquery-yui.html (next: http://localhost:59038/tests/dromaeo/cssquery-dojo.html) 03:52:55 INFO - PID 11095 | RSS: Main: 177680384 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | __start_tp_report 03:52:55 INFO - PID 11095 | _x_x_mozilla_page_load 03:52:55 INFO - PID 11095 | _x_x_mozilla_page_load_details 03:52:55 INFO - PID 11095 | |i|pagename|runs| 03:52:55 INFO - PID 11095 | |0;dojo.html;3093.0256969054744;3113.891013814517;3126.155937896768;3131.279805644702;3179.968200317996;6192.164057852195;6205.596636218643;6290.339514350996;6315.021171718386;6363.586366886161;6281.246250449941;6343.333949935248;6355.713992870332;6359.014352775327;6363.236411630599;5698.373178950312;5751.971240143794;5819.563532735041;5848.444397782225;5882.911756323659;5677.744501497443;5723.4848863602265;5761.078227483604;5767.019606666877;5878;5637.633553819009;5690.9146362804595;5699.487046165844;5702.714864256771;5738.512226460756;5687.203791469197;5755.251817263729;5788.797392091299;5799.971000145015;5818.0400233961345;5671.602987790856;5695.943040569624;5771.336296325934;5772.451617096369;5772.653640781525;6179.66011869347;6180.907286390708;6218.689065546704;6288.62268263901;6309.432151106376;6589.505787065989;6656.7670131545165;6663.63350015749;6679.565828221199;6697.93302066978;6759.188897332302;6843.520953533254;6849.897251541231;6854.280300568418;6883.8967415488805;6189.876202475925;6271.372862713738;6332.588381755171;6358.364163583605;6379.681015949184;6783.626900520519;6821.420179284816;6899.57506588224;6900.2409734929115;7008.369246767816;6502.674866256668;6505.0892874997535;6517.967410162919;6522.34776522344;6543.083968244449;6472.514561407819;6674.032265321598;6675.065490831287;6684.963830606263;6688.929771236579;6517.771877984248;6522.934770652233;6541.836454088686;6631.27056023837;6641.369069938445;6560.278369379364;6681.465482761368;6693.698783554752;6699.832504187337;6708.563943343667;5332.306800116037;5333.519983201453;5351.036813373552;5361.329833770778;5363.892722145535;4555.2711566149255;4598.632109431237;4598.954010459853;4619.099275641218;4620.976895115503;5829.47534721877;5841.357450680422;5843.444872737083;5847.883042339129;5855.473007429352;6749.898751518731;6800.31996800316;6809.557378770364;6821.761238356634;6823.624700641413;5760.798372056958;5766.135079737989;5850.23946886902;5852.736626851717;5876.6180198286975;5727.255456790674;5795.1886735857015;5855.473007429352;5877.617954832922;5934.643921364732;6487.124238227873;6564;6566.80299591013;6576.704048317837;6587.80236592903;6607.108040414482;6667.799966001027;6763.7632682855865;6798.456123510206;6802.081718967876;6387.968060159669;6478.352164783484;6515.6742162892615;6516.250631177475;6622.139121914313;6614.206295244601;6617.470602351704;6617.7683781067435;6620.205575330991;6644.302348253557;6764.830879228059;6766.391024807791;6782.457403407814;6782.864342713019;6788.185417749902;6387.712552935036;6520.119783829123;6530.249021362604;6536.182977127859;6547.770828020996;6244.375562443901;6545;6611.206655201407;6614.801555953329;6629.204495460575;6454;6465.709043092978;6544.083828263952;6544.901826472512;6555.836104097436;6519.565163312671;6559.376859198559;6593.868122637425;6633.469322454095;6679.499037572299;6287.937120628735;6377.330380310001;6407.199100112486;6434.613923164625;6450.741970321323 03:52:55 INFO - PID 11095 | |1;ext.html;825.9710910118147;827.871679889617;850.1880703927748;868.3053557154275;877.4252864373835;40882;41490.585094149086;41761.373579396335;41943;41976.37035444463;37513.8124309378;37619.43570846439;37692.43461348082;37903.24193516135;37959.4306085409;6846.246912839583;6979.162500499921;6979.581225126483;6983.89524157138;6989.82525436863;6913.619750913697;7034.929650703479;7035.718571257169;7036.226015138331;7039.190493093283;6999.335063168991;7785;7988.320992715626;7993.920060799404;7997.240262175084;7855.842883142333;7922.524648521078;7926.405519585996;7930.682772689085;7930.841383172333;7551.622418879089;7612.657430415645;7769.067711874554;7778.377729781604;7788.6884524618945;39033.609663903284;39321.60678393208;39351.606483935364;39354.212915741526;39463.408048879006;3517.736169787276;3601.6398360164035;3604;3622.5834029086727;3624.039629498185;31449.685503144905;31482;31557.21106972321;31596.684033159603;31700.682993170005;5039.21892106724;5066.442691303953;5098.923516147261;5132.9743351283005;5182.041322355376;211577;215076;215700;216939;217335;47780;47874.28188577174;48154;48576;48794.512054879706;51874.740626296625;51881;52041.47958520442;52101.47898521042;52226.73886630542;14253.643658908402;14413.567592972227;14418.279086045655;14461.49384771528;14505.927470362582;11141.665750027512;11192.10463162945;11203.495842686936;11209.327440353605;11214.663560093048;13942.790858137136;14076;14139.434422623186;14150.85849141516;14251;5488.506034456918;5533.6403133796175;5537.861553461115;5634.408387119293;5729.9713501432225;1010.1262408017159;1010.4998025977188;1012.1245122968579;1014.2595904989251;1034.0486752188006;23120.42198945006;23164.420889477562;23225.419364516023;23349;23478.882605586863;1112.293693504614;1112.3492756737398;1117.234694234452;1121.2879821313525;1124.3141683573015;12094.576689815814;12166.209196402206;12381.690457738629;12425;12512.624621261195;228595;230232;230731;232394;232823;54073.72963135238;54431.72784136054;54843.17735233975;58508.70745646244;58702.412975869694;1487.501686934889;1511.7430036893754;1514;1515.9545213643607;1534.0948840184121;26678;26762.598561021212;27006;27124.593131103444;27263.86368068147;37807.24385512219;37813.62186378101;38164.809175953946;38293.4255986166;38308.61691383162;205272;205381;205402;206441;206529;33668.46481119447;35665.82167089148;35805.1048723784;36061.81969090138;36167.457488137174;43575.56424435715;43771.34342984794;43786.56213437825;47124.764376177896;47284;33506.66493335035;33575.66424335823;34103;34169;34426;33939;34103.658963410046;34237.82881085579;34429.13927151741;34650.48024279587;36451.45322820213;37639;37776.62223377731;37799;37809.432858507695;32296.83851580727;33359.666403336625;33495.83252083724;33555.66444335526;33724.831375842965;23897.40256493532;24567.877160614084;24718.629220562067;25030.749692502843;25050 03:52:55 INFO - PID 11095 | |2;jquery.html;541.501818327139;572.2932178759235;580.1732531143122;586.3374386942754;591.65979561752;22233.777662223372;22399.664005039896;23080.76919230807;23125.884370578166;23130.30609081726;26541.734582654168;27115.593266101023;27120.45759084817;27139.86430067847;27162.45675086502;6695.832604184898;6821.965890170567;6856.382925536701;6858.245592984767;6859.759908403207;4100.343944968806;5847.427132061879;6662.700178491979;6722.899156512656;6755.932440675604;4076.082881351702;4093.385992101179;4095.8361665533344;6618.768343107992;6643.701033453482;6625.337466253384;6632.403083722488;6641.966790166019;6651.866962660744;6659.234188068362;6108.419700128481;6141.938580614182;6152.6308421494405;6159.414855588712;6180.258368995749;28975.42049159026;29681;29926.70073299261;30313.848430757927;30362.84818575915;1948.298612499499;1973.7434133562545;1974.1609815828358;1976.5256338478805;1978.4262563856464;19481.610367792706;20076.799232007637;20084.297049603192;20101.296454624164;20115.698264525898;2335.7781010804115;2370.893309801063;2377.453185767266;2403.327068420845;2438.573249681299;127205;130080;130097.99999999905;130520.99999999905;130882;14411.711765764836;15057;15115.825676607816;15119.924400377928;15743.370265189264;23745.7625423747;23768.88115559411;23832.285031449082;23886.761132388452;23923.16268930579;9977.950110249401;10000.299979001546;10072.244581656405;10080.94150114242;10158.288919775545;7609.733659322008;9271.721848344561;9359.29805264608;9421.90578094224;9475.810483790285;8033.477823941425;8807.251383632463;8852.557372131369;8921.330900182513;8954.417962832395;2563.1925943328165;2570.8200425970376;2657.521646103681;2705.8612010068227;2732.330579008116;929.6839074714629;954.9761255968656;959.3955807841015;971.562796741455;981.5582987655441;19142.521436964187;19775.847072114728;19843.40469785909;19845.900770496057;19920.402387928385;1007.5717819926502;1032.5766435761452;1039.859618951447;1042.3485321673954;1052.3948729480426;10721.249512534203;10730.624428144978;10961.177911656658;11081.168912331446;11319.37743424103;542785;546307;549572;554337;563380;111400.4429977845;113850;116060.41969790266;121864.39067804781;121932;1252.5741247975732;1252.8559215690311;1274.420138836827;1286.9034822388546;1296.4749276543016;21003.159873604884;21166.7883321171;21315;21436.249731259955;21478.24826131078;54750;54862.45137548573;55121;55268;56018;66840.6657966707;67216.327836721;67535;68399.31600683929;69129;14354.138751674933;14866.776998345249;14872.479463218735;14898.627534311729;14974.775378369552;23065.308040758806;23195.88402057979;23743.168989085298;23782.405439864142;23905.64141537913;18287.359942401952;18724.438266852016;19391.612167756848;19491.610167796847;19519.219231230592;17430.738538921672;17495.912520437316;17763.73354399711;17766.91116544409;17988.370407036215;18874.811251887855;19654;19754.70367944511;19909.502262443555;20160;14770.77843832322;15143.924280378527;15160.848391515943;15268.312925918583;15280.312385942882;18822;18888.15003324881;18914;18981;18984.620307593494 03:52:55 INFO - PID 11095 | |3;mootools.html;1346.4344975110455;1413.2368520998662;1417.7164567086586;1423.0323380101527;1426.2868565717142;13692.794608080874;14024.018318717694;14232;14241.28793560323;14288.714225715492;14651.194184319886;14877.92561037196;14878.55364339069;14897.329620167091;14911.254437278147;2594.403287243935;2651.191386627078;2657.8936842526373;2657.9202623921315;2660.8669566521694;2334.4047267946735;2394.5330660521117;2406.109739396417;2732.4671689020647;2827.377976845101;2741.7806575474015;2755.8484283364405;2756.503829310723;2759.296379423254;2759.323965628424;2629.3163777417817;2673.17131689177;2759.7930155238337;2763.875625596833;2768.958465622997;2571.434284457416;2621.082621082625;2630.3818602628367;2637.26156676131;2650.655414796064;13653.180809151483;13968.860311396958;13976.440942362293;13978.720425591533;13990.510332138429;7168.713251469935;7411.88882166768;7420.814479637998;7423.628818559105;7426.997355357012;4688.953110468886;4930.186519224324;5025.643076369396;5039.647224694273;5053.9241911371355;1802.927882884683;1809.8009218986033;1825.972610410845;1851.1022154255174;1864.2449807827852;23207;23519.294421167393;23537.529249415085;23580.7641923582;23588.764112359;6160.969195153995;6245.219347581552;6296.181496405529;6446.3553644636095;6475.838104047342;16030.835837161834;16051.117188554508;16181.919090404472;16203.83796162047;16218.432354867524;7305.671244793997;7485.026946496921;7490.588017658972;7512.6243687815395;7517.511361761468;6831.248562658104;6964.477664175207;7042.225355210922;7047.224805271416;7107.253738357502;4445.244308467503;4595.793189306489;5033.1695270280725;5046.949530504721;5106.387233532;1413.971720565583;1427.4290283886528;1434.1323499282992;1441.128117488904;1448.1238850495508;895.4716717136921;908.9500077495801;913.3195769152024;919.7470695558775;926.402470406584;8305.169483051768;8326.417150799507;8330.916690833135;8368.874466883002;8396.748097557083;980.2745967983641;1010.5604062232952;1014.3356101753363;1021.1320377678913;1033.679559336608;4465.709728867613;4646.907061858744;4678.976605116953;4964.553190212898;5169.896602068013;17956.371526996492;18445.5388615283;18458.630827383644;18510.16704248312;18525.166367513495;18436.262549498137;19132.713009304873;19559.511012224524;19571.804281956996;19620.313289034817;10992.505337259843;11027.669169924915;11172.273802202832;11174.217804753589;11193.27243729155;7796.61016949139;7902.525848449111;7927.365810735243;8106.716264930699;8147.226013528705;16687.165641717624;16804.915975420045;17066.48800535986;17089.829101708823;17091.145442727564;17249;17326.480205593853;17533.736993945357;17645.382411616047;18006.72989905126;10655.467226638792;11443.713907152054;11773.823392649289;11781.587644432404;11787.057035436974;11767.823482647596;12076.698082548006;12416.317102559085;13284.136531125447;13526.18842869431;10665.8933410668;10797.56809727602;10828.5127169276;10861.78276434451;11109.11127109813;10627.309224900357;10660.360378377321;10836.67489975302;10960.890391095987;11055.281406708538;9079.409838360485;9231.630734770533;9247.86128208064;9249.352545321763;9254.213391861767;6610.966945165435;6639.6680165992475;6656;6769.627670478171;6783.253842077269;7320.267973202637;7327;7368.852622947618;7417.517861338995;7455.9627201865815 03:52:55 INFO - PID 11095 | |4;prototype.html;508.32139094309093;513.8869448721284;527.3223907279147;537.3685919045123;539.892021595681;6231.470325022378;6246.187995560576;6261.40516650918;6264.937350626492;6279.654618995954;6150.969245153768;6163.784267550625;6166.533386645344;6170.722317495713;6212.285587157478;5144.922826157611;5157.922631160535;5160;5160.432352441228;5169.844904652867;4848.563629273364;4990.800367985276;5090.567301779353;5097.949020509803;5131.923021154686;4932;4946.0107978404285;4960.280759289901;4963.60291176705;5021.9912035186035;4866.78099485524;4948.802047918097;4958.281049247857;4966.602671786249;4998.925016124761;4442.955570444286;4455.910881782379;4477.238869392211;4491.25894227452;4503.707259028152;6092.512598992114;6108.755649774003;6124.724387402578;6133.478654314388;6146.84632884177;5574.721263936787;5638.661680299154;5691.26013618227;5767;5768.971155144198;6342.048692696087;6487.481001519867;6517.93482065178;6530.6408147551865;6536.705848236841;4854.514548545152;4872.147374209535;4876.414830220361;4892.3884514435695;4957.859692270762;6643;6643.900341494881;6657.46740260778;6896.862062758717;7014.5440546364325;4859.975700121477;4952.083864485082;4956.207006878882;4978.10394129053;4984.134122879286;5007.39911210657;5036.84889453317;5059.595232381401;5087.3974697970025;5101.2603172539775;5642.181883626933;5734.369219385864;5748.511376532958;5759.308882934075;5767.596268261182;6579.868402631921;6630.049627915628;6634.734610615618;6688.565243259172;6705.865882682417;1734.8698847586481;1754.3859649122705;1776.262850916855;1793.9103044847704;1800.4778614201996;1198.9280643161437;1251.3367915005063;1258.0941721960173;1266.5187228852976;1269.339943229534;5690.9146362804595;5697.259356283656;5703.971480142573;5781.682007489544;5819.359870414251;6686.1642294713165;6694.230163531159;6714.3957043866285;6715.865682686319;6739.797806065826;5711.400302968212;5711.685857277889;5737.3975732548315;5767.826965191051;5778.017736984722;3576.195356044869;3593.299306635181;3595.1371670799344;3637.618050104701;3648.562172539312;6445.871082578322;6484.157059582224;6502.60984340941;6504.219493660791;6530.575512591667;6479.125318082093;6813.148356455443;6854.760083397157;6882.449404047664;6937.618430986243;6320.38830098322;6404.807855764335;6495.025746138117;6517.9348206517325;6554.050677195281;6621.112982799879;6706.960421134732;6722.495812814156;6739.865202696017;6776.966115169393;6621.0467911965125;6621.27166011748;6625.436837868835;6730.932690673227;6731.283522701679;6429.22849258092;6464.385883341075;6498.252700939453;6520.359254501935;6570.47436205112;5032.169692000925;5034;5052.216906379517;5069.264956581349;5094.541491265803;6493.8701225976165;6540.215174179129;6737.124173857367;6828.931710682829;6868.828279293058;6344.9048264277;6352.809415717536;6385.553011289351;6455.741770329134;6517.73929042852;6433.324500927522;6465.515086368447;6496.317886621837;6530.640814755234;6532.778855189068;6291.276503202007;6389.393007664265;6404;6445.452136568444;6455.838604034937;6455.515836312389;6542.247641521286;6587.374199451045;6610.9669451652435;6650.401463868275;6263.436290733674;6266.83524819963;6355.1420558224045;6423.907935651044;6452.387023232785 03:52:55 INFO - PID 11095 | |5;yui.html;873.7422460374189;886.0740526150172;906.7687739626394;913.8172365526895;914.1498406481974;17592.120393980298;18632.906835465838;18652.720209196872;18711.438656840317;18714.15786289615;16991;19167.712484312713;22010.559788804254;22139.889300553514;22238.777612223872;1043.3374806997554;1063.7234319077018;1069.5080263078994;1070.293606219895;1072.222638587026;1011.5852500474807;1042.2183362478142;1047.4029803012286;1048.0462778871229;1052.8578641883362;1088.678839742278;1109.2900543652029;1109.983350249747;1113.7104352868273;1115.2082021764556;1099.8295264234016;1100.1363929315448;1101.1686176936403;1104.6575561575937;1105.0496572947259;809.1301850510724;812.1472453923416;812.3176531713389;812.3257696112272;816.5304949653913;18644.62710745791;18681.34615288472;19117.426477205707;19239;19338.709919351222;21844.563108737737;22046.669299960515;22053.33839984803;22489;22605;15517.534473965687;15762.921185394;15786.131762753044;15934.28295726695;16076.356945722157;3585.103724068983;3606.6934310583633;3612.295602357541;3614.963850361489;3627.546556680415;123353;128140.35929820291;128440.35779821042;129084;130867;16338.18309084541;16880;16992.57518562046;17012.319507219574;17103.57241068983;30493.23766905845;30585.84707076495;31083;31128.84435577853;31288.843555782074;8502;8514.957425212959;8524.701635442854;8560.871586926201;8599.710043493526;3994.46074779901;4205.074883525619;4258.063226090255;4262.786860656955;4272.230998420252;5202.869928251824;5360.973195134077;5381.1121165007335;5402.51377376038;5407.107827208545;1054.7626783973699;1055.8521806947033;1070.662741236508;1100.4717735486852;1141.1612464838338;693.5180049865396;708.7483943200193;709.6380845768695;718.9317014883683;731.4916133287314;12101.69745756363;12211.26732396059;12874;13392.933035334761;13918.30408479572;691.6541729135432;708.1290013283588;714.4320265388924;717.8061923280685;719.3418022509345;5531.059719847635;5531.308586426697;5538.47384498472;6131.908021379683;6333.050042493663;97849.021509784;101143;101220.49389753005;102216;103790;94571.52714236523;94727.52636236775;96789;97433.51283243539;99211.50394247983;80029.59985200036;81177;81905.18094819094;82130;86545;12453.626391208278;12856.357182141042;13075.476980920657;13172.341382931007;13198.20810751358;40856.79571602123;41526.584734152275;41606.1678766429;43298;43507.56492435035;71357;73328;77122;77625;79340;17971.730424043388;19015.71476427827;20245.59508809845;20296.79703202949;20366.490837729176;21892;22356.441088972904;22457.550848983257;22484.213052543084;22687.20594779241;18545.745105873277;18787.624247515247;19509.219631214593;19859.404217873485;20328.186872525526;20505.89747051255;20726;20751;20781.48046298794;20987.055582499128;19078.61842763165;19785.40643780689;19924.60150796947;20027.599448010667;20046.198152073754;12677.366131693194;13505.39225734864;14106.647333816736;14370.49703260381;14776.778348324999;14178;14263.572092837232;14324.928375358057;14339.784903226251;14402.927985360006 03:52:55 INFO - PID 11095 | __end_tp_report 03:52:55 INFO - PID 11095 | __start_cc_report 03:52:55 INFO - PID 11095 | _x_x_mozilla_cycle_collect,356 03:52:55 INFO - PID 11095 | __end_cc_report 03:52:55 INFO - PID 11095 | __startTimestamp1502275975609__endTimestamp 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | ------- Summary: start ------- 03:52:55 INFO - PID 11095 | Number of tests: 6 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | [#0] dojo.html Cycles:165 Average:6175.64 Median:6450.74 stddev:737.75 (11.4%) stddev-sans-first:699.26 03:52:55 INFO - PID 11095 | Values: 3093.0 3113.9 3126.2 3131.3 3180.0 6192.2 6205.6 6290.3 6315.0 6363.6 6281.2 6343.3 6355.7 6359.0 6363.2 5698.4 5752.0 5819.6 5848.4 5882.9 5677.7 5723.5 5761.1 5767.0 5878.0 5637.6 5690.9 5699.5 5702.7 5738.5 5687.2 5755.3 5788.8 5800.0 5818.0 5671.6 5695.9 5771.3 5772.5 5772.7 6179.7 6180.9 6218.7 6288.6 6309.4 6589.5 6656.8 6663.6 6679.6 6697.9 6759.2 6843.5 6849.9 6854.3 6883.9 6189.9 6271.4 6332.6 6358.4 6379.7 6783.6 6821.4 6899.6 6900.2 7008.4 6502.7 6505.1 6518.0 6522.3 6543.1 6472.5 6674.0 6675.1 6685.0 6688.9 6517.8 6522.9 6541.8 6631.3 6641.4 6560.3 6681.5 6693.7 6699.8 6708.6 5332.3 5333.5 5351.0 5361.3 5363.9 4555.3 4598.6 4599.0 4619.1 4621.0 5829.5 5841.4 5843.4 5847.9 5855.5 6749.9 6800.3 6809.6 6821.8 6823.6 5760.8 5766.1 5850.2 5852.7 5876.6 5727.3 5795.2 5855.5 5877.6 5934.6 6487.1 6564.0 6566.8 6576.7 6587.8 6607.1 6667.8 6763.8 6798.5 6802.1 6388.0 6478.4 6515.7 6516.3 6622.1 6614.2 6617.5 6617.8 6620.2 6644.3 6764.8 6766.4 6782.5 6782.9 6788.2 6387.7 6520.1 6530.2 6536.2 6547.8 6244.4 6545.0 6611.2 6614.8 6629.2 6454.0 6465.7 6544.1 6544.9 6555.8 6519.6 6559.4 6593.9 6633.5 6679.5 6287.9 6377.3 6407.2 6434.6 6450.7 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | [#1] ext.html Cycles:180 Average:38871.37 Median:19832.91 stddev:56444.91 (284.6%) stddev-sans-first:56530.96 03:52:55 INFO - PID 11095 | Values: 826.0 827.9 850.2 868.3 877.4 40882.0 41490.6 41761.4 41943.0 41976.4 37513.8 37619.4 37692.4 37903.2 37959.4 6846.2 6979.2 6979.6 6983.9 6989.8 6913.6 7034.9 7035.7 7036.2 7039.2 6999.3 7785.0 7988.3 7993.9 7997.2 7855.8 7922.5 7926.4 7930.7 7930.8 7551.6 7612.7 7769.1 7778.4 7788.7 39033.6 39321.6 39351.6 39354.2 39463.4 3517.7 3601.6 3604.0 3622.6 3624.0 31449.7 31482.0 31557.2 31596.7 31700.7 5039.2 5066.4 5098.9 5133.0 5182.0 211577.0 215076.0 215700.0 216939.0 217335.0 47780.0 47874.3 48154.0 48576.0 48794.5 51874.7 51881.0 52041.5 52101.5 52226.7 14253.6 14413.6 14418.3 14461.5 14505.9 11141.7 11192.1 11203.5 11209.3 11214.7 13942.8 14076.0 14139.4 14150.9 14251.0 5488.5 5533.6 5537.9 5634.4 5730.0 1010.1 1010.5 1012.1 1014.3 1034.0 23120.4 23164.4 23225.4 23349.0 23478.9 1112.3 1112.3 1117.2 1121.3 1124.3 12094.6 12166.2 12381.7 12425.0 12512.6 228595.0 230232.0 230731.0 232394.0 232823.0 54073.7 54431.7 54843.2 58508.7 58702.4 1487.5 1511.7 1514.0 1516.0 1534.1 26678.0 26762.6 27006.0 27124.6 27263.9 37807.2 37813.6 38164.8 38293.4 38308.6 205272.0 205381.0 205402.0 206441.0 206529.0 33668.5 35665.8 35805.1 36061.8 36167.5 43575.6 43771.3 43786.6 47124.8 47284.0 33506.7 33575.7 34103.0 34169.0 34426.0 33939.0 34103.7 34237.8 34429.1 34650.5 36451.5 37639.0 37776.6 37799.0 37809.4 32296.8 33359.7 33495.8 33555.7 33724.8 23897.4 24567.9 24718.6 25030.7 25050.0 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | [#2] jquery.html Cycles:180 Average:36382.72 Median:12765.83 stddev:91800.27 (719.1%) stddev-sans-first:92018.35 03:52:55 INFO - PID 11095 | Values: 541.5 572.3 580.2 586.3 591.7 22233.8 22399.7 23080.8 23125.9 23130.3 26541.7 27115.6 27120.5 27139.9 27162.5 6695.8 6822.0 6856.4 6858.2 6859.8 4100.3 5847.4 6662.7 6722.9 6755.9 4076.1 4093.4 4095.8 6618.8 6643.7 6625.3 6632.4 6642.0 6651.9 6659.2 6108.4 6141.9 6152.6 6159.4 6180.3 28975.4 29681.0 29926.7 30313.8 30362.8 1948.3 1973.7 1974.2 1976.5 1978.4 19481.6 20076.8 20084.3 20101.3 20115.7 2335.8 2370.9 2377.5 2403.3 2438.6 127205.0 130080.0 130098.0 130521.0 130882.0 14411.7 15057.0 15115.8 15119.9 15743.4 23745.8 23768.9 23832.3 23886.8 23923.2 9978.0 10000.3 10072.2 10080.9 10158.3 7609.7 9271.7 9359.3 9421.9 9475.8 8033.5 8807.3 8852.6 8921.3 8954.4 2563.2 2570.8 2657.5 2705.9 2732.3 929.7 955.0 959.4 971.6 981.6 19142.5 19775.8 19843.4 19845.9 19920.4 1007.6 1032.6 1039.9 1042.3 1052.4 10721.2 10730.6 10961.2 11081.2 11319.4 542785.0 546307.0 549572.0 554337.0 563380.0 111400.4 113850.0 116060.4 121864.4 121932.0 1252.6 1252.9 1274.4 1286.9 1296.5 21003.2 21166.8 21315.0 21436.2 21478.2 54750.0 54862.5 55121.0 55268.0 56018.0 66840.7 67216.3 67535.0 68399.3 69129.0 14354.1 14866.8 14872.5 14898.6 14974.8 23065.3 23195.9 23743.2 23782.4 23905.6 18287.4 18724.4 19391.6 19491.6 19519.2 17430.7 17495.9 17763.7 17766.9 17988.4 18874.8 19654.0 19754.7 19909.5 20160.0 14770.8 15143.9 15160.8 15268.3 15280.3 18822.0 18888.2 18914.0 18981.0 18984.6 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | [#3] mootools.html Cycles:180 Average:8714.63 Median:2400.32 stddev:5973.88 (248.9%) stddev-sans-first:5964.99 03:52:55 INFO - PID 11095 | Values: 1346.4 1413.2 1417.7 1423.0 1426.3 13692.8 14024.0 14232.0 14241.3 14288.7 14651.2 14877.9 14878.6 14897.3 14911.3 2594.4 2651.2 2657.9 2657.9 2660.9 2334.4 2394.5 2406.1 2732.5 2827.4 2741.8 2755.8 2756.5 2759.3 2759.3 2629.3 2673.2 2759.8 2763.9 2769.0 2571.4 2621.1 2630.4 2637.3 2650.7 13653.2 13968.9 13976.4 13978.7 13990.5 7168.7 7411.9 7420.8 7423.6 7427.0 4689.0 4930.2 5025.6 5039.6 5053.9 1802.9 1809.8 1826.0 1851.1 1864.2 23207.0 23519.3 23537.5 23580.8 23588.8 6161.0 6245.2 6296.2 6446.4 6475.8 16030.8 16051.1 16181.9 16203.8 16218.4 7305.7 7485.0 7490.6 7512.6 7517.5 6831.2 6964.5 7042.2 7047.2 7107.3 4445.2 4595.8 5033.2 5046.9 5106.4 1414.0 1427.4 1434.1 1441.1 1448.1 895.5 909.0 913.3 919.7 926.4 8305.2 8326.4 8330.9 8368.9 8396.7 980.3 1010.6 1014.3 1021.1 1033.7 4465.7 4646.9 4679.0 4964.6 5169.9 17956.4 18445.5 18458.6 18510.2 18525.2 18436.3 19132.7 19559.5 19571.8 19620.3 10992.5 11027.7 11172.3 11174.2 11193.3 7796.6 7902.5 7927.4 8106.7 8147.2 16687.2 16804.9 17066.5 17089.8 17091.1 17249.0 17326.5 17533.7 17645.4 18006.7 10655.5 11443.7 11773.8 11781.6 11787.1 11767.8 12076.7 12416.3 13284.1 13526.2 10665.9 10797.6 10828.5 10861.8 11109.1 10627.3 10660.4 10836.7 10960.9 11055.3 9079.4 9231.6 9247.9 9249.4 9254.2 6611.0 6639.7 6656.0 6769.6 6783.3 7320.3 7327.0 7368.9 7417.5 7456.0 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | [#4] prototype.html Cycles:180 Average:5507.88 Median:6157.38 stddev:1529.80 (24.8%) stddev-sans-first:1487.35 03:52:55 INFO - PID 11095 | Values: 508.3 513.9 527.3 537.4 539.9 6231.5 6246.2 6261.4 6264.9 6279.7 6151.0 6163.8 6166.5 6170.7 6212.3 5144.9 5157.9 5160.0 5160.4 5169.8 4848.6 4990.8 5090.6 5097.9 5131.9 4932.0 4946.0 4960.3 4963.6 5022.0 4866.8 4948.8 4958.3 4966.6 4998.9 4443.0 4455.9 4477.2 4491.3 4503.7 6092.5 6108.8 6124.7 6133.5 6146.8 5574.7 5638.7 5691.3 5767.0 5769.0 6342.0 6487.5 6517.9 6530.6 6536.7 4854.5 4872.1 4876.4 4892.4 4957.9 6643.0 6643.9 6657.5 6896.9 7014.5 4860.0 4952.1 4956.2 4978.1 4984.1 5007.4 5036.8 5059.6 5087.4 5101.3 5642.2 5734.4 5748.5 5759.3 5767.6 6579.9 6630.0 6634.7 6688.6 6705.9 1734.9 1754.4 1776.3 1793.9 1800.5 1198.9 1251.3 1258.1 1266.5 1269.3 5690.9 5697.3 5704.0 5781.7 5819.4 6686.2 6694.2 6714.4 6715.9 6739.8 5711.4 5711.7 5737.4 5767.8 5778.0 3576.2 3593.3 3595.1 3637.6 3648.6 6445.9 6484.2 6502.6 6504.2 6530.6 6479.1 6813.1 6854.8 6882.4 6937.6 6320.4 6404.8 6495.0 6517.9 6554.1 6621.1 6707.0 6722.5 6739.9 6777.0 6621.0 6621.3 6625.4 6730.9 6731.3 6429.2 6464.4 6498.3 6520.4 6570.5 5032.2 5034.0 5052.2 5069.3 5094.5 6493.9 6540.2 6737.1 6828.9 6868.8 6344.9 6352.8 6385.6 6455.7 6517.7 6433.3 6465.5 6496.3 6530.6 6532.8 6291.3 6389.4 6404.0 6445.5 6455.8 6455.5 6542.2 6587.4 6611.0 6650.4 6263.4 6266.8 6355.1 6423.9 6452.4 03:52:55 INFO - PID 11095 | 03:52:55 INFO - PID 11095 | [#5] yui.html Cycles:180 Average:23938.48 Median:20436.19 stddev:31599.95 (154.6%) stddev-sans-first:31641.14 03:52:55 INFO - PID 11095 | Values: 873.7 886.1 906.8 913.8 914.1 17592.1 18632.9 18652.7 18711.4 18714.2 16991.0 19167.7 22010.6 22139.9 22238.8 1043.3 1063.7 1069.5 1070.3 1072.2 1011.6 1042.2 1047.4 1048.0 1052.9 1088.7 1109.3 1110.0 1113.7 1115.2 1099.8 1100.1 1101.2 1104.7 1105.0 809.1 812.1 812.3 812.3 816.5 18644.6 18681.3 19117.4 19239.0 19338.7 21844.6 22046.7 22053.3 22489.0 22605.0 15517.5 15762.9 15786.1 15934.3 16076.4 3585.1 3606.7 3612.3 3615.0 3627.5 123353.0 128140.4 128440.4 129084.0 130867.0 16338.2 16880.0 16992.6 17012.3 17103.6 30493.2 30585.8 31083.0 31128.8 31288.8 8502.0 8515.0 8524.7 8560.9 8599.7 3994.5 4205.1 4258.1 4262.8 4272.2 5202.9 5361.0 5381.1 5402.5 5407.1 1054.8 1055.9 1070.7 1100.5 1141.2 693.5 708.7 709.6 718.9 731.5 12101.7 12211.3 12874.0 13392.9 13918.3 691.7 708.1 714.4 717.8 719.3 5531.1 5531.3 5538.5 6131.9 6333.1 97849.0 101143.0 101220.5 102216.0 103790.0 94571.5 94727.5 96789.0 97433.5 99211.5 80029.6 81177.0 81905.2 82130.0 86545.0 12453.6 12856.4 13075.5 13172.3 13198.2 40856.8 41526.6 41606.2 43298.0 43507.6 71357.0 73328.0 77122.0 77625.0 79340.0 17971.7 19015.7 20245.6 20296.8 20366.5 21892.0 22356.4 22457.6 22484.2 22687.2 18545.7 18787.6 19509.2 19859.4 20328.2 20505.9 20726.0 20751.0 20781.5 20987.1 19078.6 19785.4 19924.6 20027.6 20046.2 12677.4 13505.4 14106.6 14370.5 14776.8 14178.0 14263.6 14324.9 14339.8 14402.9 03:52:55 INFO - PID 11095 | -------- Summary: end -------- 03:52:55 INFO - PID 11095 | 03:52:56 INFO - TEST-INFO | 11095: exit 0 03:52:56 INFO - TEST-OK | dromaeo_css | took 1113065ms 03:52:56 INFO - TEST-START | kraken 03:52:56 INFO - Initialising browser for kraken test... 03:52:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59038/getInfo.html -profile /tmp/tmpMPTH4Q/profile 03:52:56 INFO - TEST-INFO | started process 11474 (/builds/slave/test/build/application/firefox/firefox http://localhost:59038/getInfo.html) 03:53:02 INFO - TEST-INFO | 11474: exit 0 03:53:02 INFO - Browser initialized. 03:53:02 INFO - Running cycle 1/1 for kraken test... 03:53:02 INFO - TEST-INFO | started process 11704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMPTH4Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:03 INFO - PID 11704 | 03:53:03 INFO - PID 11704 | (/builds/slave/test/build/application/firefox/firefox:11759): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:53:03 INFO - PID 11704 | 03:53:13 INFO - PID 11704 | RSS: Main: 171241472 03:53:13 INFO - PID 11704 | 03:53:16 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59038/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:17 INFO - PID 11704 | RSS: Main: 175194112 03:53:17 INFO - PID 11704 | 03:53:19 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59038/tests/kraken/driver.html?testName=audio-dft) 03:53:20 INFO - PID 11704 | RSS: Main: 175685632 03:53:20 INFO - PID 11704 | 03:53:23 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59038/tests/kraken/driver.html?testName=audio-fft) 03:53:24 INFO - PID 11704 | RSS: Main: 171380736 03:53:24 INFO - PID 11704 | 03:53:26 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59038/tests/kraken/driver.html?testName=audio-oscillator) 03:53:27 INFO - PID 11704 | RSS: Main: 171839488 03:53:27 INFO - PID 11704 | 03:53:29 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:30 INFO - PID 11704 | RSS: Main: 172163072 03:53:30 INFO - PID 11704 | 03:53:33 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59038/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:33 INFO - PID 11704 | RSS: Main: 174587904 03:53:33 INFO - PID 11704 | 03:53:37 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59038/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:38 INFO - PID 11704 | RSS: Main: 173670400 03:53:38 INFO - PID 11704 | 03:53:40 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59038/tests/kraken/driver.html?testName=json-parse-financial) 03:53:41 INFO - PID 11704 | RSS: Main: 174493696 03:53:41 INFO - PID 11704 | 03:53:43 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:43 INFO - PID 11704 | RSS: Main: 174804992 03:53:43 INFO - PID 11704 | 03:53:45 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:46 INFO - PID 11704 | RSS: Main: 174981120 03:53:46 INFO - PID 11704 | 03:53:48 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:49 INFO - PID 11704 | RSS: Main: 174919680 03:53:49 INFO - PID 11704 | 03:53:52 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:52 INFO - PID 11704 | RSS: Main: 175136768 03:53:52 INFO - PID 11704 | 03:53:56 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:56 INFO - PID 11704 | RSS: Main: 175222784 03:53:56 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | Cycle 1(1): loaded http://localhost:59038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59038/tests/kraken/driver.html?testName=ai-astar) 03:53:58 INFO - PID 11704 | RSS: Main: 176869376 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | __start_tp_report 03:53:58 INFO - PID 11704 | _x_x_mozilla_page_load 03:53:58 INFO - PID 11704 | _x_x_mozilla_page_load_details 03:53:58 INFO - PID 11704 | |i|pagename|runs| 03:53:58 INFO - PID 11704 | |0;ai-astar;98;111;101;108;113;110;108;103;111;110 03:53:58 INFO - PID 11704 | |1;audio-beat-detection;144;118;140;185;127;146;155;118;185;119 03:53:58 INFO - PID 11704 | |2;audio-dft;163;163;170;162;170;166;166;162;168;163 03:53:58 INFO - PID 11704 | |3;audio-fft;76;78;78;166;82;76;79;74;156;77 03:53:58 INFO - PID 11704 | |4;audio-oscillator;85;88;131;78;79;79;132;83;79;133 03:53:58 INFO - PID 11704 | |5;imaging-gaussian-blur;117;119;113;113;114;121;115;117;114;114 03:53:58 INFO - PID 11704 | |6;imaging-darkroom;154;150;153;152;151;151;152;149;151;150 03:53:58 INFO - PID 11704 | |7;imaging-desaturate;94;94;99;101;98;94;96;94;94;101 03:53:58 INFO - PID 11704 | |8;json-parse-financial;55;54;60;61;58;54;53;54;54;56 03:53:58 INFO - PID 11704 | |9;json-stringify-tinderbox;60;60;53;55;55;54;55;56;57;56 03:53:58 INFO - PID 11704 | |10;stanford-crypto-aes;80;79;78;79;78;79;78;90;93;78 03:53:58 INFO - PID 11704 | |11;stanford-crypto-ccm;140;130;142;142;136;126;136;127;131;182 03:53:58 INFO - PID 11704 | |12;stanford-crypto-pbkdf2;171;176;196;194;184;183;175;186;174;180 03:53:58 INFO - PID 11704 | |13;stanford-crypto-sha256-iterative;74;68;67;67;71;69;69;79;74;75 03:53:58 INFO - PID 11704 | __end_tp_report 03:53:58 INFO - PID 11704 | __start_cc_report 03:53:58 INFO - PID 11704 | _x_x_mozilla_cycle_collect,983 03:53:58 INFO - PID 11704 | __end_cc_report 03:53:58 INFO - PID 11704 | __startTimestamp1502276038782__endTimestamp 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | ------- Summary: start ------- 03:53:58 INFO - PID 11704 | Number of tests: 14 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#0] ai-astar Cycles:10 Average:107.30 Median:110.50 stddev:4.95 (4.5%) stddev-sans-first:3.94 03:53:58 INFO - PID 11704 | Values: 98.0 111.0 101.0 108.0 113.0 110.0 108.0 103.0 111.0 110.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:145.00 stddev:25.32 (17.5%) stddev-sans-first:26.85 03:53:58 INFO - PID 11704 | Values: 144.0 118.0 140.0 185.0 127.0 146.0 155.0 118.0 185.0 119.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:3.16 (1.9%) stddev-sans-first:3.24 03:53:58 INFO - PID 11704 | Values: 163.0 163.0 170.0 162.0 170.0 166.0 166.0 162.0 168.0 163.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#3] audio-fft Cycles:10 Average:94.20 Median:77.50 stddev:35.35 (45.6%) stddev-sans-first:36.87 03:53:58 INFO - PID 11704 | Values: 76.0 78.0 78.0 166.0 82.0 76.0 79.0 74.0 156.0 77.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.00 stddev:24.56 (31.1%) stddev-sans-first:25.69 03:53:58 INFO - PID 11704 | Values: 85.0 88.0 131.0 78.0 79.0 79.0 132.0 83.0 79.0 133.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.00 stddev:2.71 (2.3%) stddev-sans-first:2.83 03:53:58 INFO - PID 11704 | Values: 117.0 119.0 113.0 113.0 114.0 121.0 115.0 117.0 114.0 114.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:1.49 (1.0%) stddev-sans-first:1.22 03:53:58 INFO - PID 11704 | Values: 154.0 150.0 153.0 152.0 151.0 151.0 152.0 149.0 151.0 150.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:94.00 stddev:2.99 (3.2%) stddev-sans-first:3.03 03:53:58 INFO - PID 11704 | Values: 94.0 94.0 99.0 101.0 98.0 94.0 96.0 94.0 94.0 101.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:2.81 (5.1%) stddev-sans-first:2.96 03:53:58 INFO - PID 11704 | Values: 55.0 54.0 60.0 61.0 58.0 54.0 53.0 54.0 54.0 56.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:2.33 (4.2%) stddev-sans-first:2.00 03:53:58 INFO - PID 11704 | Values: 60.0 60.0 53.0 55.0 55.0 54.0 55.0 56.0 57.0 56.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.00 stddev:5.51 (7.0%) stddev-sans-first:5.83 03:53:58 INFO - PID 11704 | Values: 80.0 79.0 78.0 79.0 78.0 79.0 78.0 90.0 93.0 78.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:138.00 stddev:16.14 (11.7%) stddev-sans-first:17.11 03:53:58 INFO - PID 11704 | Values: 140.0 130.0 142.0 142.0 136.0 126.0 136.0 127.0 131.0 182.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:183.50 stddev:8.40 (4.6%) stddev-sans-first:7.93 03:53:58 INFO - PID 11704 | Values: 171.0 176.0 196.0 194.0 184.0 183.0 175.0 186.0 174.0 180.0 03:53:58 INFO - PID 11704 | 03:53:58 INFO - PID 11704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.50 stddev:4.03 (5.6%) stddev-sans-first:4.15 03:53:58 INFO - PID 11704 | Values: 74.0 68.0 67.0 67.0 71.0 69.0 69.0 79.0 74.0 75.0 03:53:58 INFO - PID 11704 | -------- Summary: end -------- 03:53:58 INFO - PID 11704 | 03:53:59 INFO - PID 11704 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:53:59 INFO - TEST-INFO | 11704: exit 0 03:53:59 INFO - TEST-OK | kraken | took 63189ms 03:53:59 INFO - SUITE-END | took 1176s 03:53:59 INFO - Completed test suite (00:19:36) 03:53:59 INFO - javascript benchmark 03:53:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8531.661756439145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.0256969054744, 3113.891013814517, 3126.155937896768, 3131.279805644702, 3179.968200317996, 6192.164057852195, 6205.596636218643, 6290.339514350996, 6315.021171718386, 6363.586366886161, 6281.246250449941, 6343.333949935248, 6355.713992870332, 6359.014352775327, 6363.236411630599, 5698.373178950312, 5751.971240143794, 5819.563532735041, 5848.444397782225, 5882.911756323659, 5677.744501497443, 5723.4848863602265, 5761.078227483604, 5767.019606666877, 5878.0, 5637.633553819009, 5690.9146362804595, 5699.487046165844, 5702.714864256771, 5738.512226460756, 5687.203791469197, 5755.251817263729, 5788.797392091299, 5799.971000145015, 5818.0400233961345, 5671.602987790856, 5695.943040569624, 5771.336296325934, 5772.451617096369, 5772.653640781525, 6179.66011869347, 6180.907286390708, 6218.689065546704, 6288.62268263901, 6309.432151106376, 6589.505787065989, 6656.7670131545165, 6663.63350015749, 6679.565828221199, 6697.93302066978, 6759.188897332302, 6843.520953533254, 6849.897251541231, 6854.280300568418, 6883.8967415488805, 6189.876202475925, 6271.372862713738, 6332.588381755171, 6358.364163583605, 6379.681015949184, 6783.626900520519, 6821.420179284816, 6899.57506588224, 6900.2409734929115, 7008.369246767816, 6502.674866256668, 6505.0892874997535, 6517.967410162919, 6522.34776522344, 6543.083968244449, 6472.514561407819, 6674.032265321598, 6675.065490831287, 6684.963830606263, 6688.929771236579, 6517.771877984248, 6522.934770652233, 6541.836454088686, 6631.27056023837, 6641.369069938445, 6560.278369379364, 6681.465482761368, 6693.698783554752, 6699.832504187337, 6708.563943343667, 5332.306800116037, 5333.519983201453, 5351.036813373552, 5361.329833770778, 5363.892722145535, 4555.2711566149255, 4598.632109431237, 4598.954010459853, 4619.099275641218, 4620.976895115503, 5829.47534721877, 5841.357450680422, 5843.444872737083, 5847.883042339129, 5855.473007429352, 6749.898751518731, 6800.31996800316, 6809.557378770364, 6821.761238356634, 6823.624700641413, 5760.798372056958, 5766.135079737989, 5850.23946886902, 5852.736626851717, 5876.6180198286975, 5727.255456790674, 5795.1886735857015, 5855.473007429352, 5877.617954832922, 5934.643921364732, 6487.124238227873, 6564.0, 6566.80299591013, 6576.704048317837, 6587.80236592903, 6607.108040414482, 6667.799966001027, 6763.7632682855865, 6798.456123510206, 6802.081718967876, 6387.968060159669, 6478.352164783484, 6515.6742162892615, 6516.250631177475, 6622.139121914313, 6614.206295244601, 6617.470602351704, 6617.7683781067435, 6620.205575330991, 6644.302348253557, 6764.830879228059, 6766.391024807791, 6782.457403407814, 6782.864342713019, 6788.185417749902, 6387.712552935036, 6520.119783829123, 6530.249021362604, 6536.182977127859, 6547.770828020996, 6244.375562443901, 6545.0, 6611.206655201407, 6614.801555953329, 6629.204495460575, 6454.0, 6465.709043092978, 6544.083828263952, 6544.901826472512, 6555.836104097436, 6519.565163312671, 6559.376859198559, 6593.868122637425, 6633.469322454095, 6679.499037572299, 6287.937120628735, 6377.330380310001, 6407.199100112486, 6434.613923164625, 6450.741970321323], "value": 6119.1528859690225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.9710910118147, 827.871679889617, 850.1880703927748, 868.3053557154275, 877.4252864373835, 40882.0, 41490.585094149086, 41761.373579396335, 41943.0, 41976.37035444463, 37513.8124309378, 37619.43570846439, 37692.43461348082, 37903.24193516135, 37959.4306085409, 6846.246912839583, 6979.162500499921, 6979.581225126483, 6983.89524157138, 6989.82525436863, 6913.619750913697, 7034.929650703479, 7035.718571257169, 7036.226015138331, 7039.190493093283, 6999.335063168991, 7785.0, 7988.320992715626, 7993.920060799404, 7997.240262175084, 7855.842883142333, 7922.524648521078, 7926.405519585996, 7930.682772689085, 7930.841383172333, 7551.622418879089, 7612.657430415645, 7769.067711874554, 7778.377729781604, 7788.6884524618945, 39033.609663903284, 39321.60678393208, 39351.606483935364, 39354.212915741526, 39463.408048879006, 3517.736169787276, 3601.6398360164035, 3604.0, 3622.5834029086727, 3624.039629498185, 31449.685503144905, 31482.0, 31557.21106972321, 31596.684033159603, 31700.682993170005, 5039.21892106724, 5066.442691303953, 5098.923516147261, 5132.9743351283005, 5182.041322355376, 211577.0, 215076.0, 215700.0, 216939.0, 217335.0, 47780.0, 47874.28188577174, 48154.0, 48576.0, 48794.512054879706, 51874.740626296625, 51881.0, 52041.47958520442, 52101.47898521042, 52226.73886630542, 14253.643658908402, 14413.567592972227, 14418.279086045655, 14461.49384771528, 14505.927470362582, 11141.665750027512, 11192.10463162945, 11203.495842686936, 11209.327440353605, 11214.663560093048, 13942.790858137136, 14076.0, 14139.434422623186, 14150.85849141516, 14251.0, 5488.506034456918, 5533.6403133796175, 5537.861553461115, 5634.408387119293, 5729.9713501432225, 1010.1262408017159, 1010.4998025977188, 1012.1245122968579, 1014.2595904989251, 1034.0486752188006, 23120.42198945006, 23164.420889477562, 23225.419364516023, 23349.0, 23478.882605586863, 1112.293693504614, 1112.3492756737398, 1117.234694234452, 1121.2879821313525, 1124.3141683573015, 12094.576689815814, 12166.209196402206, 12381.690457738629, 12425.0, 12512.624621261195, 228595.0, 230232.0, 230731.0, 232394.0, 232823.0, 54073.72963135238, 54431.72784136054, 54843.17735233975, 58508.70745646244, 58702.412975869694, 1487.501686934889, 1511.7430036893754, 1514.0, 1515.9545213643607, 1534.0948840184121, 26678.0, 26762.598561021212, 27006.0, 27124.593131103444, 27263.86368068147, 37807.24385512219, 37813.62186378101, 38164.809175953946, 38293.4255986166, 38308.61691383162, 205272.0, 205381.0, 205402.0, 206441.0, 206529.0, 33668.46481119447, 35665.82167089148, 35805.1048723784, 36061.81969090138, 36167.457488137174, 43575.56424435715, 43771.34342984794, 43786.56213437825, 47124.764376177896, 47284.0, 33506.66493335035, 33575.66424335823, 34103.0, 34169.0, 34426.0, 33939.0, 34103.658963410046, 34237.82881085579, 34429.13927151741, 34650.48024279587, 36451.45322820213, 37639.0, 37776.62223377731, 37799.0, 37809.432858507695, 32296.83851580727, 33359.666403336625, 33495.83252083724, 33555.66444335526, 33724.831375842965, 23897.40256493532, 24567.877160614084, 24718.629220562067, 25030.749692502843, 25050.0], "value": 17301.783389243024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.501818327139, 572.2932178759235, 580.1732531143122, 586.3374386942754, 591.65979561752, 22233.777662223372, 22399.664005039896, 23080.76919230807, 23125.884370578166, 23130.30609081726, 26541.734582654168, 27115.593266101023, 27120.45759084817, 27139.86430067847, 27162.45675086502, 6695.832604184898, 6821.965890170567, 6856.382925536701, 6858.245592984767, 6859.759908403207, 4100.343944968806, 5847.427132061879, 6662.700178491979, 6722.899156512656, 6755.932440675604, 4076.082881351702, 4093.385992101179, 4095.8361665533344, 6618.768343107992, 6643.701033453482, 6625.337466253384, 6632.403083722488, 6641.966790166019, 6651.866962660744, 6659.234188068362, 6108.419700128481, 6141.938580614182, 6152.6308421494405, 6159.414855588712, 6180.258368995749, 28975.42049159026, 29681.0, 29926.70073299261, 30313.848430757927, 30362.84818575915, 1948.298612499499, 1973.7434133562545, 1974.1609815828358, 1976.5256338478805, 1978.4262563856464, 19481.610367792706, 20076.799232007637, 20084.297049603192, 20101.296454624164, 20115.698264525898, 2335.7781010804115, 2370.893309801063, 2377.453185767266, 2403.327068420845, 2438.573249681299, 127205.0, 130080.0, 130097.99999999905, 130520.99999999905, 130882.0, 14411.711765764836, 15057.0, 15115.825676607816, 15119.924400377928, 15743.370265189264, 23745.7625423747, 23768.88115559411, 23832.285031449082, 23886.761132388452, 23923.16268930579, 9977.950110249401, 10000.299979001546, 10072.244581656405, 10080.94150114242, 10158.288919775545, 7609.733659322008, 9271.721848344561, 9359.29805264608, 9421.90578094224, 9475.810483790285, 8033.477823941425, 8807.251383632463, 8852.557372131369, 8921.330900182513, 8954.417962832395, 2563.1925943328165, 2570.8200425970376, 2657.521646103681, 2705.8612010068227, 2732.330579008116, 929.6839074714629, 954.9761255968656, 959.3955807841015, 971.562796741455, 981.5582987655441, 19142.521436964187, 19775.847072114728, 19843.40469785909, 19845.900770496057, 19920.402387928385, 1007.5717819926502, 1032.5766435761452, 1039.859618951447, 1042.3485321673954, 1052.3948729480426, 10721.249512534203, 10730.624428144978, 10961.177911656658, 11081.168912331446, 11319.37743424103, 542785.0, 546307.0, 549572.0, 554337.0, 563380.0, 111400.4429977845, 113850.0, 116060.41969790266, 121864.39067804781, 121932.0, 1252.5741247975732, 1252.8559215690311, 1274.420138836827, 1286.9034822388546, 1296.4749276543016, 21003.159873604884, 21166.7883321171, 21315.0, 21436.249731259955, 21478.24826131078, 54750.0, 54862.45137548573, 55121.0, 55268.0, 56018.0, 66840.6657966707, 67216.327836721, 67535.0, 68399.31600683929, 69129.0, 14354.138751674933, 14866.776998345249, 14872.479463218735, 14898.627534311729, 14974.775378369552, 23065.308040758806, 23195.88402057979, 23743.168989085298, 23782.405439864142, 23905.64141537913, 18287.359942401952, 18724.438266852016, 19391.612167756848, 19491.610167796847, 19519.219231230592, 17430.738538921672, 17495.912520437316, 17763.73354399711, 17766.91116544409, 17988.370407036215, 18874.811251887855, 19654.0, 19754.70367944511, 19909.502262443555, 20160.0, 14770.77843832322, 15143.924280378527, 15160.848391515943, 15268.312925918583, 15280.312385942882, 18822.0, 18888.15003324881, 18914.0, 18981.0, 18984.620307593494], "value": 12028.784236307241, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.4344975110455, 1413.2368520998662, 1417.7164567086586, 1423.0323380101527, 1426.2868565717142, 13692.794608080874, 14024.018318717694, 14232.0, 14241.28793560323, 14288.714225715492, 14651.194184319886, 14877.92561037196, 14878.55364339069, 14897.329620167091, 14911.254437278147, 2594.403287243935, 2651.191386627078, 2657.8936842526373, 2657.9202623921315, 2660.8669566521694, 2334.4047267946735, 2394.5330660521117, 2406.109739396417, 2732.4671689020647, 2827.377976845101, 2741.7806575474015, 2755.8484283364405, 2756.503829310723, 2759.296379423254, 2759.323965628424, 2629.3163777417817, 2673.17131689177, 2759.7930155238337, 2763.875625596833, 2768.958465622997, 2571.434284457416, 2621.082621082625, 2630.3818602628367, 2637.26156676131, 2650.655414796064, 13653.180809151483, 13968.860311396958, 13976.440942362293, 13978.720425591533, 13990.510332138429, 7168.713251469935, 7411.88882166768, 7420.814479637998, 7423.628818559105, 7426.997355357012, 4688.953110468886, 4930.186519224324, 5025.643076369396, 5039.647224694273, 5053.9241911371355, 1802.927882884683, 1809.8009218986033, 1825.972610410845, 1851.1022154255174, 1864.2449807827852, 23207.0, 23519.294421167393, 23537.529249415085, 23580.7641923582, 23588.764112359, 6160.969195153995, 6245.219347581552, 6296.181496405529, 6446.3553644636095, 6475.838104047342, 16030.835837161834, 16051.117188554508, 16181.919090404472, 16203.83796162047, 16218.432354867524, 7305.671244793997, 7485.026946496921, 7490.588017658972, 7512.6243687815395, 7517.511361761468, 6831.248562658104, 6964.477664175207, 7042.225355210922, 7047.224805271416, 7107.253738357502, 4445.244308467503, 4595.793189306489, 5033.1695270280725, 5046.949530504721, 5106.387233532, 1413.971720565583, 1427.4290283886528, 1434.1323499282992, 1441.128117488904, 1448.1238850495508, 895.4716717136921, 908.9500077495801, 913.3195769152024, 919.7470695558775, 926.402470406584, 8305.169483051768, 8326.417150799507, 8330.916690833135, 8368.874466883002, 8396.748097557083, 980.2745967983641, 1010.5604062232952, 1014.3356101753363, 1021.1320377678913, 1033.679559336608, 4465.709728867613, 4646.907061858744, 4678.976605116953, 4964.553190212898, 5169.896602068013, 17956.371526996492, 18445.5388615283, 18458.630827383644, 18510.16704248312, 18525.166367513495, 18436.262549498137, 19132.713009304873, 19559.511012224524, 19571.804281956996, 19620.313289034817, 10992.505337259843, 11027.669169924915, 11172.273802202832, 11174.217804753589, 11193.27243729155, 7796.61016949139, 7902.525848449111, 7927.365810735243, 8106.716264930699, 8147.226013528705, 16687.165641717624, 16804.915975420045, 17066.48800535986, 17089.829101708823, 17091.145442727564, 17249.0, 17326.480205593853, 17533.736993945357, 17645.382411616047, 18006.72989905126, 10655.467226638792, 11443.713907152054, 11773.823392649289, 11781.587644432404, 11787.057035436974, 11767.823482647596, 12076.698082548006, 12416.317102559085, 13284.136531125447, 13526.18842869431, 10665.8933410668, 10797.56809727602, 10828.5127169276, 10861.78276434451, 11109.11127109813, 10627.309224900357, 10660.360378377321, 10836.67489975302, 10960.890391095987, 11055.281406708538, 9079.409838360485, 9231.630734770533, 9247.86128208064, 9249.352545321763, 9254.213391861767, 6610.966945165435, 6639.6680165992475, 6656.0, 6769.627670478171, 6783.253842077269, 7320.267973202637, 7327.0, 7368.852622947618, 7417.517861338995, 7455.9627201865815], "value": 6359.427997273103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.32139094309093, 513.8869448721284, 527.3223907279147, 537.3685919045123, 539.892021595681, 6231.470325022378, 6246.187995560576, 6261.40516650918, 6264.937350626492, 6279.654618995954, 6150.969245153768, 6163.784267550625, 6166.533386645344, 6170.722317495713, 6212.285587157478, 5144.922826157611, 5157.922631160535, 5160.0, 5160.432352441228, 5169.844904652867, 4848.563629273364, 4990.800367985276, 5090.567301779353, 5097.949020509803, 5131.923021154686, 4932.0, 4946.0107978404285, 4960.280759289901, 4963.60291176705, 5021.9912035186035, 4866.78099485524, 4948.802047918097, 4958.281049247857, 4966.602671786249, 4998.925016124761, 4442.955570444286, 4455.910881782379, 4477.238869392211, 4491.25894227452, 4503.707259028152, 6092.512598992114, 6108.755649774003, 6124.724387402578, 6133.478654314388, 6146.84632884177, 5574.721263936787, 5638.661680299154, 5691.26013618227, 5767.0, 5768.971155144198, 6342.048692696087, 6487.481001519867, 6517.93482065178, 6530.6408147551865, 6536.705848236841, 4854.514548545152, 4872.147374209535, 4876.414830220361, 4892.3884514435695, 4957.859692270762, 6643.0, 6643.900341494881, 6657.46740260778, 6896.862062758717, 7014.5440546364325, 4859.975700121477, 4952.083864485082, 4956.207006878882, 4978.10394129053, 4984.134122879286, 5007.39911210657, 5036.84889453317, 5059.595232381401, 5087.3974697970025, 5101.2603172539775, 5642.181883626933, 5734.369219385864, 5748.511376532958, 5759.308882934075, 5767.596268261182, 6579.868402631921, 6630.049627915628, 6634.734610615618, 6688.565243259172, 6705.865882682417, 1734.8698847586481, 1754.3859649122705, 1776.262850916855, 1793.9103044847704, 1800.4778614201996, 1198.9280643161437, 1251.3367915005063, 1258.0941721960173, 1266.5187228852976, 1269.339943229534, 5690.9146362804595, 5697.259356283656, 5703.971480142573, 5781.682007489544, 5819.359870414251, 6686.1642294713165, 6694.230163531159, 6714.3957043866285, 6715.865682686319, 6739.797806065826, 5711.400302968212, 5711.685857277889, 5737.3975732548315, 5767.826965191051, 5778.017736984722, 3576.195356044869, 3593.299306635181, 3595.1371670799344, 3637.618050104701, 3648.562172539312, 6445.871082578322, 6484.157059582224, 6502.60984340941, 6504.219493660791, 6530.575512591667, 6479.125318082093, 6813.148356455443, 6854.760083397157, 6882.449404047664, 6937.618430986243, 6320.38830098322, 6404.807855764335, 6495.025746138117, 6517.9348206517325, 6554.050677195281, 6621.112982799879, 6706.960421134732, 6722.495812814156, 6739.865202696017, 6776.966115169393, 6621.0467911965125, 6621.27166011748, 6625.436837868835, 6730.932690673227, 6731.283522701679, 6429.22849258092, 6464.385883341075, 6498.252700939453, 6520.359254501935, 6570.47436205112, 5032.169692000925, 5034.0, 5052.216906379517, 5069.264956581349, 5094.541491265803, 6493.8701225976165, 6540.215174179129, 6737.124173857367, 6828.931710682829, 6868.828279293058, 6344.9048264277, 6352.809415717536, 6385.553011289351, 6455.741770329134, 6517.73929042852, 6433.324500927522, 6465.515086368447, 6496.317886621837, 6530.640814755234, 6532.778855189068, 6291.276503202007, 6389.393007664265, 6404.0, 6445.452136568444, 6455.838604034937, 6455.515836312389, 6542.247641521286, 6587.374199451045, 6610.9669451652435, 6650.401463868275, 6263.436290733674, 6266.83524819963, 6355.1420558224045, 6423.907935651044, 6452.387023232785], "value": 5062.346843189363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.7422460374189, 886.0740526150172, 906.7687739626394, 913.8172365526895, 914.1498406481974, 17592.120393980298, 18632.906835465838, 18652.720209196872, 18711.438656840317, 18714.15786289615, 16991.0, 19167.712484312713, 22010.559788804254, 22139.889300553514, 22238.777612223872, 1043.3374806997554, 1063.7234319077018, 1069.5080263078994, 1070.293606219895, 1072.222638587026, 1011.5852500474807, 1042.2183362478142, 1047.4029803012286, 1048.0462778871229, 1052.8578641883362, 1088.678839742278, 1109.2900543652029, 1109.983350249747, 1113.7104352868273, 1115.2082021764556, 1099.8295264234016, 1100.1363929315448, 1101.1686176936403, 1104.6575561575937, 1105.0496572947259, 809.1301850510724, 812.1472453923416, 812.3176531713389, 812.3257696112272, 816.5304949653913, 18644.62710745791, 18681.34615288472, 19117.426477205707, 19239.0, 19338.709919351222, 21844.563108737737, 22046.669299960515, 22053.33839984803, 22489.0, 22605.0, 15517.534473965687, 15762.921185394, 15786.131762753044, 15934.28295726695, 16076.356945722157, 3585.103724068983, 3606.6934310583633, 3612.295602357541, 3614.963850361489, 3627.546556680415, 123353.0, 128140.35929820291, 128440.35779821042, 129084.0, 130867.0, 16338.18309084541, 16880.0, 16992.57518562046, 17012.319507219574, 17103.57241068983, 30493.23766905845, 30585.84707076495, 31083.0, 31128.84435577853, 31288.843555782074, 8502.0, 8514.957425212959, 8524.701635442854, 8560.871586926201, 8599.710043493526, 3994.46074779901, 4205.074883525619, 4258.063226090255, 4262.786860656955, 4272.230998420252, 5202.869928251824, 5360.973195134077, 5381.1121165007335, 5402.51377376038, 5407.107827208545, 1054.7626783973699, 1055.8521806947033, 1070.662741236508, 1100.4717735486852, 1141.1612464838338, 693.5180049865396, 708.7483943200193, 709.6380845768695, 718.9317014883683, 731.4916133287314, 12101.69745756363, 12211.26732396059, 12874.0, 13392.933035334761, 13918.30408479572, 691.6541729135432, 708.1290013283588, 714.4320265388924, 717.8061923280685, 719.3418022509345, 5531.059719847635, 5531.308586426697, 5538.47384498472, 6131.908021379683, 6333.050042493663, 97849.021509784, 101143.0, 101220.49389753005, 102216.0, 103790.0, 94571.52714236523, 94727.52636236775, 96789.0, 97433.51283243539, 99211.50394247983, 80029.59985200036, 81177.0, 81905.18094819094, 82130.0, 86545.0, 12453.626391208278, 12856.357182141042, 13075.476980920657, 13172.341382931007, 13198.20810751358, 40856.79571602123, 41526.584734152275, 41606.1678766429, 43298.0, 43507.56492435035, 71357.0, 73328.0, 77122.0, 77625.0, 79340.0, 17971.730424043388, 19015.71476427827, 20245.59508809845, 20296.79703202949, 20366.490837729176, 21892.0, 22356.441088972904, 22457.550848983257, 22484.213052543084, 22687.20594779241, 18545.745105873277, 18787.624247515247, 19509.219631214593, 19859.404217873485, 20328.186872525526, 20505.89747051255, 20726.0, 20751.0, 20781.48046298794, 20987.055582499128, 19078.61842763165, 19785.40643780689, 19924.60150796947, 20027.599448010667, 20046.198152073754, 12677.366131693194, 13505.39225734864, 14106.647333816736, 14370.49703260381, 14776.778348324999, 14178.0, 14263.572092837232, 14324.928375358057, 14339.784903226251, 14402.927985360006], "value": 9405.912011203385, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 111.0, 101.0, 108.0, 113.0, 110.0, 108.0, 103.0, 111.0, 110.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 140.0, 185.0, 127.0, 146.0, 155.0, 118.0, 185.0, 119.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 170.0, 162.0, 170.0, 166.0, 166.0, 162.0, 168.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 166.0, 82.0, 76.0, 79.0, 74.0, 156.0, 77.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 131.0, 78.0, 79.0, 79.0, 132.0, 83.0, 79.0, 133.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 113.0, 113.0, 114.0, 121.0, 115.0, 117.0, 114.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 153.0, 152.0, 151.0, 151.0, 152.0, 149.0, 151.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 101.0, 98.0, 94.0, 96.0, 94.0, 94.0, 101.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 60.0, 61.0, 58.0, 54.0, 53.0, 54.0, 54.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 53.0, 55.0, 55.0, 54.0, 55.0, 56.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 78.0, 79.0, 78.0, 90.0, 93.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 142.0, 142.0, 136.0, 126.0, 136.0, 127.0, 131.0, 182.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 196.0, 194.0, 184.0, 183.0, 175.0, 186.0, 174.0, 180.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 67.0, 67.0, 71.0, 69.0, 69.0, 79.0, 74.0, 75.0], "value": 71.3, "unit": "score"}]}]} 03:54:00 INFO - Return code: 0 03:54:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:00 INFO - # TBPL SUCCESS # 03:54:00 INFO - Running post-action listener: _package_coverage_data 03:54:00 INFO - Running post-action listener: _resource_record_post_action 03:54:00 INFO - [mozharness: 2017-08-09 10:54:00.073556Z] Finished run-tests step (success) 03:54:00 INFO - Running post-run listener: _resource_record_post_run 03:54:00 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432799744; Read time: 12; Write time: 348940 03:54:00 INFO - TinderboxPrint: CPU usage
13.2% 03:54:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:54:00 INFO - TinderboxPrint: I/O write bytes / time
432,799,744 / 348,940 03:54:00 INFO - TinderboxPrint: CPU idle
8,271.6 (86.8%) 03:54:00 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 03:54:00 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107462656; Read time: 0; Write time: 117576 03:54:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:54:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 325337088; Read time: 0; Write time: 231364 03:54:00 INFO - Running post-run listener: _upload_blobber_files 03:54:00 INFO - Blob upload gear active. 03:54:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:54:01 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:01 INFO - (blobuploader) - INFO - Done attempting. 03:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:03 INFO - (blobuploader) - INFO - Done attempting. 03:54:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:09 INFO - (blobuploader) - INFO - Done attempting. 03:54:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:54:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:54:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:10 INFO - (blobuploader) - INFO - Done attempting. 03:54:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:10 INFO - Return code: 0 03:54:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be4d27667ba6e1b2be4f81feab467e1be08a414984ab3900db13c8ec38fcbc82933f44a7876dbc6ffcae7a5e11bb3985577c529bdc3d46c98f90d8013bbfc92c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95bb0e0a3c13416f181b2b64f6966771278c13b1e3ecd5aac113002b19c499be9cc36b86173dbec91b91d636e6ecdf5f079680bbbd71269d938f88f4b1094a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51f934b737336f42ea5bce9e45545c4737f1a96a40d981af77e800a18221596c58e69cd8debce4c1bd67d45f40b3de94d94ddc867c4ffa9301117bf4e1144a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a25435e28f7dd5d5d7b57747a843e79ebd17d680043880a1def86ec0697a763ee16c8ab79b8c32d744455dc92a073f15d2d9f86f35ace916f8bee91ee8550558"} 03:54:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:10 INFO - Contents: 03:54:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be4d27667ba6e1b2be4f81feab467e1be08a414984ab3900db13c8ec38fcbc82933f44a7876dbc6ffcae7a5e11bb3985577c529bdc3d46c98f90d8013bbfc92c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95bb0e0a3c13416f181b2b64f6966771278c13b1e3ecd5aac113002b19c499be9cc36b86173dbec91b91d636e6ecdf5f079680bbbd71269d938f88f4b1094a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51f934b737336f42ea5bce9e45545c4737f1a96a40d981af77e800a18221596c58e69cd8debce4c1bd67d45f40b3de94d94ddc867c4ffa9301117bf4e1144a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a25435e28f7dd5d5d7b57747a843e79ebd17d680043880a1def86ec0697a763ee16c8ab79b8c32d744455dc92a073f15d2d9f86f35ace916f8bee91ee8550558"} 03:54:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:10 INFO - Copying logs to upload dir... 03:54:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.814455 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-09 03:54:10.867028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:10.870378) ========= 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=d2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952 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/be4d27667ba6e1b2be4f81feab467e1be08a414984ab3900db13c8ec38fcbc82933f44a7876dbc6ffcae7a5e11bb3985577c529bdc3d46c98f90d8013bbfc92c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95bb0e0a3c13416f181b2b64f6966771278c13b1e3ecd5aac113002b19c499be9cc36b86173dbec91b91d636e6ecdf5f079680bbbd71269d938f88f4b1094a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51f934b737336f42ea5bce9e45545c4737f1a96a40d981af77e800a18221596c58e69cd8debce4c1bd67d45f40b3de94d94ddc867c4ffa9301117bf4e1144a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a25435e28f7dd5d5d7b57747a843e79ebd17d680043880a1def86ec0697a763ee16c8ab79b8c32d744455dc92a073f15d2d9f86f35ace916f8bee91ee8550558"} build_url:https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be4d27667ba6e1b2be4f81feab467e1be08a414984ab3900db13c8ec38fcbc82933f44a7876dbc6ffcae7a5e11bb3985577c529bdc3d46c98f90d8013bbfc92c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95bb0e0a3c13416f181b2b64f6966771278c13b1e3ecd5aac113002b19c499be9cc36b86173dbec91b91d636e6ecdf5f079680bbbd71269d938f88f4b1094a8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e51f934b737336f42ea5bce9e45545c4737f1a96a40d981af77e800a18221596c58e69cd8debce4c1bd67d45f40b3de94d94ddc867c4ffa9301117bf4e1144a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a25435e28f7dd5d5d7b57747a843e79ebd17d680043880a1def86ec0697a763ee16c8ab79b8c32d744455dc92a073f15d2d9f86f35ace916f8bee91ee8550558"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:10.894976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:10.895278) ========= 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=d2a8c569965ab8367867b893000001a1-1502269254.9370-1988445952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:10.978944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 03:54:10.979268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 03:54:10.979545) ========= ========= Total master_lag: 0.18 =========