builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1502274810.89 results: success (0) revision: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:30.893766) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:30.906304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:30.912830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:30.986872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:30.987194) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 03:33:31-- 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% 83.9M=0s 2017-08-09 03:33:31 (83.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.268460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:31.277920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:31.278324) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015127 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:31.332128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:31.335579) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 03:33:31,937 truncating revision to first 12 chars 2017-08-09 03:33:31,937 Setting DEBUG logging. 2017-08-09 03:33:31,937 attempt 1/10 2017-08-09 03:33:31,937 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:32,239 unpacking tar archive at: mozilla-central-4c5fbf493763/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:32.021101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:32.021432) ========= script_repo_revision: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:32.021869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:32.022133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 03:33:32.032170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-09 03:33:32.032561) ========= /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=9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:32 INFO - MultiFileLogger online at 20170809 03:33:32 in /builds/slave/test 03:33:32 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:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:32 INFO - {'append_to_log': False, 03:33:32 INFO - 'base_work_dir': '/builds/slave/test', 03:33:32 INFO - 'blob_upload_branch': 'Firefox', 03:33:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:32 INFO - 'branch': 'Firefox', 03:33:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:32 INFO - 'code_coverage': False, 03:33:32 INFO - 'config_files': ('talos/linux_config.py',), 03:33:32 INFO - 'default_actions': ('clobber', 03:33:32 INFO - 'read-buildbot-config', 03:33:32 INFO - 'download-and-extract', 03:33:32 INFO - 'populate-webroot', 03:33:32 INFO - 'create-virtualenv', 03:33:32 INFO - 'install', 03:33:32 INFO - 'setup-mitmproxy', 03:33:32 INFO - 'run-tests'), 03:33:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:32 INFO - 'disable_ccov_upload': False, 03:33:32 INFO - 'download_minidump_stackwalk': True, 03:33:32 INFO - 'download_symbols': 'ondemand', 03:33:32 INFO - 'enable_stylo': False, 03:33:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:32 INFO - 'gecko_profile': False, 03:33:32 INFO - 'gecko_profile_interval': 0, 03:33:32 INFO - 'installer_path': 'installer.exe', 03:33:32 INFO - 'log_level': 'info', 03:33:32 INFO - 'log_name': 'talos', 03:33:32 INFO - 'log_to_console': True, 03:33:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:32 INFO - 'opt_config_files': (), 03:33:32 INFO - 'pip_index': False, 03:33:32 INFO - 'suite': 'dromaeojs-e10s', 03:33:32 INFO - 'system_bits': '32', 03:33:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:32 INFO - 'title': 'talos-linux64-ix-088', 03:33:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:32 INFO - 'use_talos_json': True, 03:33:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:32 INFO - 'work_dir': 'build'} 03:33:32 INFO - [mozharness: 2017-08-09 10:33:32.738211Z] Running clobber step. 03:33:32 INFO - Running pre-action listener: _resource_record_pre_action 03:33:32 INFO - Running main action method: clobber 03:33:32 INFO - rmtree: /builds/slave/test/build 03:33:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:34 INFO - Running post-action listener: _resource_record_post_action 03:33:34 INFO - [mozharness: 2017-08-09 10:33:34.277103Z] Finished clobber step (success) 03:33:34 INFO - [mozharness: 2017-08-09 10:33:34.277205Z] Running read-buildbot-config step. 03:33:34 INFO - Running pre-action listener: _resource_record_pre_action 03:33:34 INFO - Running main action method: read_buildbot_config 03:33:34 INFO - Using buildbot properties: 03:33:34 INFO - { 03:33:34 INFO - "project": "", 03:33:34 INFO - "product": "firefox", 03:33:34 INFO - "who": "cbook@mozilla.com", 03:33:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:33:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:33:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:33:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:33:34 INFO - "stage_platform": "linux64-stylo", 03:33:34 INFO - "basedir": "/builds/slave/test", 03:33:34 INFO - "buildnumber": 71, 03:33:34 INFO - "platform": "ubuntu64_hw_stylo", 03:33:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:34 INFO - "slavebuilddir": "test", 03:33:34 INFO - "taskId": "d_DaF9-0S2a7BP6MIW8L5w", 03:33:34 INFO - "branch": "mozilla-central", 03:33:34 INFO - "script_repo_revision": "production", 03:33:34 INFO - "revision": "4c5fbf49376351679dcc49f4cff26c3c2e055ccc", 03:33:34 INFO - "slavename": "talos-linux64-ix-088", 03:33:34 INFO - "repo_path": "mozilla-central" 03:33:34 INFO - } 03:33:34 INFO - Finding installer, test and symbols from parent task. 03:33:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_DaF9-0S2a7BP6MIW8L5w'}, attempt #1 03:33:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_DaF9-0S2a7BP6MIW8L5w'}, attempt #1 03:33:35 INFO - Task dependencies: dDqfdbhSQbS4bo4eXSd8Dg 03:33:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg'}, attempt #1 03:33:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:33:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.test_packages.json 03:33:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.crashreporter-symbols.zip 03:33:35 INFO - Running post-action listener: _resource_record_post_action 03:33:35 INFO - [mozharness: 2017-08-09 10:33:35.771762Z] Finished read-buildbot-config step (success) 03:33:35 INFO - [mozharness: 2017-08-09 10:33:35.771983Z] Running download-and-extract step. 03:33:35 INFO - Running pre-action listener: _resource_record_pre_action 03:33:35 INFO - Running main action method: download_and_extract 03:33:35 INFO - mkdir: /builds/slave/test/build/tests 03:33:35 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:35 INFO - trying https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.test_packages.json 03:33:35 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:35 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:36 INFO - Downloaded 989 bytes. 03:33:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:33:36 INFO - Using the following test package requirements: 03:33:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:33:36 INFO - u'common': [u'target.common.tests.zip'], 03:33:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:33:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:33:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:33:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:33:36 INFO - u'mozbase': [u'target.common.tests.zip'], 03:33:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:33:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:33:36 INFO - u'web-platform': [u'target.common.tests.zip', 03:33:36 INFO - u'target.web-platform.tests.tar.gz'], 03:33:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:33:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:33:36 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:36 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:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip into memory 03:33:37 INFO - Content-Length response header: 54285614 03:33:37 INFO - Bytes received: 54285614 03:33:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:33:48 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:48 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:48 INFO - Fetch https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.common.tests.zip into memory 03:33:52 INFO - Content-Length response header: 54285614 03:33:52 INFO - Bytes received: 54285614 03:34:04 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:34:04 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:34:04 INFO - Fetch https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.talos.tests.zip into memory 03:34:05 INFO - Content-Length response header: 14496008 03:34:05 INFO - Bytes received: 14496008 03:34:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:05 INFO - trying https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:34:05 INFO - Downloading https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:34:05 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:34:06 INFO - Downloaded 61995509 bytes. 03:34:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:34:06 INFO - mkdir: /builds/slave/test/properties 03:34:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:06 INFO - Contents: 03:34:06 INFO - build_url:https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 03:34:06 INFO - Running post-action listener: _resource_record_post_action 03:34:06 INFO - Running post-action listener: set_extra_try_arguments 03:34:06 INFO - [mozharness: 2017-08-09 10:34:06.578195Z] Finished download-and-extract step (success) 03:34:06 INFO - [mozharness: 2017-08-09 10:34:06.578292Z] Running populate-webroot step. 03:34:06 INFO - Running pre-action listener: _resource_record_pre_action 03:34:06 INFO - Running main action method: populate_webroot 03:34:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:34:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:34:06 INFO - 'tests': ['damp', 'tps']}, 03:34:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:34:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:34:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:34:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:06 INFO - 'ts_paint', 03:34:06 INFO - 'tpaint', 03:34:06 INFO - 'sessionrestore', 03:34:06 INFO - 'sessionrestore_many_windows', 03:34:06 INFO - 'sessionrestore_no_auto_restore', 03:34:06 INFO - 'tabpaint']}, 03:34:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:34:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:34:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:06 INFO - 'tsvgr_opacity', 03:34:06 INFO - 'tart', 03:34:06 INFO - 'tscrollx', 03:34:06 INFO - 'tsvg_static']}, 03:34:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:34:06 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:06 INFO - 'talos_options': ['--mitmproxy', 03:34:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:06 INFO - '--firstNonBlankPaint'], 03:34:06 INFO - 'tests': ['tp6_google', 03:34:06 INFO - 'tp6_youtube', 03:34:06 INFO - 'tp6_amazon', 03:34:06 INFO - 'tp6_facebook']}, 03:34:06 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:06 INFO - 'talos_options': ['--stylo', 03:34:06 INFO - '--mitmproxy', 03:34:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:06 INFO - '--firstNonBlankPaint'], 03:34:06 INFO - 'tests': ['tp6_google', 03:34:06 INFO - 'tp6_youtube', 03:34:06 INFO - 'tp6_amazon', 03:34:06 INFO - 'tp6_facebook']}, 03:34:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:34:06 INFO - 'talos_options': ['--stylo', 03:34:06 INFO - '--stylo-threads=1', 03:34:06 INFO - '--mitmproxy', 03:34:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:34:06 INFO - '--firstNonBlankPaint'], 03:34:06 INFO - 'tests': ['tp6_google', 03:34:06 INFO - 'tp6_youtube', 03:34:06 INFO - 'tp6_amazon', 03:34:06 INFO - 'tp6_facebook']}, 03:34:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:34:06 INFO - 'talos_options': ['--xperf_path', 03:34:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:06 INFO - 'tests': ['tp5n']}}} 03:34:06 INFO - Running post-action listener: _resource_record_post_action 03:34:06 INFO - [mozharness: 2017-08-09 10:34:06.586792Z] Finished populate-webroot step (success) 03:34:06 INFO - [mozharness: 2017-08-09 10:34:06.586882Z] Running create-virtualenv step. 03:34:06 INFO - Running pre-action listener: _resource_record_pre_action 03:34:06 INFO - Running main action method: create_virtualenv 03:34:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:06 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:34:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:34:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:06 INFO - Using real prefix '/usr' 03:34:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:09 INFO - Installing pip.................done. 03:34:09 INFO - Return code: 0 03:34:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:09 INFO - Reading from file tmpfile_stdout 03:34:09 INFO - Output received: 03:34:09 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:34:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:34:09 INFO - Using env: {'DISPLAY': ':0', 03:34:09 INFO - 'HOME': '/home/cltbld', 03:34:09 INFO - 'LANG': 'en_US.UTF-8', 03:34:09 INFO - 'LANGUAGE': 'en_US:en', 03:34:09 INFO - 'LOGNAME': 'cltbld', 03:34:09 INFO - 'MAIL': '/var/mail/cltbld', 03:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:09 INFO - 'MOZ_NO_REMOTE': '1', 03:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:09 INFO - 'NO_EM_RESTART': '1', 03:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:09 INFO - 'PWD': '/builds/slave/test', 03:34:09 INFO - 'SHELL': '/bin/bash', 03:34:09 INFO - 'SHLVL': '1', 03:34:09 INFO - 'TERM': 'linux', 03:34:09 INFO - 'TMOUT': '86400', 03:34:09 INFO - 'USER': 'cltbld', 03:34:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:09 INFO - '_': '/tools/buildbot/bin/python'} 03:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:09 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:34:09 INFO - Cleaning up... 03:34:09 INFO - Return code: 0 03:34:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:34:09 INFO - Using env: {'DISPLAY': ':0', 03:34:09 INFO - 'HOME': '/home/cltbld', 03:34:09 INFO - 'LANG': 'en_US.UTF-8', 03:34:09 INFO - 'LANGUAGE': 'en_US:en', 03:34:09 INFO - 'LOGNAME': 'cltbld', 03:34:09 INFO - 'MAIL': '/var/mail/cltbld', 03:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:09 INFO - 'MOZ_NO_REMOTE': '1', 03:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:09 INFO - 'NO_EM_RESTART': '1', 03:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:09 INFO - 'PWD': '/builds/slave/test', 03:34:09 INFO - 'SHELL': '/bin/bash', 03:34:09 INFO - 'SHLVL': '1', 03:34:09 INFO - 'TERM': 'linux', 03:34:09 INFO - 'TMOUT': '86400', 03:34:09 INFO - 'USER': 'cltbld', 03:34:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:09 INFO - '_': '/tools/buildbot/bin/python'} 03:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:09 INFO - Downloading/unpacking psutil>=3.1.1 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:11 INFO - Installing collected packages: psutil 03:34:11 INFO - Running setup.py install for psutil 03:34:11 INFO - building 'psutil._psutil_linux' extension 03:34:11 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:34:11 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:34:11 INFO - building 'psutil._psutil_posix' extension 03:34:11 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:34:11 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:34:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:11 INFO - Successfully installed psutil 03:34:11 INFO - Cleaning up... 03:34:11 INFO - Return code: 0 03:34:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:11 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:11 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:34:11 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:34:11 INFO - Using env: {'DISPLAY': ':0', 03:34:11 INFO - 'HOME': '/home/cltbld', 03:34:11 INFO - 'LANG': 'en_US.UTF-8', 03:34:11 INFO - 'LANGUAGE': 'en_US:en', 03:34:11 INFO - 'LOGNAME': 'cltbld', 03:34:11 INFO - 'MAIL': '/var/mail/cltbld', 03:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:11 INFO - 'MOZ_NO_REMOTE': '1', 03:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:11 INFO - 'NO_EM_RESTART': '1', 03:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:11 INFO - 'PWD': '/builds/slave/test', 03:34:11 INFO - 'SHELL': '/bin/bash', 03:34:11 INFO - 'SHLVL': '1', 03:34:11 INFO - 'TERM': 'linux', 03:34:11 INFO - 'TMOUT': '86400', 03:34:11 INFO - 'USER': 'cltbld', 03:34:11 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:11 INFO - '_': '/tools/buildbot/bin/python'} 03:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:12 INFO - Installing collected packages: mozsystemmonitor 03:34:12 INFO - Running setup.py install for mozsystemmonitor 03:34:13 INFO - Successfully installed mozsystemmonitor 03:34:13 INFO - Cleaning up... 03:34:13 INFO - Return code: 0 03:34:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:13 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:13 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:34:13 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:34:13 INFO - Using env: {'DISPLAY': ':0', 03:34:13 INFO - 'HOME': '/home/cltbld', 03:34:13 INFO - 'LANG': 'en_US.UTF-8', 03:34:13 INFO - 'LANGUAGE': 'en_US:en', 03:34:13 INFO - 'LOGNAME': 'cltbld', 03:34:13 INFO - 'MAIL': '/var/mail/cltbld', 03:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:13 INFO - 'MOZ_NO_REMOTE': '1', 03:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:13 INFO - 'NO_EM_RESTART': '1', 03:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:13 INFO - 'PWD': '/builds/slave/test', 03:34:13 INFO - 'SHELL': '/bin/bash', 03:34:13 INFO - 'SHLVL': '1', 03:34:13 INFO - 'TERM': 'linux', 03:34:13 INFO - 'TMOUT': '86400', 03:34:13 INFO - 'USER': 'cltbld', 03:34:13 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:13 INFO - '_': '/tools/buildbot/bin/python'} 03:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34:14 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:14 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:14 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:14 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:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:14 INFO - warning: no files found matching '*.txt' 03:34:14 INFO - no previously-included directories found matching 'build' 03:34:14 INFO - no previously-included directories found matching 'dist' 03:34:14 INFO - no previously-included directories found matching '.git*' 03:34:14 INFO - Installing collected packages: jsonschema, functools32 03:34:14 INFO - Running setup.py install for functools32 03:34:14 INFO - warning: no files found matching '*.txt' 03:34:14 INFO - no previously-included directories found matching 'build' 03:34:14 INFO - no previously-included directories found matching 'dist' 03:34:14 INFO - no previously-included directories found matching '.git*' 03:34:14 INFO - Successfully installed jsonschema functools32 03:34:14 INFO - Cleaning up... 03:34:14 INFO - Return code: 0 03:34:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:14 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:14 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:34:14 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:34:14 INFO - Using env: {'DISPLAY': ':0', 03:34:14 INFO - 'HOME': '/home/cltbld', 03:34:14 INFO - 'LANG': 'en_US.UTF-8', 03:34:14 INFO - 'LANGUAGE': 'en_US:en', 03:34:14 INFO - 'LOGNAME': 'cltbld', 03:34:14 INFO - 'MAIL': '/var/mail/cltbld', 03:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:14 INFO - 'MOZ_NO_REMOTE': '1', 03:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:14 INFO - 'NO_EM_RESTART': '1', 03:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:14 INFO - 'PWD': '/builds/slave/test', 03:34:14 INFO - 'SHELL': '/bin/bash', 03:34:14 INFO - 'SHLVL': '1', 03:34:14 INFO - 'TERM': 'linux', 03:34:14 INFO - 'TMOUT': '86400', 03:34:14 INFO - 'USER': 'cltbld', 03:34:14 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:14 INFO - '_': '/tools/buildbot/bin/python'} 03:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:15 INFO - Cleaning up... 03:34:15 INFO - Return code: 0 03:34:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34: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:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34: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:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:34:15 INFO - Using env: {'DISPLAY': ':0', 03:34:15 INFO - 'HOME': '/home/cltbld', 03:34:15 INFO - 'LANG': 'en_US.UTF-8', 03:34:15 INFO - 'LANGUAGE': 'en_US:en', 03:34:15 INFO - 'LOGNAME': 'cltbld', 03:34:15 INFO - 'MAIL': '/var/mail/cltbld', 03:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:15 INFO - 'MOZ_NO_REMOTE': '1', 03:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:15 INFO - 'NO_EM_RESTART': '1', 03:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:15 INFO - 'PWD': '/builds/slave/test', 03:34:15 INFO - 'SHELL': '/bin/bash', 03:34:15 INFO - 'SHLVL': '1', 03:34:15 INFO - 'TERM': 'linux', 03:34:15 INFO - 'TMOUT': '86400', 03:34:15 INFO - 'USER': 'cltbld', 03:34:15 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:15 INFO - '_': '/tools/buildbot/bin/python'} 03:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:34:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:16 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:16 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:16 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:16 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:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34:16 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:16 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:16 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:16 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:16 INFO - Downloading docopt-0.6.1.tar.gz 03:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:16 INFO - Running setup.py install for blobuploader 03:34:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:17 INFO - Running setup.py install for requests 03:34:17 INFO - Running setup.py install for docopt 03:34:17 INFO - Successfully installed blobuploader requests docopt 03:34:17 INFO - Cleaning up... 03:34:17 INFO - Return code: 0 03:34:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:17 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:17 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:34:17 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:34:17 INFO - Using env: {'DISPLAY': ':0', 03:34:17 INFO - 'HOME': '/home/cltbld', 03:34:17 INFO - 'LANG': 'en_US.UTF-8', 03:34:17 INFO - 'LANGUAGE': 'en_US:en', 03:34:17 INFO - 'LOGNAME': 'cltbld', 03:34:17 INFO - 'MAIL': '/var/mail/cltbld', 03:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:17 INFO - 'MOZ_NO_REMOTE': '1', 03:34:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:17 INFO - 'NO_EM_RESTART': '1', 03:34:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:17 INFO - 'PWD': '/builds/slave/test', 03:34:17 INFO - 'SHELL': '/bin/bash', 03:34:17 INFO - 'SHLVL': '1', 03:34:17 INFO - 'TERM': 'linux', 03:34:17 INFO - 'TMOUT': '86400', 03:34:17 INFO - 'USER': 'cltbld', 03:34:17 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:17 INFO - '_': '/tools/buildbot/bin/python'} 03:34:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:17 INFO - Running setup.py (path:/tmp/pip-F8dCjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:17 INFO - Running setup.py (path:/tmp/pip-raTedA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:17 INFO - Running setup.py (path:/tmp/pip-amV3UK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:17 INFO - Running setup.py (path:/tmp/pip-XbVQQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:18 INFO - Running setup.py (path:/tmp/pip-zQ6x2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:18 INFO - Running setup.py (path:/tmp/pip-X_Lo0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:18 INFO - Running setup.py (path:/tmp/pip-UYHcSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:18 INFO - Running setup.py (path:/tmp/pip-Gb0ENp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:18 INFO - Running setup.py (path:/tmp/pip-a8YkiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:18 INFO - Running setup.py (path:/tmp/pip-hVWYxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:18 INFO - Running setup.py (path:/tmp/pip-_I92EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:18 INFO - Running setup.py (path:/tmp/pip-TSVC4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:18 INFO - Running setup.py (path:/tmp/pip-h4o4u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:18 INFO - Running setup.py (path:/tmp/pip-gTDPW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:18 INFO - Running setup.py (path:/tmp/pip-lkkmih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:18 INFO - Running setup.py (path:/tmp/pip-gD__xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:18 INFO - Running setup.py (path:/tmp/pip-Oi7BhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:18 INFO - Running setup.py install for manifestparser 03:34:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Running setup.py install for mozcrash 03:34:19 INFO - Running setup.py install for mozdebug 03:34:19 INFO - Running setup.py install for mozdevice 03:34:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Running setup.py install for mozfile 03:34:19 INFO - Running setup.py install for mozhttpd 03:34:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Running setup.py install for mozinfo 03:34:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Running setup.py install for mozInstall 03:34:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:19 INFO - Running setup.py install for mozleak 03:34:19 INFO - Running setup.py install for mozlog 03:34:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Running setup.py install for moznetwork 03:34:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Running setup.py install for mozprocess 03:34:20 INFO - Running setup.py install for mozprofile 03:34:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Running setup.py install for mozrunner 03:34:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Running setup.py install for mozscreenshot 03:34:20 INFO - Running setup.py install for moztest 03:34:20 INFO - Running setup.py install for mozversion 03:34:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:20 INFO - Cleaning up... 03:34:20 INFO - Return code: 0 03:34:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:20 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:20 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:34:20 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:34:20 INFO - Using env: {'DISPLAY': ':0', 03:34:20 INFO - 'HOME': '/home/cltbld', 03:34:20 INFO - 'LANG': 'en_US.UTF-8', 03:34:20 INFO - 'LANGUAGE': 'en_US:en', 03:34:20 INFO - 'LOGNAME': 'cltbld', 03:34:20 INFO - 'MAIL': '/var/mail/cltbld', 03:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:20 INFO - 'MOZ_NO_REMOTE': '1', 03:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:20 INFO - 'NO_EM_RESTART': '1', 03:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:20 INFO - 'PWD': '/builds/slave/test', 03:34:20 INFO - 'SHELL': '/bin/bash', 03:34:20 INFO - 'SHLVL': '1', 03:34:20 INFO - 'TERM': 'linux', 03:34:20 INFO - 'TMOUT': '86400', 03:34:20 INFO - 'USER': 'cltbld', 03:34:20 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:20 INFO - '_': '/tools/buildbot/bin/python'} 03:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:20 INFO - Running setup.py (path:/tmp/pip-6cWwyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:21 INFO - Running setup.py (path:/tmp/pip-pjOdGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:21 INFO - Running setup.py (path:/tmp/pip-0swbHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:21 INFO - Running setup.py (path:/tmp/pip-QOfWmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:21 INFO - Running setup.py (path:/tmp/pip-FAZy5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:21 INFO - Running setup.py (path:/tmp/pip-Ik2W94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:21 INFO - Running setup.py (path:/tmp/pip-diNiyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:21 INFO - Running setup.py (path:/tmp/pip-DdMVXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:21 INFO - Running setup.py (path:/tmp/pip-DwByKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:21 INFO - Running setup.py (path:/tmp/pip-eSvGm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:21 INFO - Running setup.py (path:/tmp/pip-QVTK3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:21 INFO - Running setup.py (path:/tmp/pip-uwCVKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:21 INFO - Running setup.py (path:/tmp/pip-aZabZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:21 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:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:21 INFO - Running setup.py (path:/tmp/pip-VpIxCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:22 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:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:22 INFO - Running setup.py (path:/tmp/pip-EjTUqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:22 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:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:22 INFO - Running setup.py (path:/tmp/pip-ZtgsGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:22 INFO - Running setup.py (path:/tmp/pip-x4moWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34:22 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:22 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:22 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:22 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:23 INFO - Downloading blessings-1.6.tar.gz 03:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:23 INFO - Installing collected packages: blessings 03:34:23 INFO - Running setup.py install for blessings 03:34:23 INFO - Successfully installed blessings 03:34:23 INFO - Cleaning up... 03:34:23 INFO - Return code: 0 03:34:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:23 INFO - Reading from file tmpfile_stdout 03:34:23 INFO - Current package versions: 03:34:23 INFO - argparse == 1.2.1 03:34:23 INFO - blessings == 1.6 03:34:23 INFO - blobuploader == 1.2.4 03:34:23 INFO - docopt == 0.6.1 03:34:23 INFO - functools32 == 3.2.3-2 03:34:23 INFO - jsonschema == 2.5.1 03:34:23 INFO - manifestparser == 1.1 03:34:23 INFO - mozInstall == 1.13 03:34:23 INFO - mozcrash == 1.0 03:34:23 INFO - mozdebug == 0.1 03:34:23 INFO - mozdevice == 0.51 03:34:23 INFO - mozfile == 1.2 03:34:23 INFO - mozhttpd == 0.7 03:34:23 INFO - mozinfo == 0.10 03:34:23 INFO - mozleak == 0.1 03:34:23 INFO - mozlog == 3.5 03:34:23 INFO - moznetwork == 0.27 03:34:23 INFO - mozprocess == 0.25 03:34:23 INFO - mozprofile == 0.28 03:34:23 INFO - mozrunner == 6.13 03:34:23 INFO - mozscreenshot == 0.1 03:34:23 INFO - mozsystemmonitor == 0.3 03:34:23 INFO - moztest == 0.8 03:34:23 INFO - mozversion == 1.4 03:34:23 INFO - psutil == 3.1.1 03:34:23 INFO - requests == 1.2.3 03:34:23 INFO - wsgiref == 0.1.2 03:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:23 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:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:23 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:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:23 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:23 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:23 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: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 - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:23 INFO - 'MOZ_NO_REMOTE': '1', 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': '/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 - 'SHELL': '/bin/bash', 03:34:23 INFO - 'SHLVL': '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:23 INFO - '_': '/tools/buildbot/bin/python'} 03:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:34:23 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:23 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:23 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:23 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:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:34:25 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:25 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:25 INFO - Installing collected packages: simplejson 03:34:25 INFO - Running setup.py install for simplejson 03:34:25 INFO - building 'simplejson._speedups' extension 03:34:25 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:26 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:26 INFO - Successfully installed simplejson 03:34:26 INFO - Cleaning up... 03:34:26 INFO - Return code: 0 03:34:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:26 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 0x149d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1669a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, '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': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', '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:26 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:26 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:26 INFO - Using env: {'DISPLAY': ':0', 03:34:26 INFO - 'HOME': '/home/cltbld', 03:34:26 INFO - 'LANG': 'en_US.UTF-8', 03:34:26 INFO - 'LANGUAGE': 'en_US:en', 03:34:26 INFO - 'LOGNAME': 'cltbld', 03:34:26 INFO - 'MAIL': '/var/mail/cltbld', 03:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:26 INFO - 'MOZ_NO_REMOTE': '1', 03:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:26 INFO - 'NO_EM_RESTART': '1', 03:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:26 INFO - 'PWD': '/builds/slave/test', 03:34:26 INFO - 'SHELL': '/bin/bash', 03:34:26 INFO - 'SHLVL': '1', 03:34:26 INFO - 'TERM': 'linux', 03:34:26 INFO - 'TMOUT': '86400', 03:34:26 INFO - 'USER': 'cltbld', 03:34:26 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:26 INFO - '_': '/tools/buildbot/bin/python'} 03:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:26 INFO - Cleaning up... 03:34:26 INFO - Return code: 0 03:34:26 INFO - Running post-action listener: _resource_record_post_action 03:34:26 INFO - Running post-action listener: _start_resource_monitoring 03:34:26 INFO - Starting resource monitoring. 03:34:26 INFO - [mozharness: 2017-08-09 10:34:26.491223Z] Finished create-virtualenv step (success) 03:34:26 INFO - [mozharness: 2017-08-09 10:34:26.491741Z] Running install step. 03:34:26 INFO - Running pre-action listener: _resource_record_pre_action 03:34:26 INFO - Running main action method: install 03:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:26 INFO - Reading from file tmpfile_stdout 03:34:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:26 INFO - Reading from file tmpfile_stdout 03:34:26 INFO - Output received: 03:34:26 INFO - Usage: mozinstall [options] installer 03:34:26 INFO - Options: 03:34:26 INFO - -h, --help show this help message and exit 03:34:26 INFO - -d DEST, --destination=DEST 03:34:26 INFO - Directory to install application into. [default: 03:34:26 INFO - "/builds/slave/test"] 03:34:26 INFO - --app=APP Application being installed. [default: firefox] 03:34:26 INFO - mkdir: /builds/slave/test/build/application 03:34:26 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:26 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:44 INFO - Reading from file tmpfile_stdout 03:34:44 INFO - Output received: 03:34:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:34:44 INFO - Running post-action listener: _resource_record_post_action 03:34:44 INFO - [mozharness: 2017-08-09 10:34:44.789954Z] Finished install step (success) 03:34:44 INFO - [mozharness: 2017-08-09 10:34:44.790240Z] Running setup-mitmproxy step. 03:34:44 INFO - Running pre-action listener: _resource_record_pre_action 03:34:44 INFO - Running main action method: setup_mitmproxy 03:34:44 INFO - Skipping: mitmproxy is not required 03:34:44 INFO - Running post-action listener: _resource_record_post_action 03:34:44 INFO - [mozharness: 2017-08-09 10:34:44.791388Z] Finished setup-mitmproxy step (success) 03:34:44 INFO - [mozharness: 2017-08-09 10:34:44.791609Z] Running run-tests step. 03:34:44 INFO - Running pre-action listener: _resource_record_pre_action 03:34:44 INFO - Running pre-action listener: _set_gcov_prefix 03:34:44 INFO - Running main action method: run_tests 03:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:34:44 INFO - Python 2.7.3 03:34:44 INFO - Return code: 0 03:34:44 INFO - grabbing minidump binary from tooltool 03:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:44 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 0x180df00>, '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 0x1808ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1809050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:34:44 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:44 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:44 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:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:34:44 INFO - Return code: 0 03:34:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:34:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:34:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:34:44 INFO - ENV: RUST_BACKTRACE is now full 03:34:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:34:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:34:44 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-088', '--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:44 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-088 --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:44 INFO - Using env: {'DISPLAY': ':0', 03:34:44 INFO - 'HOME': '/home/cltbld', 03:34:44 INFO - 'LANG': 'en_US.UTF-8', 03:34:44 INFO - 'LANGUAGE': 'en_US:en', 03:34:44 INFO - 'LOGNAME': 'cltbld', 03:34:44 INFO - 'MAIL': '/var/mail/cltbld', 03:34:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:44 INFO - 'MOZ_NO_REMOTE': '1', 03:34:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:44 INFO - 'NO_EM_RESTART': '1', 03:34:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:44 INFO - 'PWD': '/builds/slave/test', 03:34:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:44 INFO - 'RUST_BACKTRACE': 'full', 03:34:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:44 INFO - 'SHELL': '/bin/bash', 03:34:44 INFO - 'SHLVL': '1', 03:34:44 INFO - 'STYLO_FORCE_ENABLED': '1', 03:34:44 INFO - 'TERM': 'linux', 03:34:44 INFO - 'TMOUT': '86400', 03:34:44 INFO - 'USER': 'cltbld', 03:34:44 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152', 03:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:44 INFO - '_': '/tools/buildbot/bin/python'} 03:34:44 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-088', '--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:45 INFO - mozversion application_buildid: 20170809093721 03:34:45 INFO - mozversion application_changeset: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc 03:34:45 INFO - mozversion application_display_name: Nightly 03:34:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:34:45 INFO - mozversion application_name: Firefox 03:34:45 INFO - mozversion application_remotingname: firefox 03:34:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:34:45 INFO - mozversion application_vendor: Mozilla 03:34:45 INFO - mozversion application_version: 57.0a1 03:34:45 INFO - mozversion platform_buildid: 20170809093721 03:34:45 INFO - mozversion platform_changeset: 4c5fbf49376351679dcc49f4cff26c3c2e055ccc 03:34:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:34:45 INFO - mozversion platform_version: 57.0a1 03:34:45 INFO - using testdate: 1502274885 03:34:45 INFO - actual date: 1502274885 03:34:45 INFO - starting webserver on 'localhost:56313' 03:34:45 INFO - SUITE-START | Running 2 tests 03:34:45 INFO - TEST-START | dromaeo_css 03:34:45 INFO - Initialising browser for dromaeo_css test... 03:34:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56313/getInfo.html -profile /tmp/tmpMOU64B/profile 03:34:45 INFO - TEST-INFO | started process 9904 (/builds/slave/test/build/application/firefox/firefox http://localhost:56313/getInfo.html) 03:34:50 INFO - TEST-INFO | 9904: exit 0 03:34:51 INFO - Browser initialized. 03:34:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:51 INFO - TEST-INFO | started process 10136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMOU64B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:52 INFO - PID 10136 | 03:34:52 INFO - PID 10136 | (/builds/slave/test/build/application/firefox/firefox:10190): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:52 INFO - PID 10136 | 03:35:02 INFO - PID 10136 | RSS: Main: 170795008 03:35:02 INFO - PID 10136 | 03:38:01 INFO - PID 10136 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56313/tests/dromaeo/cssquery-ext.html) 03:38:03 INFO - PID 10136 | RSS: Main: 175501312 03:38:03 INFO - PID 10136 | 03:41:05 INFO - PID 10136 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-ext.html (next: http://localhost:56313/tests/dromaeo/cssquery-jquery.html) 03:41:06 INFO - PID 10136 | RSS: Main: 171458560 03:41:06 INFO - PID 10136 | 03:44:07 INFO - PID 10136 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56313/tests/dromaeo/cssquery-mootools.html) 03:44:08 INFO - PID 10136 | RSS: Main: 172929024 03:44:08 INFO - PID 10136 | 03:47:10 INFO - PID 10136 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56313/tests/dromaeo/cssquery-prototype.html) 03:47:10 INFO - PID 10136 | RSS: Main: 173535232 03:47:10 INFO - PID 10136 | 03:50:14 INFO - PID 10136 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56313/tests/dromaeo/cssquery-yui.html) 03:50:15 INFO - PID 10136 | RSS: Main: 177074176 03:50:15 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | Cycle 1(1): loaded http://localhost:56313/tests/dromaeo/cssquery-yui.html (next: http://localhost:56313/tests/dromaeo/cssquery-dojo.html) 03:53:17 INFO - PID 10136 | RSS: Main: 177504256 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | __start_tp_report 03:53:17 INFO - PID 10136 | _x_x_mozilla_page_load 03:53:17 INFO - PID 10136 | _x_x_mozilla_page_load_details 03:53:17 INFO - PID 10136 | |i|pagename|runs| 03:53:17 INFO - PID 10136 | |0;dojo.html;3070.7543396528295;3119.5476655884895;3126.593542839433;3136.200268931422;3140.607424071991;6185.103160041797;6192.1950146481;6266.84332891678;6311.747530098791;6390.3929126733;6266.404691554295;6297.716602752876;6309.4636955858805;6332.841678958017;6399.488040956724;5642.04085305497;5727.828165155052;5751.884962300762;5827.358990511061;5853.356130825606;5651.745671444774;5689.032864413039;5692.629979051369;5714.428557144273;5742.54059675225;5616.5787565932715;5651.886962260753;5687.17535957286;5701.77192912283;5713.71431428429;5611.607187496877;5644.576656750719;5658.377578466366;5712.82861514151;5719.19931209631;5534.391216966131;5628.802991895264;5635.520980716603;5682.6590404575445;5742.483176514133;6129.540284478682;6160;6189.195404597419;6193.566450348478;6194.783182588588;6702.4302934250645;6721.126253587003;6741.157355330583;6788.72845086196;6805.6597170141295;6710.731570737214;6770.424513916323;6781.25406205317;6849.2465828758795;6871.312868713138;6145.985912324461;6209.5032397408095;6237.688115594202;6265.310815810257;6310.652914089723;6910.619915904674;6922.58464492122;6923.273056329013;6930.792076237721;6942.409895158867;6466.127072845105;6574.835629109215;6595.835104122435;6622.768203112868;6644.103046088716;6792.08306878575;6823.522353435311;6834.863302733917;6840.623765692835;6844.452443804484;6651.700673469705;6681.365270299314;6685.76599819004;6774.42417394527;6778.18661760582;6396.976483762575;6521.934780652133;6780.864382712318;6850.109485766819;6850.623215723183;5367.704776237267;5460.918086228709;5466.562674985991;5478.068728316196;5479.863003424946;4630.32860235264;4675.041616468616;4700.153972285021;4707.5057119002695;4720.527947205321;5769.307683078057;5858.121281807763;5858.443447872445;5859.648421094748;5870.823875283749;6715.6977935993;6736.528443008942;6788.1175447191545;6822.147231596051;6826.863462730717;5709.286339207599;5772.336181339116;5778.133280007948;5835.328937172195;5864.882702346014;5882.176495290662;5906.645601263852;5919;5929.881402371929;5931.228940237742;6439.291677915426;6508.056331831953;6513.576617519846;6541.705623246965;6550.050242714779;6552.967235163794;6751.831204219836;6802.6598670065305;6829.829254268683;6864.450843932374;6491.935080649133;6521.054447105238;6535.771248006297;6546.279909209888;6630.734770609121;6584.209894812653;6619.172603424572;6638.402543771083;6642.136522252076;6649.567778094409;6681.799546013627;6772.051912732123;6774.288699686659;6774.627395493295;6776.220734615582;6464.159659244268;6530.47756179495;6539.21529416454;6550.967245163743;6560.606363618198;6501.284858665637;6529.085927970183;6537.117489139096;6540.182477190351;6649.700763465752;6401.071844582602;6404.327545607644;6417.03744438338;6497.837554061186;6518.934810651833;6503.739850405931;6533.509986750918;6596.90104648421;6610.966945165435;6620.470362370903;6266.561340706289;6350.237971443456;6379.553431259767;6383.521235907233;6387.520935929917 03:53:17 INFO - PID 10136 | |1;ext.html;713.2902761752058;790.162427826504;818.8526065308243;1158.7276989907375;1181.149572307938;36694.63305366949;40492.39261411081;40573;40589.18821623569;40739.59260407395;40579.39130913031;41027.58972410275;41113.383299250534;41145.17709645805;41151.58848411515;7412.55524668519;7558.47090703651;7560.395168386516;7564.546127232356;7572;7500.362469190098;7606.73376431825;7619.885701714478;7624.847503049936;7627.389808815282;7030.156381234259;7599.316061554459;7618.73334433295;7622.4664273500875;7626.122995855464;7521.736739214129;7561.924380756177;7570.091589009354;7572.129205141424;7588.734394296201;7459.067616547932;7549.3583045440655;7553.584552849591;7553.924460755377;7562.205968373297;37922.62077379219;38183;38192;38748.612513875065;39406.211875762325;3544.521489598897;3593.5148754918014;3595.7842529448053;3600.1719604491113;3600.297941901304;30567.541486877715;30722.23194420135;30771.230719231975;30789.846050769826;30819.845900770575;5006.674566153189;5038.2190760432195;5067;5069.417017043051;5097;228253;236049;236356;237356.99999999828;237959;46849;46995;47045;47161;47175.52824471711;48594.514054859705;48772;48912.75543622259;49107;49116.50883491119;15956.441524546584;16269;16275.267612957445;16277.674446511004;16284.43004494837;13578.253196074113;13581.253031083384;13589.796153057712;13592.592222233348;13647.590572282847;13256.867431325756;13299.468021279234;13469.595912122651;13575.185488870698;13716.451341946211;4867.70389455948;5491.505764481216;5714.571407144397;5717.742701578439;5775.768969241183;1001.7946321004323;1012.4532752313816;1021.3412349034979;1029.840374741916;1033.5555711044324;22663.320100397013;23036.193733219257;23074.423139421648;23322.416939576306;23533.0586776527;1141.2752901907184;1141.9543218271342;1145.2970988467212;1147.9942600286945;1154.509333533245;12203.633890983285;12583.370831458573;12587.622371328875;12589.559365422167;12631.747365052832;230133;230859;230947;231248;231935;49835;49989.500104998486;49995.50004499981;50554.49445505571;50628.493715063116;1434.9571787416573;1445.515752222996;1480.6076389756722;1481.9925900370429;1497.622860449679;22671.659925101467;22678.773212267664;22801;23009.769902301432;23224.883875580515;36494.635053650185;36536.63463365439;36599.63400365962;36600.45099323459;36642.633573664985;188801;189349;189378;189624;189626;33226.169345765586;33315.167120822174;33406.164845879044;33496.33007339888;33612.495812562345;35754.463683044254;38943.805280973414;39377.212455751294;41387.7930610345;41533.79233103936;31122.68877311198;31655.52516712205;31848.203794905312;32107.678923210467;32143;30790.38419231558;30872.69127308698;30883.536746948364;31189.8440507796;31227.68772312248;33634.66365336315;33645.99062028143;33837.15407114842;33907.83046084754;34029.31941361209;29575;29851;29962;30004.549931751477;30151.698483015767;22210.333689989326;23309.06763729432;24298.63552046756;24978.50042999166;25209.49581008333 03:53:17 INFO - PID 10136 | |2;jquery.html;568.4173721935016;573.1860757724031;574.1760573576914;576.1760682224417;594.126633848243;21481;21582.892085539588;22616;22720.204792832254;22730.318090457273;26226.47547049058;26959;26960.730392696118;27066.18801435955;27080.729192708066;6458.095866578683;6617.470602351825;6623.5032372572;6629.105070815451;6639;5731.885362292752;6042.184305118797;6313.526485513582;6449.645269510175;6551.639659818708;6292.590981586205;6295.527835412339;6296.811095667137;6299.65351905645;6299.937000630004;6190.690465476709;6235.095911092866;6279.937200628004;6291.33940936202;6295.370462953714;5869.50109240715;5870.178175055496;5903.232579764646;5904.2029326040865;5905.822825315247;28967.275818104506;29276.707232927612;29335.413291734047;30119;30664.540031899538;1935.4677463697456;1945.1246938877562;1957.7063440483898;1962.80371962804;1964.9115789789494;19118.71321930172;19584.31454899086;19659.311924082587;19708.70436943447;19765;2358.811295096388;2406.6630671705975;2422.358075110097;2424.1636635360774;2472.4807790363866;137373;145047.27476362657;145065;145282.54717452795;145353.27323363317;14766.409343626136;15001.699966000837;15059.623509412133;15160.31778569945;15954.521364359089;22629.773702263097;23980.7601923982;24037.278881633578;24059.639105413433;24062.51874962491;10081.596736130472;10142.847857282146;10223.488825558692;10319.432431216355;10354.844677329846;9397.76505587352;9409.153176214037;9483.668071617598;9584.28117891161;9605.231581473465;9237.769055773526;9588.952055239679;9596.66411675588;9660.806783864284;9739.56171972263;2725.1824452664123;2785.470760555488;2802.7477527022666;2810.718928107173;2891.407261511385;931.5202670624634;982.7051884434641;983.1053741095569;996.7757254617653;1001.2890847498212;20220;20423.387298381072;20451;20692.172313107607;20697.793022069887;1057.4078516031047;1062.2670357453333;1065.3820783945293;1079.0450451350455;1080.1466841195368;11656.358900260397;13469.730605388033;14477.710445791025;14771.926140369444;14845.331960061607;504340;508882;516498;523318;543521;113350;118987.40506297413;121493;122276;123707;1277.431542963391;1312.2061153002487;1323.8212841266306;1334.106148880272;1345.8923286137085;21254.78745212528;21472.208612880226;22468.32595022152;22499.775002249768;22512.66231006569;58256;58912.70543647254;60245.698771505864;60435.697821510614;61634.691826540584;67121.66439167772;67378.3262167372;67867;67894.66052669704;68024;14774.556763297118;15147.469838555598;15308.617284567976;15319.080855148726;15331.61670958235;23224.651630225224;23239.535209296057;23286;23525;23615.29154125379;18509.259629614666;18771.812281877552;18931.43205703831;18954.43136705901;18966.810331896504;16889.239984200987;16944.40694575684;16998.745018824975;16999.91500042492;17017.48947531576;18732.25070997145;18775.155118019447;18786.248550057844;18847.057647117865;18965.90517047406;14677.633059173178;14825.332860021541;14910.776338354717;14923.104613723212;14957.40170393172;18345.54136146607;18425.07874606291;18571.25714971386;18714.06429678538;18719.812801871805 03:53:17 INFO - PID 10136 | |3;mootools.html;1333.7665908466017;1407.7817938219573;1412.816333876596;1414.1939094716015;1420.1479112532481;13348.799768003488;13591.932040339796;14153.22157281349;14220.715585688293;14238;14477.710445791077;14655.193964331958;14683.779743303832;14707.264636768172;14739.705205895876;2658.2822637887807;2735.534959056965;2737.2472570043296;2739.7534221920023;2742.1088146352517;2599.6100584912224;2612.1379944618325;2663.8934442622367;2710.7424794644476;2713.3216695826045;2705.648265725453;2733.1937078561873;2735.493933622286;2735.5076086304457;2736.2885649731115;2635.169921474729;2662.5739881618847;2664.0675763482627;2671.131882138303;2677.0897894715695;2565.076572433922;2566.576514875062;2586.1336452288506;2590.378309205796;2605;13566.389512471962;13879.028468007244;13887.4445022199;13890.930545347208;13899;7438.66526006331;7673.808154796119;7717.922820771832;7722.304992550641;7722.382209423289;4894.290327902434;4988.575971042465;5022.221555658843;5139.408967968694;5168.508991645787;1772.3265159239536;1786.7051936430473;1801.9909900450546;1826.488583196707;1838.9080545972647;22556.210532631445;22690.319290421314;22714.43213919665;22876.542469150525;23059;6199;6339.207599050119;6456.451201647913;6464.644444555594;6529.11856899322;15340.693186136215;15652.217389130497;15916.76124858128;15934.760978585331;15993.920030400006;7228.349448549656;7452.105747310249;7454.329110380092;7457.701691932262;7463.477556571096;6765.898511522331;6896.482763792736;6908.861822763517;6913.861722765517;6913.965430172817;4840.104580652591;4993.550580447777;5002.549770520671;5034;5075.5178258065425;1306.5296493262417;1332.9266890320932;1359.7416490866703;1362.1826903857607;1366.187118664393;882.5719526029999;908.1191244492832;910.9498977556298;921.2123634292583;931.7251410833685;7467.141278752904;7584.862270659335;7612.086549614081;7630.2751238632245;7656.578888161093;976.5995941663883;1000.6197644895038;1001.6544292219173;1002.4286156890648;1006.5168719014914;4770.308305295713;5167.612429067835;5183.170692689152;5192.1173400522;5243.947560524422;18281.268749250146;18980;19413.417597471816;19420.902895485433;19430.125644346037;19034.619307614048;19119.13963871629;19154.138063787163;19172.13725382361;19330.84014959107;10283.382997020202;10791.298565593212;11011.779764404668;11080.501377438035;11133.220674552704;7991.480553763987;8169.142240064945;8193.46742461738;8232.842414580598;8460.53467059293;16894.49316520506;17149.742753858452;17172.828271717623;17176.484705458857;17478.563035924202;17273.827261727223;17322.133893305538;17590.560235994202;17650.64698705993;17823.376181834094;11232;11479.196456247982;11502.252353596989;11505.597304094317;11506.827397588875;12520.248785072925;12705.047121466112;12791.80812287835;12835.935820321212;12847.871521285042;9975.401475911469;10051.849222261526;10056.145227655732;10218.38689678592;10284.331518451278;10301.278910476494;10305.484725763832;10321.019503147189;10370.377777333384;10699.197560182862;9151.816963660822;9166.816663666556;9171.954140229256;9206.769830754285;9210.95394523023;6735.191776986793;6745.156855393076;6783.287754785873;6832.0435139081565;6871.175458944958;7169.3906017986965;7244.166920804175;7291.234420385783;7365.852682946418;7425.480216384801 03:53:17 INFO - PID 10136 | |4;prototype.html;501.6162635583779;502.8290381270367;533.0910797090959;534.3347532322255;534.8636097795062;6229.532785041118;6256.6871656417225;6272.905906411407;6336.809895703131;6359.421216723963;5927.881442371161;6045.27456705196;6124.081387791834;6124.908126378096;6153.261608606962;4960.727160006199;4969.627277954168;4989.600831933455;5021.748912554376;5028.7737051832755;5005.799768009275;5007.37407824022;5011.599072074244;5018.874528136807;5027.581244753566;4826.589739872115;4932.210846264598;4969.776360063805;4972.875678108058;5002.1746411842005;4983.676061056056;4989;5001.524855138756;5015.724135172564;5028.5977121830165;4389.517153113155;4457.1977044132045;4482.618977386926;4488.7531185784765;4500.8874778130485;5989.940100598982;6022;6035.8792824143275;6096.603720758137;6109.5112391008615;5724.39893811148;5744.339400968858;5754.3094828620415;5760.913586296209;5787.681677507735;6592.571482853599;6602.438792702626;6606.900896486556;6614.834629134262;6636.634985075819;4907.582855457291;4914.454129929836;4914.625982875244;4916.575082425809;4928.28539861718;6771.356721111487;6876.931230687729;6897.9655101724675;6916.20463646677;7009.1589009319205;5052.292679024939;5062.7215503146945;5069.31564238823;5070.138076527;5108.259302401131;5113.769880355393;5129.384473863086;5147.819826306136;5152.896942061137;5197.402298735694;5778.248827652378;5789.363170051291;5800.535957123504;5801;5831.300243970751;6561.835954101186;6589.571677840925;6589.736410543621;6641.369069938348;6722.697478613474;1758.384565402099;1773.6896043192648;1794.3312719171297;1805.3861687026474;1809.3896432175375;1156.4969238381332;1200.6372766909622;1200.6638141320445;1207.9516819327305;1242.1243023668292;5596.468335508121;5723.656580605177;5765.85585360361;5781.508571771446;5811.912821307684;6537.607743535403;6564.442022428051;6577.769778057745;6659.633720145439;6673.499487538454;5570.749316280777;5572.3870374258795;5731.942680573225;5793.94206057934;5822.155787410802;3517.2086280587173;3558.5018097466377;3567.8216089195957;3605.4676762375884;3625.927481450409;6550.377714117151;6553.148090748267;6569.704363303663;6574.967125164344;6622.437092847162;6929.99515070312;6932.861342773116;6971.6862741176765;6972.267911869282;6988.545744526589;6506.60960342381;6514.283428822826;6547.723193977129;6574.671266436659;6604.3395660434535;6736.225334086446;6769.661516924036;6801.489888258499;6857.382835544825;6883.346082122191;6536.444402225864;6656.667166641745;6677.866442671022;6693.431058360094;6718.529702920749;6468.3855033771715;6493.707783149675;6503.414692677682;6519.315471875385;6538.378854008862;5024.321716568216;5024.321716568363;5057.7724002419245;5089.13484707608;5140.126178549581;6869.381755642016;6894.724211031503;6906.786860015487;6909.170899492093;6913.827154321182;6606.504512161703;6611.2727599963;6631.966840165768;6643.3356664335115;6648.335166483313;6521.282658907611;6534.379233972765;6571.835704107244;6618.8345291368105;6638.369354911276;6097.725602347817;6315.400036996478;6447.3552644735155;6494.675266236574;6562.5406221565945;6336.683165841781;6388.712507937247;6426.807195784134;6550.541462097607;6563.212414510289;6223.985529333645;6264.21697287839;6307.747690092345;6308.71610777507;6312.5265605078885 03:53:17 INFO - PID 10136 | |5;yui.html;897.0715309654505;905.9592318345674;916.7799728065266;926.5552534783304;928.2295694573505;18594.34919777808;19738.70391944122;19753.604927901433;19763.308284210056;21580.676289855626;21642.35072947814;22015;22282.55434891301;22303.219387321446;22483.437914052116;974.7173319737285;1002.3234316836143;1004.6132239087967;1005.9094681478665;1006.993006993007;960.140674096683;1049.9160067194643;1059.5549869054978;1064.4890452582727;1065.4353192807823;1121.938293393867;1131.1742428027544;1131.2477202660261;1131.4173200801595;1131.5869707556724;1125.2460851229696;1125.5216532973454;1129.8983091521761;1130.2370899642708;1131.032966813379;808.6846130009301;819.713100414856;824.5135370131651;825.5954582254712;826.4008593769529;19426.320078797315;20166.49583760403;20178.899105504526;20197.091130899145;20349.287774927954;21197.5760484791;21494.892525537427;21509.354719358445;21628.24301149468;21911.561768764695;16620.916895415445;16786.076765777878;16799.412020579344;17033.40383086586;17935.461936141935;3692.040069581901;3698.9815050924844;3700.1489657378684;3700.5374328208973;3700.5744339401044;126042;127418;127625;129162.3541882294;130073;16858.157092145342;17479.38822141219;17502.299908003537;17661;18329.083545822654;32188.356232875212;32564.674353256163;32920.341593168;32922.17694557607;33151.502727459105;7671;8106.108328083906;8583.957080214559;8970.910290897138;9043.457392556467;4265.210935976792;4337.392765012901;4349.304111342233;4349.3475978603465;4350.695451318377;5177.068127737043;5259;5298.655587386807;5336.199570064444;5364.222187782828;1039.1219419590434;1065.3927261460892;1069.8181309177303;1080.0873262093519;1082.588616325807;680.6460640466929;704.0671110778137;704.9753258636026;707.5012116457988;712.154366421329;11855.644330670093;12359.25844449318;12790.488380464678;12917.28954907489;12991.870081299066;695.6765104226558;699.5837476701355;701.554512884312;711.4592909388901;716.8458781362032;5463.453654634504;5508.55931525477;5591.412901645269;5728.427157284322;5737.168110623936;106032;106108;106222;108459.45770271098;108913.45543272392;93638;95584.52207739056;96007.51996239975;96295.03704963;96433;76926;79018.6049069751;79729.20270797334;79775.60112199401;81178.59410702909;11872.52509899629;11897.107716921439;11959.162858599815;11964.401779911144;12088.939555302168;35935.64064359323;36596.63403365932;36750;36814.26371472609;37034.8148259257;66126;66471;68714.31285687079;69705;69752;18460;19685.31101411444;19695.409137725892;19716.802831971498;19972.50068748293;21080;22271;22541;22785.430364241027;22805.201817936293;18310.542236444195;18418.35535756242;19326.710099348238;19580.80419195847;19832.50418739543;18863.528411789815;19138.330158444387;19410.708839367137;19523.902380488005;19827.801721982596;19258.8074119257;19723.60552788965;19740;19797.901010494854;19962.900185499562;13181.802272966104;13708.451661933412;13754.93122534381;13809;14051.929740351234;14808.703825923205;15306.540803775904;15417.614559636098;15590.688186236439;15648.843511564739 03:53:17 INFO - PID 10136 | __end_tp_report 03:53:17 INFO - PID 10136 | __start_cc_report 03:53:17 INFO - PID 10136 | _x_x_mozilla_cycle_collect,371 03:53:17 INFO - PID 10136 | __end_cc_report 03:53:17 INFO - PID 10136 | __startTimestamp1502275997447__endTimestamp 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | ------- Summary: start ------- 03:53:17 INFO - PID 10136 | Number of tests: 6 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | [#0] dojo.html Cycles:165 Average:6180.54 Median:6404.33 stddev:744.56 (11.6%) stddev-sans-first:705.75 03:53:17 INFO - PID 10136 | Values: 3070.8 3119.5 3126.6 3136.2 3140.6 6185.1 6192.2 6266.8 6311.7 6390.4 6266.4 6297.7 6309.5 6332.8 6399.5 5642.0 5727.8 5751.9 5827.4 5853.4 5651.7 5689.0 5692.6 5714.4 5742.5 5616.6 5651.9 5687.2 5701.8 5713.7 5611.6 5644.6 5658.4 5712.8 5719.2 5534.4 5628.8 5635.5 5682.7 5742.5 6129.5 6160.0 6189.2 6193.6 6194.8 6702.4 6721.1 6741.2 6788.7 6805.7 6710.7 6770.4 6781.3 6849.2 6871.3 6146.0 6209.5 6237.7 6265.3 6310.7 6910.6 6922.6 6923.3 6930.8 6942.4 6466.1 6574.8 6595.8 6622.8 6644.1 6792.1 6823.5 6834.9 6840.6 6844.5 6651.7 6681.4 6685.8 6774.4 6778.2 6397.0 6521.9 6780.9 6850.1 6850.6 5367.7 5460.9 5466.6 5478.1 5479.9 4630.3 4675.0 4700.2 4707.5 4720.5 5769.3 5858.1 5858.4 5859.6 5870.8 6715.7 6736.5 6788.1 6822.1 6826.9 5709.3 5772.3 5778.1 5835.3 5864.9 5882.2 5906.6 5919.0 5929.9 5931.2 6439.3 6508.1 6513.6 6541.7 6550.1 6553.0 6751.8 6802.7 6829.8 6864.5 6491.9 6521.1 6535.8 6546.3 6630.7 6584.2 6619.2 6638.4 6642.1 6649.6 6681.8 6772.1 6774.3 6774.6 6776.2 6464.2 6530.5 6539.2 6551.0 6560.6 6501.3 6529.1 6537.1 6540.2 6649.7 6401.1 6404.3 6417.0 6497.8 6518.9 6503.7 6533.5 6596.9 6611.0 6620.5 6266.6 6350.2 6379.6 6383.5 6387.5 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | [#1] ext.html Cycles:180 Average:38052.44 Median:33554.41 stddev:56935.14 (169.7%) stddev-sans-first:57025.83 03:53:17 INFO - PID 10136 | Values: 713.3 790.2 818.9 1158.7 1181.1 36694.6 40492.4 40573.0 40589.2 40739.6 40579.4 41027.6 41113.4 41145.2 41151.6 7412.6 7558.5 7560.4 7564.5 7572.0 7500.4 7606.7 7619.9 7624.8 7627.4 7030.2 7599.3 7618.7 7622.5 7626.1 7521.7 7561.9 7570.1 7572.1 7588.7 7459.1 7549.4 7553.6 7553.9 7562.2 37922.6 38183.0 38192.0 38748.6 39406.2 3544.5 3593.5 3595.8 3600.2 3600.3 30567.5 30722.2 30771.2 30789.8 30819.8 5006.7 5038.2 5067.0 5069.4 5097.0 228253.0 236049.0 236356.0 237357.0 237959.0 46849.0 46995.0 47045.0 47161.0 47175.5 48594.5 48772.0 48912.8 49107.0 49116.5 15956.4 16269.0 16275.3 16277.7 16284.4 13578.3 13581.3 13589.8 13592.6 13647.6 13256.9 13299.5 13469.6 13575.2 13716.5 4867.7 5491.5 5714.6 5717.7 5775.8 1001.8 1012.5 1021.3 1029.8 1033.6 22663.3 23036.2 23074.4 23322.4 23533.1 1141.3 1142.0 1145.3 1148.0 1154.5 12203.6 12583.4 12587.6 12589.6 12631.7 230133.0 230859.0 230947.0 231248.0 231935.0 49835.0 49989.5 49995.5 50554.5 50628.5 1435.0 1445.5 1480.6 1482.0 1497.6 22671.7 22678.8 22801.0 23009.8 23224.9 36494.6 36536.6 36599.6 36600.5 36642.6 188801.0 189349.0 189378.0 189624.0 189626.0 33226.2 33315.2 33406.2 33496.3 33612.5 35754.5 38943.8 39377.2 41387.8 41533.8 31122.7 31655.5 31848.2 32107.7 32143.0 30790.4 30872.7 30883.5 31189.8 31227.7 33634.7 33646.0 33837.2 33907.8 34029.3 29575.0 29851.0 29962.0 30004.5 30151.7 22210.3 23309.1 24298.6 24978.5 25209.5 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | [#2] jquery.html Cycles:180 Average:36176.34 Median:22725.26 stddev:87354.78 (384.4%) stddev-sans-first:87558.92 03:53:17 INFO - PID 10136 | Values: 568.4 573.2 574.2 576.2 594.1 21481.0 21582.9 22616.0 22720.2 22730.3 26226.5 26959.0 26960.7 27066.2 27080.7 6458.1 6617.5 6623.5 6629.1 6639.0 5731.9 6042.2 6313.5 6449.6 6551.6 6292.6 6295.5 6296.8 6299.7 6299.9 6190.7 6235.1 6279.9 6291.3 6295.4 5869.5 5870.2 5903.2 5904.2 5905.8 28967.3 29276.7 29335.4 30119.0 30664.5 1935.5 1945.1 1957.7 1962.8 1964.9 19118.7 19584.3 19659.3 19708.7 19765.0 2358.8 2406.7 2422.4 2424.2 2472.5 137373.0 145047.3 145065.0 145282.5 145353.3 14766.4 15001.7 15059.6 15160.3 15954.5 22629.8 23980.8 24037.3 24059.6 24062.5 10081.6 10142.8 10223.5 10319.4 10354.8 9397.8 9409.2 9483.7 9584.3 9605.2 9237.8 9589.0 9596.7 9660.8 9739.6 2725.2 2785.5 2802.7 2810.7 2891.4 931.5 982.7 983.1 996.8 1001.3 20220.0 20423.4 20451.0 20692.2 20697.8 1057.4 1062.3 1065.4 1079.0 1080.1 11656.4 13469.7 14477.7 14771.9 14845.3 504340.0 508882.0 516498.0 523318.0 543521.0 113350.0 118987.4 121493.0 122276.0 123707.0 1277.4 1312.2 1323.8 1334.1 1345.9 21254.8 21472.2 22468.3 22499.8 22512.7 58256.0 58912.7 60245.7 60435.7 61634.7 67121.7 67378.3 67867.0 67894.7 68024.0 14774.6 15147.5 15308.6 15319.1 15331.6 23224.7 23239.5 23286.0 23525.0 23615.3 18509.3 18771.8 18931.4 18954.4 18966.8 16889.2 16944.4 16998.7 16999.9 17017.5 18732.3 18775.2 18786.2 18847.1 18965.9 14677.6 14825.3 14910.8 14923.1 14957.4 18345.5 18425.1 18571.3 18714.1 18719.8 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | [#3] mootools.html Cycles:180 Average:8662.36 Median:2588.26 stddev:5918.78 (228.7%) stddev-sans-first:5909.77 03:53:17 INFO - PID 10136 | Values: 1333.8 1407.8 1412.8 1414.2 1420.1 13348.8 13591.9 14153.2 14220.7 14238.0 14477.7 14655.2 14683.8 14707.3 14739.7 2658.3 2735.5 2737.2 2739.8 2742.1 2599.6 2612.1 2663.9 2710.7 2713.3 2705.6 2733.2 2735.5 2735.5 2736.3 2635.2 2662.6 2664.1 2671.1 2677.1 2565.1 2566.6 2586.1 2590.4 2605.0 13566.4 13879.0 13887.4 13890.9 13899.0 7438.7 7673.8 7717.9 7722.3 7722.4 4894.3 4988.6 5022.2 5139.4 5168.5 1772.3 1786.7 1802.0 1826.5 1838.9 22556.2 22690.3 22714.4 22876.5 23059.0 6199.0 6339.2 6456.5 6464.6 6529.1 15340.7 15652.2 15916.8 15934.8 15993.9 7228.3 7452.1 7454.3 7457.7 7463.5 6765.9 6896.5 6908.9 6913.9 6914.0 4840.1 4993.6 5002.5 5034.0 5075.5 1306.5 1332.9 1359.7 1362.2 1366.2 882.6 908.1 910.9 921.2 931.7 7467.1 7584.9 7612.1 7630.3 7656.6 976.6 1000.6 1001.7 1002.4 1006.5 4770.3 5167.6 5183.2 5192.1 5243.9 18281.3 18980.0 19413.4 19420.9 19430.1 19034.6 19119.1 19154.1 19172.1 19330.8 10283.4 10791.3 11011.8 11080.5 11133.2 7991.5 8169.1 8193.5 8232.8 8460.5 16894.5 17149.7 17172.8 17176.5 17478.6 17273.8 17322.1 17590.6 17650.6 17823.4 11232.0 11479.2 11502.3 11505.6 11506.8 12520.2 12705.0 12791.8 12835.9 12847.9 9975.4 10051.8 10056.1 10218.4 10284.3 10301.3 10305.5 10321.0 10370.4 10699.2 9151.8 9166.8 9172.0 9206.8 9211.0 6735.2 6745.2 6783.3 6832.0 6871.2 7169.4 7244.2 7291.2 7365.9 7425.5 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | [#4] prototype.html Cycles:180 Average:5531.08 Median:6097.16 stddev:1550.56 (25.4%) stddev-sans-first:1508.26 03:53:17 INFO - PID 10136 | Values: 501.6 502.8 533.1 534.3 534.9 6229.5 6256.7 6272.9 6336.8 6359.4 5927.9 6045.3 6124.1 6124.9 6153.3 4960.7 4969.6 4989.6 5021.7 5028.8 5005.8 5007.4 5011.6 5018.9 5027.6 4826.6 4932.2 4969.8 4972.9 5002.2 4983.7 4989.0 5001.5 5015.7 5028.6 4389.5 4457.2 4482.6 4488.8 4500.9 5989.9 6022.0 6035.9 6096.6 6109.5 5724.4 5744.3 5754.3 5760.9 5787.7 6592.6 6602.4 6606.9 6614.8 6636.6 4907.6 4914.5 4914.6 4916.6 4928.3 6771.4 6876.9 6898.0 6916.2 7009.2 5052.3 5062.7 5069.3 5070.1 5108.3 5113.8 5129.4 5147.8 5152.9 5197.4 5778.2 5789.4 5800.5 5801.0 5831.3 6561.8 6589.6 6589.7 6641.4 6722.7 1758.4 1773.7 1794.3 1805.4 1809.4 1156.5 1200.6 1200.7 1208.0 1242.1 5596.5 5723.7 5765.9 5781.5 5811.9 6537.6 6564.4 6577.8 6659.6 6673.5 5570.7 5572.4 5731.9 5793.9 5822.2 3517.2 3558.5 3567.8 3605.5 3625.9 6550.4 6553.1 6569.7 6575.0 6622.4 6930.0 6932.9 6971.7 6972.3 6988.5 6506.6 6514.3 6547.7 6574.7 6604.3 6736.2 6769.7 6801.5 6857.4 6883.3 6536.4 6656.7 6677.9 6693.4 6718.5 6468.4 6493.7 6503.4 6519.3 6538.4 5024.3 5024.3 5057.8 5089.1 5140.1 6869.4 6894.7 6906.8 6909.2 6913.8 6606.5 6611.3 6632.0 6643.3 6648.3 6521.3 6534.4 6571.8 6618.8 6638.4 6097.7 6315.4 6447.4 6494.7 6562.5 6336.7 6388.7 6426.8 6550.5 6563.2 6224.0 6264.2 6307.7 6308.7 6312.5 03:53:17 INFO - PID 10136 | 03:53:17 INFO - PID 10136 | [#5] yui.html Cycles:180 Average:23759.63 Median:20273.19 stddev:31406.96 (154.9%) stddev-sans-first:31448.15 03:53:17 INFO - PID 10136 | Values: 897.1 906.0 916.8 926.6 928.2 18594.3 19738.7 19753.6 19763.3 21580.7 21642.4 22015.0 22282.6 22303.2 22483.4 974.7 1002.3 1004.6 1005.9 1007.0 960.1 1049.9 1059.6 1064.5 1065.4 1121.9 1131.2 1131.2 1131.4 1131.6 1125.2 1125.5 1129.9 1130.2 1131.0 808.7 819.7 824.5 825.6 826.4 19426.3 20166.5 20178.9 20197.1 20349.3 21197.6 21494.9 21509.4 21628.2 21911.6 16620.9 16786.1 16799.4 17033.4 17935.5 3692.0 3699.0 3700.1 3700.5 3700.6 126042.0 127418.0 127625.0 129162.4 130073.0 16858.2 17479.4 17502.3 17661.0 18329.1 32188.4 32564.7 32920.3 32922.2 33151.5 7671.0 8106.1 8584.0 8970.9 9043.5 4265.2 4337.4 4349.3 4349.3 4350.7 5177.1 5259.0 5298.7 5336.2 5364.2 1039.1 1065.4 1069.8 1080.1 1082.6 680.6 704.1 705.0 707.5 712.2 11855.6 12359.3 12790.5 12917.3 12991.9 695.7 699.6 701.6 711.5 716.8 5463.5 5508.6 5591.4 5728.4 5737.2 106032.0 106108.0 106222.0 108459.5 108913.5 93638.0 95584.5 96007.5 96295.0 96433.0 76926.0 79018.6 79729.2 79775.6 81178.6 11872.5 11897.1 11959.2 11964.4 12088.9 35935.6 36596.6 36750.0 36814.3 37034.8 66126.0 66471.0 68714.3 69705.0 69752.0 18460.0 19685.3 19695.4 19716.8 19972.5 21080.0 22271.0 22541.0 22785.4 22805.2 18310.5 18418.4 19326.7 19580.8 19832.5 18863.5 19138.3 19410.7 19523.9 19827.8 19258.8 19723.6 19740.0 19797.9 19962.9 13181.8 13708.5 13754.9 13809.0 14051.9 14808.7 15306.5 15417.6 15590.7 15648.8 03:53:17 INFO - PID 10136 | -------- Summary: end -------- 03:53:17 INFO - PID 10136 | 03:53:18 INFO - TEST-INFO | 10136: exit 0 03:53:18 INFO - TEST-OK | dromaeo_css | took 1112981ms 03:53:18 INFO - TEST-START | kraken 03:53:18 INFO - Initialising browser for kraken test... 03:53:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56313/getInfo.html -profile /tmp/tmpqLssoQ/profile 03:53:18 INFO - TEST-INFO | started process 10523 (/builds/slave/test/build/application/firefox/firefox http://localhost:56313/getInfo.html) 03:53:23 INFO - TEST-INFO | 10523: exit 0 03:53:23 INFO - Browser initialized. 03:53:23 INFO - Running cycle 1/1 for kraken test... 03:53:23 INFO - TEST-INFO | started process 10755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqLssoQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:24 INFO - PID 10755 | 03:53:24 INFO - PID 10755 | (/builds/slave/test/build/application/firefox/firefox:10810): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:53:24 INFO - PID 10755 | 03:53:35 INFO - PID 10755 | RSS: Main: 171040768 03:53:35 INFO - PID 10755 | 03:53:37 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-beat-detection) 03:53:38 INFO - PID 10755 | RSS: Main: 175771648 03:53:38 INFO - PID 10755 | 03:53:41 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-dft) 03:53:42 INFO - PID 10755 | RSS: Main: 176025600 03:53:42 INFO - PID 10755 | 03:53:45 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-fft) 03:53:45 INFO - PID 10755 | RSS: Main: 170631168 03:53:45 INFO - PID 10755 | 03:53:47 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56313/tests/kraken/driver.html?testName=audio-oscillator) 03:53:48 INFO - PID 10755 | RSS: Main: 171778048 03:53:48 INFO - PID 10755 | 03:53:50 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56313/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:51 INFO - PID 10755 | RSS: Main: 171499520 03:53:51 INFO - PID 10755 | 03:53:54 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56313/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:55 INFO - PID 10755 | RSS: Main: 174088192 03:53:55 INFO - PID 10755 | 03:53:58 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56313/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:59 INFO - PID 10755 | RSS: Main: 174006272 03:53:59 INFO - PID 10755 | 03:54:02 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56313/tests/kraken/driver.html?testName=json-parse-financial) 03:54:02 INFO - PID 10755 | RSS: Main: 174727168 03:54:02 INFO - PID 10755 | 03:54:04 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56313/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:05 INFO - PID 10755 | RSS: Main: 174559232 03:54:05 INFO - PID 10755 | 03:54:06 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:07 INFO - PID 10755 | RSS: Main: 174292992 03:54:07 INFO - PID 10755 | 03:54:09 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:10 INFO - PID 10755 | RSS: Main: 174690304 03:54:10 INFO - PID 10755 | 03:54:13 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:14 INFO - PID 10755 | RSS: Main: 175316992 03:54:14 INFO - PID 10755 | 03:54:17 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:17 INFO - PID 10755 | RSS: Main: 174952448 03:54:17 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | Cycle 1(1): loaded http://localhost:56313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56313/tests/kraken/driver.html?testName=ai-astar) 03:54:19 INFO - PID 10755 | RSS: Main: 176713728 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | __start_tp_report 03:54:19 INFO - PID 10755 | _x_x_mozilla_page_load 03:54:19 INFO - PID 10755 | _x_x_mozilla_page_load_details 03:54:19 INFO - PID 10755 | |i|pagename|runs| 03:54:19 INFO - PID 10755 | |0;ai-astar;99;116;103;108;113;113;111;104;108;111 03:54:19 INFO - PID 10755 | |1;audio-beat-detection;143;119;139;177;120;144;139;120;165;128 03:54:19 INFO - PID 10755 | |2;audio-dft;163;166;162;166;161;166;165;167;165;162 03:54:19 INFO - PID 10755 | |3;audio-fft;76;75;74;170;79;76;76;74;162;75 03:54:19 INFO - PID 10755 | |4;audio-oscillator;79;79;139;78;80;79;127;80;85;128 03:54:19 INFO - PID 10755 | |5;imaging-gaussian-blur;114;115;114;114;114;120;114;115;116;117 03:54:19 INFO - PID 10755 | |6;imaging-darkroom;150;151;153;152;150;152;150;151;150;153 03:54:19 INFO - PID 10755 | |7;imaging-desaturate;94;94;94;99;94;94;99;94;95;95 03:54:19 INFO - PID 10755 | |8;json-parse-financial;57;53;52;54;53;55;53;54;54;56 03:54:19 INFO - PID 10755 | |9;json-stringify-tinderbox;55;55;55;54;58;54;55;55;55;57 03:54:19 INFO - PID 10755 | |10;stanford-crypto-aes;79;91;78;89;86;77;77;78;87;77 03:54:19 INFO - PID 10755 | |11;stanford-crypto-ccm;132;125;134;140;125;130;137;127;144;161 03:54:19 INFO - PID 10755 | |12;stanford-crypto-pbkdf2;181;174;181;174;173;173;186;180;171;182 03:54:19 INFO - PID 10755 | |13;stanford-crypto-sha256-iterative;68;80;66;68;72;70;67;69;67;67 03:54:19 INFO - PID 10755 | __end_tp_report 03:54:19 INFO - PID 10755 | __start_cc_report 03:54:19 INFO - PID 10755 | _x_x_mozilla_cycle_collect,902 03:54:19 INFO - PID 10755 | __end_cc_report 03:54:19 INFO - PID 10755 | __startTimestamp1502276059872__endTimestamp 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | ------- Summary: start ------- 03:54:19 INFO - PID 10755 | Number of tests: 14 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#0] ai-astar Cycles:10 Average:108.60 Median:112.00 stddev:5.27 (4.7%) stddev-sans-first:4.30 03:54:19 INFO - PID 10755 | Values: 99.0 116.0 103.0 108.0 113.0 113.0 111.0 104.0 108.0 111.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:141.00 stddev:19.44 (13.8%) stddev-sans-first:20.58 03:54:19 INFO - PID 10755 | Values: 143.0 119.0 139.0 177.0 120.0 144.0 139.0 120.0 165.0 128.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.50 stddev:2.11 (1.3%) stddev-sans-first:2.19 03:54:19 INFO - PID 10755 | Values: 163.0 166.0 162.0 166.0 161.0 166.0 165.0 167.0 165.0 162.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:38.18 (50.6%) stddev-sans-first:39.95 03:54:19 INFO - PID 10755 | Values: 76.0 75.0 74.0 170.0 79.0 76.0 76.0 74.0 162.0 75.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.00 stddev:25.07 (31.7%) stddev-sans-first:25.87 03:54:19 INFO - PID 10755 | Values: 79.0 79.0 139.0 78.0 80.0 79.0 127.0 80.0 85.0 128.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.95 (1.7%) stddev-sans-first:2.01 03:54:19 INFO - PID 10755 | Values: 114.0 115.0 114.0 114.0 114.0 120.0 114.0 115.0 116.0 117.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.50 stddev:1.23 (0.8%) stddev-sans-first:1.22 03:54:19 INFO - PID 10755 | Values: 150.0 151.0 153.0 152.0 150.0 152.0 150.0 151.0 150.0 153.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.04 (2.2%) stddev-sans-first:2.12 03:54:19 INFO - PID 10755 | Values: 94.0 94.0 94.0 99.0 94.0 94.0 99.0 94.0 95.0 95.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.52 (2.8%) stddev-sans-first:1.20 03:54:19 INFO - PID 10755 | Values: 57.0 53.0 52.0 54.0 53.0 55.0 53.0 54.0 54.0 56.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.32 03:54:19 INFO - PID 10755 | Values: 55.0 55.0 55.0 54.0 58.0 54.0 55.0 55.0 55.0 57.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:5.65 (6.8%) stddev-sans-first:5.89 03:54:19 INFO - PID 10755 | Values: 79.0 91.0 78.0 89.0 86.0 77.0 77.0 78.0 87.0 77.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:135.50 stddev:10.97 (8.1%) stddev-sans-first:11.56 03:54:19 INFO - PID 10755 | Values: 132.0 125.0 134.0 140.0 125.0 130.0 137.0 127.0 144.0 161.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:180.50 stddev:5.06 (2.8%) stddev-sans-first:5.21 03:54:19 INFO - PID 10755 | Values: 181.0 174.0 181.0 174.0 173.0 173.0 186.0 180.0 171.0 182.0 03:54:19 INFO - PID 10755 | 03:54:19 INFO - PID 10755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.50 stddev:4.12 (6.0%) stddev-sans-first:4.33 03:54:19 INFO - PID 10755 | Values: 68.0 80.0 66.0 68.0 72.0 70.0 67.0 69.0 67.0 67.0 03:54:19 INFO - PID 10755 | -------- Summary: end -------- 03:54:19 INFO - PID 10755 | 03:54:20 INFO - PID 10755 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:54:20 INFO - TEST-INFO | 10755: exit 0 03:54:20 INFO - TEST-OK | kraken | took 62442ms 03:54:20 INFO - SUITE-END | took 1175s 03:54:21 INFO - Completed test suite (00:19:35) 03:54:21 INFO - javascript benchmark 03:54:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8531.315395300031, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.7543396528295, 3119.5476655884895, 3126.593542839433, 3136.200268931422, 3140.607424071991, 6185.103160041797, 6192.1950146481, 6266.84332891678, 6311.747530098791, 6390.3929126733, 6266.404691554295, 6297.716602752876, 6309.4636955858805, 6332.841678958017, 6399.488040956724, 5642.04085305497, 5727.828165155052, 5751.884962300762, 5827.358990511061, 5853.356130825606, 5651.745671444774, 5689.032864413039, 5692.629979051369, 5714.428557144273, 5742.54059675225, 5616.5787565932715, 5651.886962260753, 5687.17535957286, 5701.77192912283, 5713.71431428429, 5611.607187496877, 5644.576656750719, 5658.377578466366, 5712.82861514151, 5719.19931209631, 5534.391216966131, 5628.802991895264, 5635.520980716603, 5682.6590404575445, 5742.483176514133, 6129.540284478682, 6160.0, 6189.195404597419, 6193.566450348478, 6194.783182588588, 6702.4302934250645, 6721.126253587003, 6741.157355330583, 6788.72845086196, 6805.6597170141295, 6710.731570737214, 6770.424513916323, 6781.25406205317, 6849.2465828758795, 6871.312868713138, 6145.985912324461, 6209.5032397408095, 6237.688115594202, 6265.310815810257, 6310.652914089723, 6910.619915904674, 6922.58464492122, 6923.273056329013, 6930.792076237721, 6942.409895158867, 6466.127072845105, 6574.835629109215, 6595.835104122435, 6622.768203112868, 6644.103046088716, 6792.08306878575, 6823.522353435311, 6834.863302733917, 6840.623765692835, 6844.452443804484, 6651.700673469705, 6681.365270299314, 6685.76599819004, 6774.42417394527, 6778.18661760582, 6396.976483762575, 6521.934780652133, 6780.864382712318, 6850.109485766819, 6850.623215723183, 5367.704776237267, 5460.918086228709, 5466.562674985991, 5478.068728316196, 5479.863003424946, 4630.32860235264, 4675.041616468616, 4700.153972285021, 4707.5057119002695, 4720.527947205321, 5769.307683078057, 5858.121281807763, 5858.443447872445, 5859.648421094748, 5870.823875283749, 6715.6977935993, 6736.528443008942, 6788.1175447191545, 6822.147231596051, 6826.863462730717, 5709.286339207599, 5772.336181339116, 5778.133280007948, 5835.328937172195, 5864.882702346014, 5882.176495290662, 5906.645601263852, 5919.0, 5929.881402371929, 5931.228940237742, 6439.291677915426, 6508.056331831953, 6513.576617519846, 6541.705623246965, 6550.050242714779, 6552.967235163794, 6751.831204219836, 6802.6598670065305, 6829.829254268683, 6864.450843932374, 6491.935080649133, 6521.054447105238, 6535.771248006297, 6546.279909209888, 6630.734770609121, 6584.209894812653, 6619.172603424572, 6638.402543771083, 6642.136522252076, 6649.567778094409, 6681.799546013627, 6772.051912732123, 6774.288699686659, 6774.627395493295, 6776.220734615582, 6464.159659244268, 6530.47756179495, 6539.21529416454, 6550.967245163743, 6560.606363618198, 6501.284858665637, 6529.085927970183, 6537.117489139096, 6540.182477190351, 6649.700763465752, 6401.071844582602, 6404.327545607644, 6417.03744438338, 6497.837554061186, 6518.934810651833, 6503.739850405931, 6533.509986750918, 6596.90104648421, 6610.966945165435, 6620.470362370903, 6266.561340706289, 6350.237971443456, 6379.553431259767, 6383.521235907233, 6387.520935929917], "value": 6123.369664798638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2902761752058, 790.162427826504, 818.8526065308243, 1158.7276989907375, 1181.149572307938, 36694.63305366949, 40492.39261411081, 40573.0, 40589.18821623569, 40739.59260407395, 40579.39130913031, 41027.58972410275, 41113.383299250534, 41145.17709645805, 41151.58848411515, 7412.55524668519, 7558.47090703651, 7560.395168386516, 7564.546127232356, 7572.0, 7500.362469190098, 7606.73376431825, 7619.885701714478, 7624.847503049936, 7627.389808815282, 7030.156381234259, 7599.316061554459, 7618.73334433295, 7622.4664273500875, 7626.122995855464, 7521.736739214129, 7561.924380756177, 7570.091589009354, 7572.129205141424, 7588.734394296201, 7459.067616547932, 7549.3583045440655, 7553.584552849591, 7553.924460755377, 7562.205968373297, 37922.62077379219, 38183.0, 38192.0, 38748.612513875065, 39406.211875762325, 3544.521489598897, 3593.5148754918014, 3595.7842529448053, 3600.1719604491113, 3600.297941901304, 30567.541486877715, 30722.23194420135, 30771.230719231975, 30789.846050769826, 30819.845900770575, 5006.674566153189, 5038.2190760432195, 5067.0, 5069.417017043051, 5097.0, 228253.0, 236049.0, 236356.0, 237356.99999999828, 237959.0, 46849.0, 46995.0, 47045.0, 47161.0, 47175.52824471711, 48594.514054859705, 48772.0, 48912.75543622259, 49107.0, 49116.50883491119, 15956.441524546584, 16269.0, 16275.267612957445, 16277.674446511004, 16284.43004494837, 13578.253196074113, 13581.253031083384, 13589.796153057712, 13592.592222233348, 13647.590572282847, 13256.867431325756, 13299.468021279234, 13469.595912122651, 13575.185488870698, 13716.451341946211, 4867.70389455948, 5491.505764481216, 5714.571407144397, 5717.742701578439, 5775.768969241183, 1001.7946321004323, 1012.4532752313816, 1021.3412349034979, 1029.840374741916, 1033.5555711044324, 22663.320100397013, 23036.193733219257, 23074.423139421648, 23322.416939576306, 23533.0586776527, 1141.2752901907184, 1141.9543218271342, 1145.2970988467212, 1147.9942600286945, 1154.509333533245, 12203.633890983285, 12583.370831458573, 12587.622371328875, 12589.559365422167, 12631.747365052832, 230133.0, 230859.0, 230947.0, 231248.0, 231935.0, 49835.0, 49989.500104998486, 49995.50004499981, 50554.49445505571, 50628.493715063116, 1434.9571787416573, 1445.515752222996, 1480.6076389756722, 1481.9925900370429, 1497.622860449679, 22671.659925101467, 22678.773212267664, 22801.0, 23009.769902301432, 23224.883875580515, 36494.635053650185, 36536.63463365439, 36599.63400365962, 36600.45099323459, 36642.633573664985, 188801.0, 189349.0, 189378.0, 189624.0, 189626.0, 33226.169345765586, 33315.167120822174, 33406.164845879044, 33496.33007339888, 33612.495812562345, 35754.463683044254, 38943.805280973414, 39377.212455751294, 41387.7930610345, 41533.79233103936, 31122.68877311198, 31655.52516712205, 31848.203794905312, 32107.678923210467, 32143.0, 30790.38419231558, 30872.69127308698, 30883.536746948364, 31189.8440507796, 31227.68772312248, 33634.66365336315, 33645.99062028143, 33837.15407114842, 33907.83046084754, 34029.31941361209, 29575.0, 29851.0, 29962.0, 30004.549931751477, 30151.698483015767, 22210.333689989326, 23309.06763729432, 24298.63552046756, 24978.50042999166, 25209.49581008333], "value": 17014.404139808797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4173721935016, 573.1860757724031, 574.1760573576914, 576.1760682224417, 594.126633848243, 21481.0, 21582.892085539588, 22616.0, 22720.204792832254, 22730.318090457273, 26226.47547049058, 26959.0, 26960.730392696118, 27066.18801435955, 27080.729192708066, 6458.095866578683, 6617.470602351825, 6623.5032372572, 6629.105070815451, 6639.0, 5731.885362292752, 6042.184305118797, 6313.526485513582, 6449.645269510175, 6551.639659818708, 6292.590981586205, 6295.527835412339, 6296.811095667137, 6299.65351905645, 6299.937000630004, 6190.690465476709, 6235.095911092866, 6279.937200628004, 6291.33940936202, 6295.370462953714, 5869.50109240715, 5870.178175055496, 5903.232579764646, 5904.2029326040865, 5905.822825315247, 28967.275818104506, 29276.707232927612, 29335.413291734047, 30119.0, 30664.540031899538, 1935.4677463697456, 1945.1246938877562, 1957.7063440483898, 1962.80371962804, 1964.9115789789494, 19118.71321930172, 19584.31454899086, 19659.311924082587, 19708.70436943447, 19765.0, 2358.811295096388, 2406.6630671705975, 2422.358075110097, 2424.1636635360774, 2472.4807790363866, 137373.0, 145047.27476362657, 145065.0, 145282.54717452795, 145353.27323363317, 14766.409343626136, 15001.699966000837, 15059.623509412133, 15160.31778569945, 15954.521364359089, 22629.773702263097, 23980.7601923982, 24037.278881633578, 24059.639105413433, 24062.51874962491, 10081.596736130472, 10142.847857282146, 10223.488825558692, 10319.432431216355, 10354.844677329846, 9397.76505587352, 9409.153176214037, 9483.668071617598, 9584.28117891161, 9605.231581473465, 9237.769055773526, 9588.952055239679, 9596.66411675588, 9660.806783864284, 9739.56171972263, 2725.1824452664123, 2785.470760555488, 2802.7477527022666, 2810.718928107173, 2891.407261511385, 931.5202670624634, 982.7051884434641, 983.1053741095569, 996.7757254617653, 1001.2890847498212, 20220.0, 20423.387298381072, 20451.0, 20692.172313107607, 20697.793022069887, 1057.4078516031047, 1062.2670357453333, 1065.3820783945293, 1079.0450451350455, 1080.1466841195368, 11656.358900260397, 13469.730605388033, 14477.710445791025, 14771.926140369444, 14845.331960061607, 504340.0, 508882.0, 516498.0, 523318.0, 543521.0, 113350.0, 118987.40506297413, 121493.0, 122276.0, 123707.0, 1277.431542963391, 1312.2061153002487, 1323.8212841266306, 1334.106148880272, 1345.8923286137085, 21254.78745212528, 21472.208612880226, 22468.32595022152, 22499.775002249768, 22512.66231006569, 58256.0, 58912.70543647254, 60245.698771505864, 60435.697821510614, 61634.691826540584, 67121.66439167772, 67378.3262167372, 67867.0, 67894.66052669704, 68024.0, 14774.556763297118, 15147.469838555598, 15308.617284567976, 15319.080855148726, 15331.61670958235, 23224.651630225224, 23239.535209296057, 23286.0, 23525.0, 23615.29154125379, 18509.259629614666, 18771.812281877552, 18931.43205703831, 18954.43136705901, 18966.810331896504, 16889.239984200987, 16944.40694575684, 16998.745018824975, 16999.91500042492, 17017.48947531576, 18732.25070997145, 18775.155118019447, 18786.248550057844, 18847.057647117865, 18965.90517047406, 14677.633059173178, 14825.332860021541, 14910.776338354717, 14923.104613723212, 14957.40170393172, 18345.54136146607, 18425.07874606291, 18571.25714971386, 18714.06429678538, 18719.812801871805], "value": 12266.173376899069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.7665908466017, 1407.7817938219573, 1412.816333876596, 1414.1939094716015, 1420.1479112532481, 13348.799768003488, 13591.932040339796, 14153.22157281349, 14220.715585688293, 14238.0, 14477.710445791077, 14655.193964331958, 14683.779743303832, 14707.264636768172, 14739.705205895876, 2658.2822637887807, 2735.534959056965, 2737.2472570043296, 2739.7534221920023, 2742.1088146352517, 2599.6100584912224, 2612.1379944618325, 2663.8934442622367, 2710.7424794644476, 2713.3216695826045, 2705.648265725453, 2733.1937078561873, 2735.493933622286, 2735.5076086304457, 2736.2885649731115, 2635.169921474729, 2662.5739881618847, 2664.0675763482627, 2671.131882138303, 2677.0897894715695, 2565.076572433922, 2566.576514875062, 2586.1336452288506, 2590.378309205796, 2605.0, 13566.389512471962, 13879.028468007244, 13887.4445022199, 13890.930545347208, 13899.0, 7438.66526006331, 7673.808154796119, 7717.922820771832, 7722.304992550641, 7722.382209423289, 4894.290327902434, 4988.575971042465, 5022.221555658843, 5139.408967968694, 5168.508991645787, 1772.3265159239536, 1786.7051936430473, 1801.9909900450546, 1826.488583196707, 1838.9080545972647, 22556.210532631445, 22690.319290421314, 22714.43213919665, 22876.542469150525, 23059.0, 6199.0, 6339.207599050119, 6456.451201647913, 6464.644444555594, 6529.11856899322, 15340.693186136215, 15652.217389130497, 15916.76124858128, 15934.760978585331, 15993.920030400006, 7228.349448549656, 7452.105747310249, 7454.329110380092, 7457.701691932262, 7463.477556571096, 6765.898511522331, 6896.482763792736, 6908.861822763517, 6913.861722765517, 6913.965430172817, 4840.104580652591, 4993.550580447777, 5002.549770520671, 5034.0, 5075.5178258065425, 1306.5296493262417, 1332.9266890320932, 1359.7416490866703, 1362.1826903857607, 1366.187118664393, 882.5719526029999, 908.1191244492832, 910.9498977556298, 921.2123634292583, 931.7251410833685, 7467.141278752904, 7584.862270659335, 7612.086549614081, 7630.2751238632245, 7656.578888161093, 976.5995941663883, 1000.6197644895038, 1001.6544292219173, 1002.4286156890648, 1006.5168719014914, 4770.308305295713, 5167.612429067835, 5183.170692689152, 5192.1173400522, 5243.947560524422, 18281.268749250146, 18980.0, 19413.417597471816, 19420.902895485433, 19430.125644346037, 19034.619307614048, 19119.13963871629, 19154.138063787163, 19172.13725382361, 19330.84014959107, 10283.382997020202, 10791.298565593212, 11011.779764404668, 11080.501377438035, 11133.220674552704, 7991.480553763987, 8169.142240064945, 8193.46742461738, 8232.842414580598, 8460.53467059293, 16894.49316520506, 17149.742753858452, 17172.828271717623, 17176.484705458857, 17478.563035924202, 17273.827261727223, 17322.133893305538, 17590.560235994202, 17650.64698705993, 17823.376181834094, 11232.0, 11479.196456247982, 11502.252353596989, 11505.597304094317, 11506.827397588875, 12520.248785072925, 12705.047121466112, 12791.80812287835, 12835.935820321212, 12847.871521285042, 9975.401475911469, 10051.849222261526, 10056.145227655732, 10218.38689678592, 10284.331518451278, 10301.278910476494, 10305.484725763832, 10321.019503147189, 10370.377777333384, 10699.197560182862, 9151.816963660822, 9166.816663666556, 9171.954140229256, 9206.769830754285, 9210.95394523023, 6735.191776986793, 6745.156855393076, 6783.287754785873, 6832.0435139081565, 6871.175458944958, 7169.3906017986965, 7244.166920804175, 7291.234420385783, 7365.852682946418, 7425.480216384801], "value": 6330.809889732998, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.6162635583779, 502.8290381270367, 533.0910797090959, 534.3347532322255, 534.8636097795062, 6229.532785041118, 6256.6871656417225, 6272.905906411407, 6336.809895703131, 6359.421216723963, 5927.881442371161, 6045.27456705196, 6124.081387791834, 6124.908126378096, 6153.261608606962, 4960.727160006199, 4969.627277954168, 4989.600831933455, 5021.748912554376, 5028.7737051832755, 5005.799768009275, 5007.37407824022, 5011.599072074244, 5018.874528136807, 5027.581244753566, 4826.589739872115, 4932.210846264598, 4969.776360063805, 4972.875678108058, 5002.1746411842005, 4983.676061056056, 4989.0, 5001.524855138756, 5015.724135172564, 5028.5977121830165, 4389.517153113155, 4457.1977044132045, 4482.618977386926, 4488.7531185784765, 4500.8874778130485, 5989.940100598982, 6022.0, 6035.8792824143275, 6096.603720758137, 6109.5112391008615, 5724.39893811148, 5744.339400968858, 5754.3094828620415, 5760.913586296209, 5787.681677507735, 6592.571482853599, 6602.438792702626, 6606.900896486556, 6614.834629134262, 6636.634985075819, 4907.582855457291, 4914.454129929836, 4914.625982875244, 4916.575082425809, 4928.28539861718, 6771.356721111487, 6876.931230687729, 6897.9655101724675, 6916.20463646677, 7009.1589009319205, 5052.292679024939, 5062.7215503146945, 5069.31564238823, 5070.138076527, 5108.259302401131, 5113.769880355393, 5129.384473863086, 5147.819826306136, 5152.896942061137, 5197.402298735694, 5778.248827652378, 5789.363170051291, 5800.535957123504, 5801.0, 5831.300243970751, 6561.835954101186, 6589.571677840925, 6589.736410543621, 6641.369069938348, 6722.697478613474, 1758.384565402099, 1773.6896043192648, 1794.3312719171297, 1805.3861687026474, 1809.3896432175375, 1156.4969238381332, 1200.6372766909622, 1200.6638141320445, 1207.9516819327305, 1242.1243023668292, 5596.468335508121, 5723.656580605177, 5765.85585360361, 5781.508571771446, 5811.912821307684, 6537.607743535403, 6564.442022428051, 6577.769778057745, 6659.633720145439, 6673.499487538454, 5570.749316280777, 5572.3870374258795, 5731.942680573225, 5793.94206057934, 5822.155787410802, 3517.2086280587173, 3558.5018097466377, 3567.8216089195957, 3605.4676762375884, 3625.927481450409, 6550.377714117151, 6553.148090748267, 6569.704363303663, 6574.967125164344, 6622.437092847162, 6929.99515070312, 6932.861342773116, 6971.6862741176765, 6972.267911869282, 6988.545744526589, 6506.60960342381, 6514.283428822826, 6547.723193977129, 6574.671266436659, 6604.3395660434535, 6736.225334086446, 6769.661516924036, 6801.489888258499, 6857.382835544825, 6883.346082122191, 6536.444402225864, 6656.667166641745, 6677.866442671022, 6693.431058360094, 6718.529702920749, 6468.3855033771715, 6493.707783149675, 6503.414692677682, 6519.315471875385, 6538.378854008862, 5024.321716568216, 5024.321716568363, 5057.7724002419245, 5089.13484707608, 5140.126178549581, 6869.381755642016, 6894.724211031503, 6906.786860015487, 6909.170899492093, 6913.827154321182, 6606.504512161703, 6611.2727599963, 6631.966840165768, 6643.3356664335115, 6648.335166483313, 6521.282658907611, 6534.379233972765, 6571.835704107244, 6618.8345291368105, 6638.369354911276, 6097.725602347817, 6315.400036996478, 6447.3552644735155, 6494.675266236574, 6562.5406221565945, 6336.683165841781, 6388.712507937247, 6426.807195784134, 6550.541462097607, 6563.212414510289, 6223.985529333645, 6264.21697287839, 6307.747690092345, 6308.71610777507, 6312.5265605078885], "value": 5075.360628653015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.0715309654505, 905.9592318345674, 916.7799728065266, 926.5552534783304, 928.2295694573505, 18594.34919777808, 19738.70391944122, 19753.604927901433, 19763.308284210056, 21580.676289855626, 21642.35072947814, 22015.0, 22282.55434891301, 22303.219387321446, 22483.437914052116, 974.7173319737285, 1002.3234316836143, 1004.6132239087967, 1005.9094681478665, 1006.993006993007, 960.140674096683, 1049.9160067194643, 1059.5549869054978, 1064.4890452582727, 1065.4353192807823, 1121.938293393867, 1131.1742428027544, 1131.2477202660261, 1131.4173200801595, 1131.5869707556724, 1125.2460851229696, 1125.5216532973454, 1129.8983091521761, 1130.2370899642708, 1131.032966813379, 808.6846130009301, 819.713100414856, 824.5135370131651, 825.5954582254712, 826.4008593769529, 19426.320078797315, 20166.49583760403, 20178.899105504526, 20197.091130899145, 20349.287774927954, 21197.5760484791, 21494.892525537427, 21509.354719358445, 21628.24301149468, 21911.561768764695, 16620.916895415445, 16786.076765777878, 16799.412020579344, 17033.40383086586, 17935.461936141935, 3692.040069581901, 3698.9815050924844, 3700.1489657378684, 3700.5374328208973, 3700.5744339401044, 126042.0, 127418.0, 127625.0, 129162.3541882294, 130073.0, 16858.157092145342, 17479.38822141219, 17502.299908003537, 17661.0, 18329.083545822654, 32188.356232875212, 32564.674353256163, 32920.341593168, 32922.17694557607, 33151.502727459105, 7671.0, 8106.108328083906, 8583.957080214559, 8970.910290897138, 9043.457392556467, 4265.210935976792, 4337.392765012901, 4349.304111342233, 4349.3475978603465, 4350.695451318377, 5177.068127737043, 5259.0, 5298.655587386807, 5336.199570064444, 5364.222187782828, 1039.1219419590434, 1065.3927261460892, 1069.8181309177303, 1080.0873262093519, 1082.588616325807, 680.6460640466929, 704.0671110778137, 704.9753258636026, 707.5012116457988, 712.154366421329, 11855.644330670093, 12359.25844449318, 12790.488380464678, 12917.28954907489, 12991.870081299066, 695.6765104226558, 699.5837476701355, 701.554512884312, 711.4592909388901, 716.8458781362032, 5463.453654634504, 5508.55931525477, 5591.412901645269, 5728.427157284322, 5737.168110623936, 106032.0, 106108.0, 106222.0, 108459.45770271098, 108913.45543272392, 93638.0, 95584.52207739056, 96007.51996239975, 96295.03704963, 96433.0, 76926.0, 79018.6049069751, 79729.20270797334, 79775.60112199401, 81178.59410702909, 11872.52509899629, 11897.107716921439, 11959.162858599815, 11964.401779911144, 12088.939555302168, 35935.64064359323, 36596.63403365932, 36750.0, 36814.26371472609, 37034.8148259257, 66126.0, 66471.0, 68714.31285687079, 69705.0, 69752.0, 18460.0, 19685.31101411444, 19695.409137725892, 19716.802831971498, 19972.50068748293, 21080.0, 22271.0, 22541.0, 22785.430364241027, 22805.201817936293, 18310.542236444195, 18418.35535756242, 19326.710099348238, 19580.80419195847, 19832.50418739543, 18863.528411789815, 19138.330158444387, 19410.708839367137, 19523.902380488005, 19827.801721982596, 19258.8074119257, 19723.60552788965, 19740.0, 19797.901010494854, 19962.900185499562, 13181.802272966104, 13708.451661933412, 13754.93122534381, 13809.0, 14051.929740351234, 14808.703825923205, 15306.540803775904, 15417.614559636098, 15590.688186236439, 15648.843511564739], "value": 9389.158033626609, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 116.0, 103.0, 108.0, 113.0, 113.0, 111.0, 104.0, 108.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 139.0, 177.0, 120.0, 144.0, 139.0, 120.0, 165.0, 128.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 166.0, 161.0, 166.0, 165.0, 167.0, 165.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 170.0, 79.0, 76.0, 76.0, 74.0, 162.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 139.0, 78.0, 80.0, 79.0, 127.0, 80.0, 85.0, 128.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 120.0, 114.0, 115.0, 116.0, 117.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 153.0, 152.0, 150.0, 152.0, 150.0, 151.0, 150.0, 153.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 99.0, 94.0, 94.0, 99.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 52.0, 54.0, 53.0, 55.0, 53.0, 54.0, 54.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 58.0, 54.0, 55.0, 55.0, 55.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 91.0, 78.0, 89.0, 86.0, 77.0, 77.0, 78.0, 87.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 134.0, 140.0, 125.0, 130.0, 137.0, 127.0, 144.0, 161.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 174.0, 181.0, 174.0, 173.0, 173.0, 186.0, 180.0, 171.0, 182.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 80.0, 66.0, 68.0, 72.0, 70.0, 67.0, 69.0, 67.0, 67.0], "value": 69.4, "unit": "score"}]}]} 03:54:21 INFO - Return code: 0 03:54:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:21 INFO - # TBPL SUCCESS # 03:54:21 INFO - Running post-action listener: _package_coverage_data 03:54:21 INFO - Running post-action listener: _resource_record_post_action 03:54:21 INFO - [mozharness: 2017-08-09 10:54:21.166091Z] Finished run-tests step (success) 03:54:21 INFO - Running post-run listener: _resource_record_post_run 03:54:21 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 430301184; Read time: 108; Write time: 301540 03:54:21 INFO - TinderboxPrint: CPU usage
13.2% 03:54:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 108 03:54:21 INFO - TinderboxPrint: I/O write bytes / time
430,301,184 / 301,540 03:54:21 INFO - TinderboxPrint: CPU idle
8,265.2 (86.8%) 03:54:21 INFO - TinderboxPrint: CPU user
1,204.7 (12.7%) 03:54:21 INFO - TinderboxPrint: Swap in / out
0 / 0 03:54:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107626496; Read time: 0; Write time: 95992 03:54:21 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:21 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322674688; Read time: 88; Write time: 205548 03:54:21 INFO - Running post-run listener: _upload_blobber_files 03:54:21 INFO - Blob upload gear active. 03:54:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:21 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:21 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:21 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:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:54:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:54:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:54:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:23 INFO - (blobuploader) - INFO - Done attempting. 03:54:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:54:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:26 INFO - (blobuploader) - INFO - Done attempting. 03:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:54:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:26 INFO - (blobuploader) - INFO - Done attempting. 03:54:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:54:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:54:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:54:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:54:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:54:28 INFO - (blobuploader) - INFO - Done attempting. 03:54:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:54:28 INFO - Return code: 0 03:54:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:54:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:54:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/544cab5215db41977ebc7680d17d8c5b6405518aa628fcf6d2a76d514b16cde1d196d8e84c8eaf39c4b9c3430c91e0b85493a2e0176ab534df2e299fbc90974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a34f47768ca31e771959748e66236341fca8942c718d8cb6f7ceca48855ddb56591ceeb60626b6c1f85f6a692b9d1a3eb90ca96f6780db5ceaaf22993c5620", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0b8f9471f24f5fc69415fbaf817752ee89b422d88021ceff0596167416799b4f9f9cf71257f25134e53e23dd9ba0bec2f025bc1a7436739b7ffe63a6b42fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08e2248dd933685cd0d6499a4496fbc86b311a033825190de28296a9219a3311e674d3455e540f72597016cf6d1ce463eed81d51bb397ae6d9ef6a08393a55c"} 03:54:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:54:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:54:28 INFO - Contents: 03:54:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/544cab5215db41977ebc7680d17d8c5b6405518aa628fcf6d2a76d514b16cde1d196d8e84c8eaf39c4b9c3430c91e0b85493a2e0176ab534df2e299fbc90974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a34f47768ca31e771959748e66236341fca8942c718d8cb6f7ceca48855ddb56591ceeb60626b6c1f85f6a692b9d1a3eb90ca96f6780db5ceaaf22993c5620", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0b8f9471f24f5fc69415fbaf817752ee89b422d88021ceff0596167416799b4f9f9cf71257f25134e53e23dd9ba0bec2f025bc1a7436739b7ffe63a6b42fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08e2248dd933685cd0d6499a4496fbc86b311a033825190de28296a9219a3311e674d3455e540f72597016cf6d1ce463eed81d51bb397ae6d9ef6a08393a55c"} 03:54:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:54:28 INFO - Copying logs to upload dir... 03:54:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:54:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.813034 ========= master_lag: -0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-09 03:54:27.556575) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:27.564153) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152 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/544cab5215db41977ebc7680d17d8c5b6405518aa628fcf6d2a76d514b16cde1d196d8e84c8eaf39c4b9c3430c91e0b85493a2e0176ab534df2e299fbc90974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a34f47768ca31e771959748e66236341fca8942c718d8cb6f7ceca48855ddb56591ceeb60626b6c1f85f6a692b9d1a3eb90ca96f6780db5ceaaf22993c5620", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0b8f9471f24f5fc69415fbaf817752ee89b422d88021ceff0596167416799b4f9f9cf71257f25134e53e23dd9ba0bec2f025bc1a7436739b7ffe63a6b42fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08e2248dd933685cd0d6499a4496fbc86b311a033825190de28296a9219a3311e674d3455e540f72597016cf6d1ce463eed81d51bb397ae6d9ef6a08393a55c"} build_url:https://queue.taskcluster.net/v1/task/dDqfdbhSQbS4bo4eXSd8Dg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 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/544cab5215db41977ebc7680d17d8c5b6405518aa628fcf6d2a76d514b16cde1d196d8e84c8eaf39c4b9c3430c91e0b85493a2e0176ab534df2e299fbc90974a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06a34f47768ca31e771959748e66236341fca8942c718d8cb6f7ceca48855ddb56591ceeb60626b6c1f85f6a692b9d1a3eb90ca96f6780db5ceaaf22993c5620", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0b8f9471f24f5fc69415fbaf817752ee89b422d88021ceff0596167416799b4f9f9cf71257f25134e53e23dd9ba0bec2f025bc1a7436739b7ffe63a6b42fc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c08e2248dd933685cd0d6499a4496fbc86b311a033825190de28296a9219a3311e674d3455e540f72597016cf6d1ce463eed81d51bb397ae6d9ef6a08393a55c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:27.591639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:27.592104) ========= 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=9f7544b6a75ada7b6b576032000001a7-1502261046.584770-144521152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 03:54:27.675719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 03:54:27.676106) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 03:54:27.679595) ========= ========= Total master_lag: -0.12 =========