builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-081 starttime: 1502193941.76 results: success (0) revision: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.761483) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.761864) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.762153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.780893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.781180) ========= 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=483e410453545d07cca6935c000001ab-1502193804.354225-1683656443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 05:05:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-08-08 05:05:42 (69.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.968025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:41.968308) ========= 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=483e410453545d07cca6935c000001ab-1502193804.354225-1683656443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014979 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:42.025272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-08 05:05:42.025649) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c7788eda00e4cb4445638bdb7500009cd4cbe59 --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 8c7788eda00e4cb4445638bdb7500009cd4cbe59 --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=483e410453545d07cca6935c000001ab-1502193804.354225-1683656443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 05:05:42,345 truncating revision to first 12 chars 2017-08-08 05:05:42,345 Setting DEBUG logging. 2017-08-08 05:05:42,345 attempt 1/10 2017-08-08 05:05:42,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c7788eda00e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 05:05:43,646 unpacking tar archive at: mozilla-central-8c7788eda00e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-08 05:05:43.638883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:43.639206) ========= script_repo_revision: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:43.639601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:43.639878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 05:05:43.649215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-08 05:05:43.649527) ========= /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=483e410453545d07cca6935c000001ab-1502193804.354225-1683656443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:05:44 INFO - MultiFileLogger online at 20170808 05:05:44 in /builds/slave/test 05:05:44 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 05:05:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:44 INFO - {'append_to_log': False, 05:05:44 INFO - 'base_work_dir': '/builds/slave/test', 05:05:44 INFO - 'blob_upload_branch': 'Firefox', 05:05:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:44 INFO - 'branch': 'Firefox', 05:05:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:44 INFO - 'code_coverage': False, 05:05:44 INFO - 'config_files': ('talos/linux_config.py',), 05:05:44 INFO - 'default_actions': ('clobber', 05:05:44 INFO - 'read-buildbot-config', 05:05:44 INFO - 'download-and-extract', 05:05:44 INFO - 'populate-webroot', 05:05:44 INFO - 'create-virtualenv', 05:05:44 INFO - 'install', 05:05:44 INFO - 'setup-mitmproxy', 05:05:44 INFO - 'run-tests'), 05:05:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:44 INFO - 'disable_ccov_upload': False, 05:05:44 INFO - 'download_minidump_stackwalk': True, 05:05:44 INFO - 'download_symbols': 'ondemand', 05:05:44 INFO - 'enable_stylo': False, 05:05:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:44 INFO - 'gecko_profile': False, 05:05:44 INFO - 'gecko_profile_interval': 0, 05:05:44 INFO - 'installer_path': 'installer.exe', 05:05:44 INFO - 'log_level': 'info', 05:05:44 INFO - 'log_name': 'talos', 05:05:44 INFO - 'log_to_console': True, 05:05:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:05:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:05:44 INFO - 'opt_config_files': (), 05:05:44 INFO - 'pip_index': False, 05:05:44 INFO - 'suite': 'dromaeojs-e10s', 05:05:44 INFO - 'system_bits': '32', 05:05:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:44 INFO - 'title': 'talos-linux64-ix-081', 05:05:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:44 INFO - 'use_talos_json': True, 05:05:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:44 INFO - 'work_dir': 'build'} 05:05:44 INFO - [mozharness: 2017-08-08 12:05:44.075752Z] Running clobber step. 05:05:44 INFO - Running pre-action listener: _resource_record_pre_action 05:05:44 INFO - Running main action method: clobber 05:05:44 INFO - rmtree: /builds/slave/test/build 05:05:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:45 INFO - Running post-action listener: _resource_record_post_action 05:05:45 INFO - [mozharness: 2017-08-08 12:05:45.606476Z] Finished clobber step (success) 05:05:45 INFO - [mozharness: 2017-08-08 12:05:45.606575Z] Running read-buildbot-config step. 05:05:45 INFO - Running pre-action listener: _resource_record_pre_action 05:05:45 INFO - Running main action method: read_buildbot_config 05:05:45 INFO - Using buildbot properties: 05:05:45 INFO - { 05:05:45 INFO - "project": "", 05:05:45 INFO - "product": "firefox", 05:05:45 INFO - "who": "cbook@mozilla.com", 05:05:45 INFO - "installer_path": "public/build/target.tar.bz2", 05:05:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:05:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:05:45 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:05:45 INFO - "stage_platform": "linux64-stylo", 05:05:45 INFO - "basedir": "/builds/slave/test", 05:05:45 INFO - "buildnumber": 264, 05:05:45 INFO - "platform": "ubuntu64_hw_stylo", 05:05:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:05:45 INFO - "slavebuilddir": "test", 05:05:45 INFO - "taskId": "E9CpVJaUQ4ia8CvxKv6EXQ", 05:05:45 INFO - "branch": "mozilla-central", 05:05:45 INFO - "script_repo_revision": "production", 05:05:45 INFO - "revision": "8c7788eda00e4cb4445638bdb7500009cd4cbe59", 05:05:45 INFO - "slavename": "talos-linux64-ix-081", 05:05:45 INFO - "repo_path": "mozilla-central" 05:05:45 INFO - } 05:05:45 INFO - Finding installer, test and symbols from parent task. 05:05:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E9CpVJaUQ4ia8CvxKv6EXQ'}, attempt #1 05:05:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E9CpVJaUQ4ia8CvxKv6EXQ'}, attempt #1 05:05:46 INFO - Task dependencies: At2ih0kyQ7Ka5Inf4WhGAA 05:05:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA'}, attempt #1 05:05:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2 05:05:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.test_packages.json 05:05:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.crashreporter-symbols.zip 05:05:47 INFO - Running post-action listener: _resource_record_post_action 05:05:47 INFO - [mozharness: 2017-08-08 12:05:47.004743Z] Finished read-buildbot-config step (success) 05:05:47 INFO - [mozharness: 2017-08-08 12:05:47.004963Z] Running download-and-extract step. 05:05:47 INFO - Running pre-action listener: _resource_record_pre_action 05:05:47 INFO - Running main action method: download_and_extract 05:05:47 INFO - mkdir: /builds/slave/test/build/tests 05:05:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:47 INFO - trying https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.test_packages.json 05:05:47 INFO - Downloading https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:05:47 INFO - Downloaded 989 bytes. 05:05:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:05:47 INFO - Using the following test package requirements: 05:05:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:05:47 INFO - u'common': [u'target.common.tests.zip'], 05:05:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:05:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:05:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:05:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:05:47 INFO - u'mozbase': [u'target.common.tests.zip'], 05:05:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:05:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:05:47 INFO - u'web-platform': [u'target.common.tests.zip', 05:05:47 INFO - u'target.web-platform.tests.tar.gz'], 05:05:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:05:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.common.tests.zip 05:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.common.tests.zip into memory 05:05:48 INFO - Content-Length response header: 54284886 05:05:48 INFO - Bytes received: 54284886 05:05:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:05:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.common.tests.zip 05:05:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:05:59 INFO - Fetch https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.common.tests.zip into memory 05:06:00 INFO - Content-Length response header: 54284886 05:06:00 INFO - Bytes received: 54284886 05:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.talos.tests.zip 05:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.talos.tests.zip into memory 05:06:13 INFO - Content-Length response header: 14496008 05:06:13 INFO - Bytes received: 14496008 05:06: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')]} 05:06:13 INFO - trying https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2 05:06:13 INFO - Downloading https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:06:15 INFO - Downloaded 61790054 bytes. 05:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2 05:06:15 INFO - mkdir: /builds/slave/test/properties 05:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:15 INFO - Contents: 05:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2 05:06:15 INFO - Running post-action listener: _resource_record_post_action 05:06:15 INFO - Running post-action listener: set_extra_try_arguments 05:06:15 INFO - [mozharness: 2017-08-08 12:06:15.588447Z] Finished download-and-extract step (success) 05:06:15 INFO - [mozharness: 2017-08-08 12:06:15.588546Z] Running populate-webroot step. 05:06:15 INFO - Running pre-action listener: _resource_record_pre_action 05:06:15 INFO - Running main action method: populate_webroot 05:06:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:06:15 INFO - 'tests': ['damp', 'tps']}, 05:06:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:06:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:06:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:06:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:15 INFO - 'ts_paint', 05:06:15 INFO - 'tpaint', 05:06:15 INFO - 'sessionrestore', 05:06:15 INFO - 'sessionrestore_many_windows', 05:06:15 INFO - 'sessionrestore_no_auto_restore', 05:06:15 INFO - 'tabpaint']}, 05:06:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:06:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:06:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:15 INFO - 'tsvgr_opacity', 05:06:15 INFO - 'tart', 05:06:15 INFO - 'tscrollx', 05:06:15 INFO - 'tsvg_static']}, 05:06:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:06:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:06:15 INFO - 'talos_options': ['--mitmproxy', 05:06:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:06:15 INFO - '--firstNonBlankPaint'], 05:06:15 INFO - 'tests': ['tp6_google', 05:06:15 INFO - 'tp6_youtube', 05:06:15 INFO - 'tp6_amazon', 05:06:15 INFO - 'tp6_facebook']}, 05:06:15 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:06:15 INFO - 'talos_options': ['--stylo', 05:06:15 INFO - '--mitmproxy', 05:06:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:06:15 INFO - '--firstNonBlankPaint'], 05:06:15 INFO - 'tests': ['tp6_google', 05:06:15 INFO - 'tp6_youtube', 05:06:15 INFO - 'tp6_amazon', 05:06:15 INFO - 'tp6_facebook']}, 05:06:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:06:15 INFO - 'talos_options': ['--stylo', 05:06:15 INFO - '--stylo-threads=1', 05:06:15 INFO - '--mitmproxy', 05:06:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:06:15 INFO - '--firstNonBlankPaint'], 05:06:15 INFO - 'tests': ['tp6_google', 05:06:15 INFO - 'tp6_youtube', 05:06:15 INFO - 'tp6_amazon', 05:06:15 INFO - 'tp6_facebook']}, 05:06:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:06:15 INFO - 'talos_options': ['--xperf_path', 05:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:15 INFO - 'tests': ['tp5n']}}} 05:06:15 INFO - Running post-action listener: _resource_record_post_action 05:06:15 INFO - [mozharness: 2017-08-08 12:06:15.597017Z] Finished populate-webroot step (success) 05:06:15 INFO - [mozharness: 2017-08-08 12:06:15.597107Z] Running create-virtualenv step. 05:06:15 INFO - Running pre-action listener: _resource_record_pre_action 05:06:15 INFO - Running main action method: create_virtualenv 05:06:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:15 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 05:06:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:06:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:15 INFO - Using real prefix '/usr' 05:06:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:18 INFO - Installing pip.................done. 05:06:18 INFO - Return code: 0 05:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:06:18 INFO - Reading from file tmpfile_stdout 05:06:18 INFO - Output received: 05:06:18 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) 05:06:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:18 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')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:18 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')]} 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:18 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:18 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 05:06:18 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 05:06:18 INFO - Using env: {'DISPLAY': ':0', 05:06:18 INFO - 'HOME': '/home/cltbld', 05:06:18 INFO - 'LANG': 'en_US.UTF-8', 05:06:18 INFO - 'LANGUAGE': 'en_US:en', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MAIL': '/var/mail/cltbld', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SHLVL': '1', 05:06:18 INFO - 'TERM': 'linux', 05:06:18 INFO - 'TMOUT': '86400', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - '_': '/tools/buildbot/bin/python'} 05:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:18 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 05:06:18 INFO - Cleaning up... 05:06:18 INFO - Return code: 0 05:06:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:18 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')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:18 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')]} 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:18 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:18 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 05:06:18 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 05:06:18 INFO - Using env: {'DISPLAY': ':0', 05:06:18 INFO - 'HOME': '/home/cltbld', 05:06:18 INFO - 'LANG': 'en_US.UTF-8', 05:06:18 INFO - 'LANGUAGE': 'en_US:en', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MAIL': '/var/mail/cltbld', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SHLVL': '1', 05:06:18 INFO - 'TERM': 'linux', 05:06:18 INFO - 'TMOUT': '86400', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - '_': '/tools/buildbot/bin/python'} 05:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:18 INFO - Downloading/unpacking psutil>=3.1.1 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:20 INFO - Installing collected packages: psutil 05:06:20 INFO - Running setup.py install for psutil 05:06:20 INFO - building 'psutil._psutil_linux' extension 05:06:20 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 05:06:20 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 05:06:20 INFO - building 'psutil._psutil_posix' extension 05:06:20 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 05:06:20 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 05:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:20 INFO - Successfully installed psutil 05:06:20 INFO - Cleaning up... 05:06:20 INFO - Return code: 0 05:06:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06: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')]} 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:20 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:20 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 05:06:20 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 05:06:20 INFO - Using env: {'DISPLAY': ':0', 05:06:20 INFO - 'HOME': '/home/cltbld', 05:06:20 INFO - 'LANG': 'en_US.UTF-8', 05:06:20 INFO - 'LANGUAGE': 'en_US:en', 05:06:20 INFO - 'LOGNAME': 'cltbld', 05:06:20 INFO - 'MAIL': '/var/mail/cltbld', 05:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:20 INFO - 'MOZ_NO_REMOTE': '1', 05:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:20 INFO - 'NO_EM_RESTART': '1', 05:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:20 INFO - 'PWD': '/builds/slave/test', 05:06:20 INFO - 'SHELL': '/bin/bash', 05:06:20 INFO - 'SHLVL': '1', 05:06:20 INFO - 'TERM': 'linux', 05:06:20 INFO - 'TMOUT': '86400', 05:06:20 INFO - 'USER': 'cltbld', 05:06:20 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:20 INFO - '_': '/tools/buildbot/bin/python'} 05:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:20 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 05:06:20 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 05:06:20 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 05:06:20 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 05:06:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:21 INFO - Installing collected packages: mozsystemmonitor 05:06:21 INFO - Running setup.py install for mozsystemmonitor 05:06:22 INFO - Successfully installed mozsystemmonitor 05:06:22 INFO - Cleaning up... 05:06:22 INFO - Return code: 0 05:06:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:06:22 INFO - Using env: {'DISPLAY': ':0', 05:06:22 INFO - 'HOME': '/home/cltbld', 05:06:22 INFO - 'LANG': 'en_US.UTF-8', 05:06:22 INFO - 'LANGUAGE': 'en_US:en', 05:06:22 INFO - 'LOGNAME': 'cltbld', 05:06:22 INFO - 'MAIL': '/var/mail/cltbld', 05:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:22 INFO - 'MOZ_NO_REMOTE': '1', 05:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:22 INFO - 'NO_EM_RESTART': '1', 05:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:22 INFO - 'PWD': '/builds/slave/test', 05:06:22 INFO - 'SHELL': '/bin/bash', 05:06:22 INFO - 'SHLVL': '1', 05:06:22 INFO - 'TERM': 'linux', 05:06:22 INFO - 'TMOUT': '86400', 05:06:22 INFO - 'USER': 'cltbld', 05:06:22 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:22 INFO - '_': '/tools/buildbot/bin/python'} 05:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:06: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 05:06: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 05:06: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 05:06: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 05:06:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:06: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 05:06: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 05:06: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 05:06: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 05:06:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:23 INFO - warning: no files found matching '*.txt' 05:06:23 INFO - no previously-included directories found matching 'build' 05:06:23 INFO - no previously-included directories found matching 'dist' 05:06:23 INFO - no previously-included directories found matching '.git*' 05:06:23 INFO - Installing collected packages: jsonschema, functools32 05:06:23 INFO - Running setup.py install for functools32 05:06:23 INFO - warning: no files found matching '*.txt' 05:06:23 INFO - no previously-included directories found matching 'build' 05:06:23 INFO - no previously-included directories found matching 'dist' 05:06:23 INFO - no previously-included directories found matching '.git*' 05:06:23 INFO - Successfully installed jsonschema functools32 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06: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')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:23 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 05:06:23 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 05:06:23 INFO - Using env: {'DISPLAY': ':0', 05:06:23 INFO - 'HOME': '/home/cltbld', 05:06:23 INFO - 'LANG': 'en_US.UTF-8', 05:06:23 INFO - 'LANGUAGE': 'en_US:en', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MAIL': '/var/mail/cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SHLVL': '1', 05:06:23 INFO - 'TERM': 'linux', 05:06:23 INFO - 'TMOUT': '86400', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - '_': '/tools/buildbot/bin/python'} 05:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:06:24 INFO - Cleaning up... 05:06:24 INFO - Return code: 0 05:06:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:24 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')]} 05:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:24 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')]} 05:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:24 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:24 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 05:06:24 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 05:06:24 INFO - Using env: {'DISPLAY': ':0', 05:06:24 INFO - 'HOME': '/home/cltbld', 05:06:24 INFO - 'LANG': 'en_US.UTF-8', 05:06:24 INFO - 'LANGUAGE': 'en_US:en', 05:06:24 INFO - 'LOGNAME': 'cltbld', 05:06:24 INFO - 'MAIL': '/var/mail/cltbld', 05:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:24 INFO - 'MOZ_NO_REMOTE': '1', 05:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:24 INFO - 'NO_EM_RESTART': '1', 05:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:24 INFO - 'PWD': '/builds/slave/test', 05:06:24 INFO - 'SHELL': '/bin/bash', 05:06:24 INFO - 'SHLVL': '1', 05:06:24 INFO - 'TERM': 'linux', 05:06:24 INFO - 'TMOUT': '86400', 05:06:24 INFO - 'USER': 'cltbld', 05:06:24 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:24 INFO - '_': '/tools/buildbot/bin/python'} 05:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:24 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 05:06:24 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 05:06:24 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 05:06:24 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 05:06:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 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 05:06:25 INFO - Downloading docopt-0.6.1.tar.gz 05:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:26 INFO - Running setup.py install for blobuploader 05:06:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:26 INFO - Running setup.py install for requests 05:06:26 INFO - Running setup.py install for docopt 05:06:26 INFO - Successfully installed blobuploader requests docopt 05:06:26 INFO - Cleaning up... 05:06:26 INFO - Return code: 0 05:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06: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')]} 05:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:26 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:26 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 05:06:26 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 05:06:26 INFO - Using env: {'DISPLAY': ':0', 05:06:26 INFO - 'HOME': '/home/cltbld', 05:06:26 INFO - 'LANG': 'en_US.UTF-8', 05:06:26 INFO - 'LANGUAGE': 'en_US:en', 05:06:26 INFO - 'LOGNAME': 'cltbld', 05:06:26 INFO - 'MAIL': '/var/mail/cltbld', 05:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:26 INFO - 'MOZ_NO_REMOTE': '1', 05:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:26 INFO - 'NO_EM_RESTART': '1', 05:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:26 INFO - 'PWD': '/builds/slave/test', 05:06:26 INFO - 'SHELL': '/bin/bash', 05:06:26 INFO - 'SHLVL': '1', 05:06:26 INFO - 'TERM': 'linux', 05:06:26 INFO - 'TMOUT': '86400', 05:06:26 INFO - 'USER': 'cltbld', 05:06:26 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:26 INFO - '_': '/tools/buildbot/bin/python'} 05:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:26 INFO - Running setup.py (path:/tmp/pip-IZ7MKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:26 INFO - Running setup.py (path:/tmp/pip-VI555q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:26 INFO - Running setup.py (path:/tmp/pip-XreB9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:27 INFO - Running setup.py (path:/tmp/pip-2ilLsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:27 INFO - Running setup.py (path:/tmp/pip-xa9QV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:27 INFO - Running setup.py (path:/tmp/pip-7zvXHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:27 INFO - Running setup.py (path:/tmp/pip-1Rq9mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:27 INFO - Running setup.py (path:/tmp/pip-wd6Wek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:27 INFO - Running setup.py (path:/tmp/pip-jgwSwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:27 INFO - Running setup.py (path:/tmp/pip-i4c40k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:27 INFO - Running setup.py (path:/tmp/pip-fGNDKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:27 INFO - Running setup.py (path:/tmp/pip-A45PEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:27 INFO - Running setup.py (path:/tmp/pip-bGFJOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:27 INFO - Running setup.py (path:/tmp/pip-USk1jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:27 INFO - Running setup.py (path:/tmp/pip-rL0qgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:27 INFO - Running setup.py (path:/tmp/pip-aKXRD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:27 INFO - Running setup.py (path:/tmp/pip-zsCVlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:28 INFO - Running setup.py install for manifestparser 05:06:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozcrash 05:06:28 INFO - Running setup.py install for mozdebug 05:06:28 INFO - Running setup.py install for mozdevice 05:06:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozfile 05:06:28 INFO - Running setup.py install for mozhttpd 05:06:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozinfo 05:06:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozInstall 05:06:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:28 INFO - Running setup.py install for mozleak 05:06:28 INFO - Running setup.py install for mozlog 05:06:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for moznetwork 05:06:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for mozprocess 05:06:29 INFO - Running setup.py install for mozprofile 05:06:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for mozrunner 05:06:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Running setup.py install for mozscreenshot 05:06:29 INFO - Running setup.py install for moztest 05:06:29 INFO - Running setup.py install for mozversion 05:06:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:29 INFO - Cleaning up... 05:06:29 INFO - Return code: 0 05:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:29 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')]} 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:29 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')]} 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:29 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:29 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 05:06:29 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 05:06:29 INFO - Using env: {'DISPLAY': ':0', 05:06:29 INFO - 'HOME': '/home/cltbld', 05:06:29 INFO - 'LANG': 'en_US.UTF-8', 05:06:29 INFO - 'LANGUAGE': 'en_US:en', 05:06:29 INFO - 'LOGNAME': 'cltbld', 05:06:29 INFO - 'MAIL': '/var/mail/cltbld', 05:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:29 INFO - 'MOZ_NO_REMOTE': '1', 05:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:29 INFO - 'NO_EM_RESTART': '1', 05:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:29 INFO - 'PWD': '/builds/slave/test', 05:06:29 INFO - 'SHELL': '/bin/bash', 05:06:29 INFO - 'SHLVL': '1', 05:06:29 INFO - 'TERM': 'linux', 05:06:29 INFO - 'TMOUT': '86400', 05:06:29 INFO - 'USER': 'cltbld', 05:06:29 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:29 INFO - '_': '/tools/buildbot/bin/python'} 05:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:30 INFO - Running setup.py (path:/tmp/pip-ggFMsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:30 INFO - Running setup.py (path:/tmp/pip-x1jgLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:30 INFO - Running setup.py (path:/tmp/pip-rHfF_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:30 INFO - Running setup.py (path:/tmp/pip-jbizPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:30 INFO - Running setup.py (path:/tmp/pip-iGTh3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:30 INFO - Running setup.py (path:/tmp/pip-gKc46r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:30 INFO - Running setup.py (path:/tmp/pip-9CTaNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:30 INFO - Running setup.py (path:/tmp/pip-1dfBxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:30 INFO - Running setup.py (path:/tmp/pip-t6ouW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:30 INFO - Running setup.py (path:/tmp/pip-v0KAOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:30 INFO - Running setup.py (path:/tmp/pip-wOlO6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:30 INFO - Running setup.py (path:/tmp/pip-m_7N2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:30 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)) 05:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:30 INFO - Running setup.py (path:/tmp/pip-zN6_u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:31 INFO - Running setup.py (path:/tmp/pip-KtoTDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:31 INFO - Running setup.py (path:/tmp/pip-sqSPsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:31 INFO - Running setup.py (path:/tmp/pip-sBr26d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:31 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)) 05:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:31 INFO - Running setup.py (path:/tmp/pip-G5PLN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 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)) 05:06:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:31 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 05:06:31 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 05:06:31 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 05:06:31 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 05:06:32 INFO - Downloading blessings-1.6.tar.gz 05:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:32 INFO - Installing collected packages: blessings 05:06:32 INFO - Running setup.py install for blessings 05:06:32 INFO - Successfully installed blessings 05:06:32 INFO - Cleaning up... 05:06:32 INFO - Return code: 0 05:06:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:32 INFO - Reading from file tmpfile_stdout 05:06:32 INFO - Current package versions: 05:06:32 INFO - argparse == 1.2.1 05:06:32 INFO - blessings == 1.6 05:06:32 INFO - blobuploader == 1.2.4 05:06:32 INFO - docopt == 0.6.1 05:06:32 INFO - functools32 == 3.2.3-2 05:06:32 INFO - jsonschema == 2.5.1 05:06:32 INFO - manifestparser == 1.1 05:06:32 INFO - mozInstall == 1.13 05:06:32 INFO - mozcrash == 1.0 05:06:32 INFO - mozdebug == 0.1 05:06:32 INFO - mozdevice == 0.51 05:06:32 INFO - mozfile == 1.2 05:06:32 INFO - mozhttpd == 0.7 05:06:32 INFO - mozinfo == 0.10 05:06:32 INFO - mozleak == 0.1 05:06:32 INFO - mozlog == 3.5 05:06:32 INFO - moznetwork == 0.27 05:06:32 INFO - mozprocess == 0.25 05:06:32 INFO - mozprofile == 0.28 05:06:32 INFO - mozrunner == 6.13 05:06:32 INFO - mozscreenshot == 0.1 05:06:32 INFO - mozsystemmonitor == 0.3 05:06:32 INFO - moztest == 0.8 05:06:32 INFO - mozversion == 1.4 05:06:32 INFO - psutil == 3.1.1 05:06:32 INFO - requests == 1.2.3 05:06:32 INFO - wsgiref == 0.1.2 05:06:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:32 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')]} 05:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:32 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')]} 05:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:32 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:32 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 05:06:32 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 05:06:32 INFO - Using env: {'DISPLAY': ':0', 05:06:32 INFO - 'HOME': '/home/cltbld', 05:06:32 INFO - 'LANG': 'en_US.UTF-8', 05:06:32 INFO - 'LANGUAGE': 'en_US:en', 05:06:32 INFO - 'LOGNAME': 'cltbld', 05:06:32 INFO - 'MAIL': '/var/mail/cltbld', 05:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:32 INFO - 'MOZ_NO_REMOTE': '1', 05:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:32 INFO - 'NO_EM_RESTART': '1', 05:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:32 INFO - 'PWD': '/builds/slave/test', 05:06:32 INFO - 'SHELL': '/bin/bash', 05:06:32 INFO - 'SHLVL': '1', 05:06:32 INFO - 'TERM': 'linux', 05:06:32 INFO - 'TMOUT': '86400', 05:06:32 INFO - 'USER': 'cltbld', 05:06:32 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:32 INFO - '_': '/tools/buildbot/bin/python'} 05:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 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)) 05:06:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:06:33 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 05:06:33 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 05:06:33 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 05:06:33 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 05:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:06:34 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)) 05:06:34 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)) 05:06:34 INFO - Installing collected packages: simplejson 05:06:34 INFO - Running setup.py install for simplejson 05:06:34 INFO - building 'simplejson._speedups' extension 05:06:34 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 05:06:35 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 05:06:35 INFO - Successfully installed simplejson 05:06:35 INFO - Cleaning up... 05:06:35 INFO - Return code: 0 05:06:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06: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')]} 05:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:35 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 0x11b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1522d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, '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': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', '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 05:06:35 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 05:06:35 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 05:06:35 INFO - Using env: {'DISPLAY': ':0', 05:06:35 INFO - 'HOME': '/home/cltbld', 05:06:35 INFO - 'LANG': 'en_US.UTF-8', 05:06:35 INFO - 'LANGUAGE': 'en_US:en', 05:06:35 INFO - 'LOGNAME': 'cltbld', 05:06:35 INFO - 'MAIL': '/var/mail/cltbld', 05:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:35 INFO - 'MOZ_NO_REMOTE': '1', 05:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:35 INFO - 'NO_EM_RESTART': '1', 05:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:35 INFO - 'PWD': '/builds/slave/test', 05:06:35 INFO - 'SHELL': '/bin/bash', 05:06:35 INFO - 'SHLVL': '1', 05:06:35 INFO - 'TERM': 'linux', 05:06:35 INFO - 'TMOUT': '86400', 05:06:35 INFO - 'USER': 'cltbld', 05:06:35 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:35 INFO - '_': '/tools/buildbot/bin/python'} 05:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:06:35 INFO - Cleaning up... 05:06:35 INFO - Return code: 0 05:06:35 INFO - Running post-action listener: _resource_record_post_action 05:06:35 INFO - Running post-action listener: _start_resource_monitoring 05:06:35 INFO - Starting resource monitoring. 05:06:35 INFO - [mozharness: 2017-08-08 12:06:35.619189Z] Finished create-virtualenv step (success) 05:06:35 INFO - [mozharness: 2017-08-08 12:06:35.619707Z] Running install step. 05:06:35 INFO - Running pre-action listener: _resource_record_pre_action 05:06:35 INFO - Running main action method: install 05:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:35 INFO - Reading from file tmpfile_stdout 05:06:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:35 INFO - Reading from file tmpfile_stdout 05:06:35 INFO - Output received: 05:06:35 INFO - Usage: mozinstall [options] installer 05:06:35 INFO - Options: 05:06:35 INFO - -h, --help show this help message and exit 05:06:35 INFO - -d DEST, --destination=DEST 05:06:35 INFO - Directory to install application into. [default: 05:06:35 INFO - "/builds/slave/test"] 05:06:35 INFO - --app=APP Application being installed. [default: firefox] 05:06:35 INFO - mkdir: /builds/slave/test/build/application 05:06:35 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'] 05:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:06:53 INFO - Reading from file tmpfile_stdout 05:06:53 INFO - Output received: 05:06:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:53 INFO - Running post-action listener: _resource_record_post_action 05:06:53 INFO - [mozharness: 2017-08-08 12:06:53.936689Z] Finished install step (success) 05:06:53 INFO - [mozharness: 2017-08-08 12:06:53.936975Z] Running setup-mitmproxy step. 05:06:53 INFO - Running pre-action listener: _resource_record_pre_action 05:06:53 INFO - Running main action method: setup_mitmproxy 05:06:53 INFO - Skipping: mitmproxy is not required 05:06:53 INFO - Running post-action listener: _resource_record_post_action 05:06:53 INFO - [mozharness: 2017-08-08 12:06:53.938264Z] Finished setup-mitmproxy step (success) 05:06:53 INFO - [mozharness: 2017-08-08 12:06:53.938487Z] Running run-tests step. 05:06:53 INFO - Running pre-action listener: _resource_record_pre_action 05:06:53 INFO - Running pre-action listener: _set_gcov_prefix 05:06:53 INFO - Running main action method: run_tests 05:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:53 INFO - Python 2.7.3 05:06:53 INFO - Return code: 0 05:06:53 INFO - grabbing minidump binary from tooltool 05:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:53 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 0x151feb0>, '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 0x1520db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1521240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:53 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 05:06:53 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 05:06:53 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 05:06:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:54 INFO - Return code: 0 05:06:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:54 INFO - ENV: RUST_BACKTRACE is now 1 05:06:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:54 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/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 05:06:54 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/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 05:06:54 INFO - Using env: {'DISPLAY': ':0', 05:06:54 INFO - 'HOME': '/home/cltbld', 05:06:54 INFO - 'LANG': 'en_US.UTF-8', 05:06:54 INFO - 'LANGUAGE': 'en_US:en', 05:06:54 INFO - 'LOGNAME': 'cltbld', 05:06:54 INFO - 'MAIL': '/var/mail/cltbld', 05:06:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:54 INFO - 'MOZ_NO_REMOTE': '1', 05:06:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:54 INFO - 'NO_EM_RESTART': '1', 05:06:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:54 INFO - 'PWD': '/builds/slave/test', 05:06:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:54 INFO - 'RUST_BACKTRACE': '1', 05:06:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:06:54 INFO - 'SHELL': '/bin/bash', 05:06:54 INFO - 'SHLVL': '1', 05:06:54 INFO - 'STYLO_FORCE_ENABLED': '1', 05:06:54 INFO - 'TERM': 'linux', 05:06:54 INFO - 'TMOUT': '86400', 05:06:54 INFO - 'USER': 'cltbld', 05:06:54 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1502193804.354225-1683656443', 05:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:54 INFO - '_': '/tools/buildbot/bin/python'} 05:06:54 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/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 05:06:54 INFO - mozversion application_buildid: 20170808111607 05:06:54 INFO - mozversion application_changeset: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 05:06:54 INFO - mozversion application_display_name: Nightly 05:06:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:54 INFO - mozversion application_name: Firefox 05:06:54 INFO - mozversion application_remotingname: firefox 05:06:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:06:54 INFO - mozversion application_vendor: Mozilla 05:06:54 INFO - mozversion application_version: 57.0a1 05:06:54 INFO - mozversion platform_buildid: 20170808111607 05:06:54 INFO - mozversion platform_changeset: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 05:06:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:06:54 INFO - mozversion platform_version: 57.0a1 05:06:54 INFO - using testdate: 1502194014 05:06:54 INFO - actual date: 1502194014 05:06:54 INFO - starting webserver on 'localhost:46230' 05:06:54 INFO - SUITE-START | Running 2 tests 05:06:54 INFO - TEST-START | dromaeo_css 05:06:54 INFO - Initialising browser for dromaeo_css test... 05:06:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46230/getInfo.html -profile /tmp/tmpRqNTSw/profile 05:06:54 INFO - TEST-INFO | started process 13073 (/builds/slave/test/build/application/firefox/firefox http://localhost:46230/getInfo.html) 05:07:00 INFO - TEST-INFO | 13073: exit 0 05:07:00 INFO - Browser initialized. 05:07:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:00 INFO - TEST-INFO | started process 13297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRqNTSw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:01 INFO - PID 13297 | 05:07:01 INFO - PID 13297 | (/builds/slave/test/build/application/firefox/firefox:13352): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:07:01 INFO - PID 13297 | 05:07:11 INFO - PID 13297 | RSS: Main: 173916160 05:07:11 INFO - PID 13297 | 05:10:10 INFO - PID 13297 | Cycle 1(1): loaded http://localhost:46230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46230/tests/dromaeo/cssquery-ext.html) 05:10:11 INFO - PID 13297 | RSS: Main: 175308800 05:10:11 INFO - PID 13297 | 05:13:13 INFO - PID 13297 | Cycle 1(1): loaded http://localhost:46230/tests/dromaeo/cssquery-ext.html (next: http://localhost:46230/tests/dromaeo/cssquery-jquery.html) 05:13:14 INFO - PID 13297 | RSS: Main: 171999232 05:13:14 INFO - PID 13297 | 05:16:15 INFO - PID 13297 | Cycle 1(1): loaded http://localhost:46230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46230/tests/dromaeo/cssquery-mootools.html) 05:16:16 INFO - PID 13297 | RSS: Main: 175132672 05:16:16 INFO - PID 13297 | 05:19:18 INFO - PID 13297 | Cycle 1(1): loaded http://localhost:46230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46230/tests/dromaeo/cssquery-prototype.html) 05:19:19 INFO - PID 13297 | RSS: Main: 173084672 05:19:19 INFO - PID 13297 | 05:22:23 INFO - PID 13297 | Cycle 1(1): loaded http://localhost:46230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46230/tests/dromaeo/cssquery-yui.html) 05:22:23 INFO - PID 13297 | RSS: Main: 175263744 05:22:23 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | Cycle 1(1): loaded http://localhost:46230/tests/dromaeo/cssquery-yui.html (next: http://localhost:46230/tests/dromaeo/cssquery-dojo.html) 05:25:25 INFO - PID 13297 | RSS: Main: 177459200 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | __start_tp_report 05:25:25 INFO - PID 13297 | _x_x_mozilla_page_load 05:25:25 INFO - PID 13297 | _x_x_mozilla_page_load_details 05:25:25 INFO - PID 13297 | |i|pagename|runs| 05:25:25 INFO - PID 13297 | |0;dojo.html;3100.054483382569;3168.429682657122;3175.4760464523356;3178.6821317868216;3243.983780081099;6171.47542458891;6307.053941908716;6331.145295385128;6331.303556608781;6365.42711155997;6134.478569321613;6203.472704820085;6209;6238.220222472191;6398.648074355909;5719.771209151629;5741.425857414246;5750.281214848144;5803.01348770709;5834.649921004753;88.32219938335042;5750.482456578907;5762.366139724627;5836.620619659709;5862.032764593858;5360.2227676987;5744.224529688522;5820.767169313222;5822.359540450547;5826.970865145647;5722.62802917809;5731.398203188647;5747.712614369307;5830.941690583082;5832.737526811304;5613.46672066153;5646.774129034875;5686.5735069869925;5704.828855134353;5743.827685169452;6113.786017489367;6124.203853499062;6242.656653884034;6263.655498947556;6329.145565348711;6591.209054913393;6605.504587155982;6610.7025183866845;6649.3350664933605;6720.19357677077;6801;6806.6256355900405;6807.047013418125;6811.114555107804;6812.284710105417;6265.655388953605;6270.78052268173;6318.715657795365;6320.5891617044745;6324.494040476751;6799.3200679931615;6873.931260687429;6960.164780226304;6974.232834388214;6980.965095174492;6521.054447105238;6541.378569035934;6584.144061272004;6630.469562434993;6651.800445986628;6583.111279977237;6687.832804179934;6721.596704197764;6772.55978361405;6776.15298087739;6709.798706038827;6711.7315307388135;6717.059611654372;6717.328267173243;6719.563228390139;6617.272100068989;6699.933000669931;6707.6981535831;6760.0535924970545;6760.864782704319;5421.213923981;5422.295101636762;5423.105187644073;5452.972735136299;5545.417731138253;4708.081924024782;4728.0780247851335;4728.1252968201;4729.69256998294;4733.644976626767;5775.971120144372;5780.624259423208;5845.853853653693;5856.94143058564;5861.0915308127305;6662.6668666566475;6740.83147921296;6785.1518560179975;6786.151731033621;6814.93185068143;5807.216025836458;5816.214811000461;5816.970915145397;5819.0689489681445;5820.592558520948;5970.13433052205;5977.013792724239;5992.191054207713;5992.970035149797;5997.640141591519;6417.614943103429;6474.417302442803;6491.740330386731;6545.345465453416;6550.0829883816305;6659.433948114464;6726.125603671491;6744.797656070227;6762.966185169043;6823.522353435411;6385.329540398191;6401.103845461546;6406.647634379968;6492.156019717407;6508.479321654351;6604.735810567524;6653.367930046831;6655.401013908578;6731.225909020525;6741.629210393476;6820.181578210647;6838.794836154923;6841.315868413119;6842.384185423336;6846.075779769866;6595.868082638416;6605.933940660532;6629.370209830058;6642.933570664231;6644.202695676549;6541.476681865534;6560.868782624225;6561.80314590563;6656.034874943203;6659.600423974577;6419.45434638061;6473.385028422293;6482.962725963823;6566.606003639797;6571.178602674666;6557.245916719638;6568.343165683585;6583.868322633425;6673.666316684244;6707.899381509379;6370.96814515943;6380.138681277968;6413.390727880844;6451.225852897683;6494.74021039172 05:25:25 INFO - PID 13297 | |1;ext.html;852.2372476633413;859.6303589456531;879.2921698033084;906.9591868365923;908.087372190948;41998.37002444966;42911.35632965508;42913;42940.785296073474;43050.56949430505;37756.62243377566;37983.43024854629;37984;38072.80963595178;38087.61912380882;7015.6141412222305;7089.751858684947;7124.5725256484775;7158.46311526635;7169.964150179242;7046.894296585555;7087.964560177192;7119.074520312378;7151.821204469878;7155.534890232144;7318.926810731904;7901.170377110407;7954.16481269467;7993.480423772466;7996.720114795983;7882.5270483771155;7901.565413902233;7921.683132674686;7960.9203907960755;7961.482503637274;7629.198934111894;7757.301842834172;7852.21477852216;7855.725049623293;7860.174681658458;39323.21353572941;39402.408963865564;39470.80264598687;39480.210395791924;39597.60402395997;3594.51474051005;3609.8014609196484;3615.5119058927235;3640.8179591020344;3642.1076836175043;31661.52507712386;31765.364692706247;31800.204994875083;31833.681663183535;31853.203669908205;5135.3837539495125;5161.612879034087;5184.196449550326;5194.35070616173;5195.974020129913;179580;180120;180253;180261;180474;49597.75201124044;49893.501064989614;50044.24933625926;50101.49898500968;50205.24692129621;51479.74260128675;52026.21960670593;52061;52097.47902521002;52148.739256303474;16633.750493742602;17084.57288567771;17101.230444630022;17101.48695539136;17119.657606848043;13941.163530188222;14036.578902632937;14046.227457489731;14051.297435128407;14084.929575352058;14724.116553006854;14771.778423323658;15018.924905375621;15063.719583835278;15124.697506049817;5746.310442746897;5864.149698293723;5876.559258055663;6048.516118710492;6049.939500605025;994.6419289055934;1000.9949950250202;1020.9234307426973;1033.0857191385528;1034.4310629153936;22698.319050428512;22777.80275891691;22886.8855655724;23128;23533.76466235316;1115.1524841120645;1119.1158984402393;1119.7928383249125;1121.1647322744607;1126.3523474002482;12167.634970950709;12197.512099516098;12257.938710306391;12305.384730763426;12308.692282692826;228783;229046;229435;230337;232747;53729.46270537245;53929.46070539323;55802;57233.42766572281;59844;1462.473509536566;1494.0662086196128;1506.0812904128254;1511.6220944763809;1515.7650564162573;26787.86606066957;27101.457970840867;27115.457690846466;27221.455570888076;27456.588151177348;50605.74697126491;51567;51636;51659.22511162411;51678.74160629323;204143;206055;207531;207999;208573;34473.48289775706;34608.65391346054;34867.82566087255;34949.77675781336;35129.64870351264;41410.378844317966;42931.570684292754;43103.7844810774;43109.56890431055;43601;31808;32008.51987220147;32107.35785284328;32231.35537289288;32520.186995325304;31653.36693266168;31967.36065278728;31971;32116.67883321137;32246.677533225306;35558.111047224025;35617;35782.64217357897;35815.46276805798;35957.64042359647;31323.373532529677;31550.36899262048;31654.208644784063;31774.52338214975;32555.34889302153;23050.654240186745;23055.19306824253;23975;24642.753572464047;25311.36721581975 05:25:25 INFO - PID 13297 | |2;jquery.html;581.7672930827669;583.7431530126746;589.7906243283633;591.5385998920843;598.5989387110635;22194.778052219513;22583.774162258393;23326.300210993697;23535.76464235359;23572.88213558934;27244.182674519798;27739.722602773967;27833.582496262523;27861.164165075028;27885;6587.703553340088;6740.32596740327;6740.427063699592;6742.595444273359;6769.593824370529;6000.909986350208;6568.441682456997;6599.10912026875;6622.106015687868;6648.900266496006;6560.2455717592375;6566.704498297588;6567.704453299613;6569.868602627945;6571.178602674666;6534.836629084263;6545;6557.803265902031;6562.114114594517;6568;6109.755609775603;6111.480524155452;6114.1745864308195;6132.662703551303;6136.386361363872;27476.03833865825;29694.851525742233;30272.84863575668;30528.84735576308;30867.382652346827;1921.567647279365;1944.3097700316325;1948.4349538633778;1949.629570381623;1950.317388913883;19753.40739777809;20032.79967200324;20033.29883454072;20127.496812579655;20189.19243230269;2384.07960199005;2416.9274921752376;2468.7037555493275;2525.835820671669;2534.0750626021554;136272;142604;142641;142669.57330426667;143346.28326858403;14312.141271523742;14809.777853332209;15369.308381122877;15436.691266174837;15453.304601292968;24244.090709114666;24362.390940226283;24424.87787561051;24441.87779061093;24476.14333498319;10334;10456.32033917793;10484.63303784364;10570.207234457446;10801.189910756724;9942.154916832005;9990.700278991642;10070.949645251727;10131.138853197413;10335.586576537005;7748.690052397954;9117.908820911705;9165.312601554777;9212.677556285631;9387.295952803566;2672.6525551678546;2679.7454241846995;2770.9307267318477;2775.9028434004713;2823.378856651533;960.4813400763649;971.9805603887883;987.4914419074182;988.4909271725068;991.4447909170888;19308.32420865263;19770;20216.797832021784;20285.087171077335;20572.79427205739;1050.0444595418132;1059.1050562274866;1062.325423356159;1062.7077553672802;1066.1950227578284;11022.393768342818;11369.204155709022;11415;11437.313761174357;11456.19806613529;494155;537865;551512;554840;558726;125171;126912;128792;130474.34762826315;131076;1275.0819410024767;1290.851552071505;1324.6555895467247;1326.1777697827408;1339.2634051271762;20887.791122088584;21087;21183.7881621188;21190.78809211888;21213.681794773398;59932;61028;61362.69318653378;62347;63367.36632633799;76786;76936.2306376929;77403.61298193473;77783.6110819465;77806.6109669448;12481;13040.217586944813;14556.85443145555;14633.268336582916;15170.469033583771;23387.76612233924;23677;23722.169724059575;25291;25340.366490837878;19153.808461915203;19211.231550737815;19277.8072219276;19413.902930485256;19441.416757497296;17401.738973915653;17461.214245358737;17645.823541764417;17665.735013975056;17913.373031944342;18836.434906952814;18873;19039;19126.808731912504;19957.60084798325;14772.33524491379;14920;14973.700525989638;14976.850231497545;14979.475718349806;17355.56611084733;17506.299748009937;18146.18342174632;18552.350667726565;18658.253669853053 05:25:25 INFO - PID 13297 | |3;mootools.html;1336.9131006484579;1368.8631136886313;1384.6123085536042;1404.6137312239132;1405.5853523210646;13664.31678416079;14306.713865722691;14311.141331520103;14315.284235788222;14350.856491435083;13798.379072941716;14598.854011459882;14662.26688665565;14674.339654715537;14683;2686.1001564475923;2709.282040259333;2718.0894400375896;2720.8231464954715;2725.9045933392335;2561.0140096062964;2583.173384516946;2662.294491959632;2710.471458065678;2713.7014928357867;2755.3524921643398;2762.8342299461997;2773.320536468568;2773.736495032979;2774.833509989397;2680.7453291937236;2704.594310853368;2711.1188863619304;2721.4557088582264;2725.99999999999;2592.0798116668498;2600.7139214686367;2626.500964816679;2628.4086080631896;2643.299525625711;13774.517891873737;13894.791578126336;14067.718645627132;14071.859281407158;14074.648133796634;7472.58900760458;7718.9965304510615;7743.612819359009;7750.418718596128;7759.340456061242;5114.462981386975;5125.282460455539;5133.614978876599;5294.285271488338;5384.973075134639;1924.9326273580357;1930.2954421636002;1933.2750218668;1975.5357490989607;1976.179885347579;23105.53788924229;23196.3041108767;23276.06895724169;23380.76619233803;23387.649185262235;7077.128250722423;7080.362767350963;7224.530405523624;7319.5242309249725;7332.96333518329;15741.68516629661;15793.921030394775;15827.050376977419;15847.603809904844;15887.602809929844;7486.401087912954;7723;7730.265624765639;7732.729354472679;7734.729284475016;6953.4089602384365;7002.7899163025195;7104.076470058859;7109.822254443577;7136.179339375934;4959.628027897922;5093.770780314895;5102.923456148161;5109.284700141909;5121.718305493159;1353.5059703208258;1385.3835043405588;1514.0612820051417;1530.5637893200385;1574.6220906982242;863.3222920007764;868.4268382867277;886.9733907982642;888.6134531478828;903.0472851142108;8211.794705132419;8287.668493260322;8328.250457458858;8353.457025293337;8443.831123377498;700.0793955947912;799.1409235072321;951.2009911674088;997.3218211616171;1002.7593377589326;5012.624053196025;5082.567981721595;5254.79139797841;5282.128448805904;5316.627836051439;19277.614447710966;19922.103505342293;20027.899860500605;20072.09675564603;20078;19097.2361105557;19495.512612184808;19736.309229177197;19788.604227915363;20168.49578760543;10530;10749.462526873625;10749.78500429987;10777.78444431107;10813.83779243312;7721.652525636472;8084.797880052811;8158.4289099762445;8296.460730052528;8582;16503.83496165071;16657.083860387796;16701.832981670028;17009.404670836462;17229.91385043067;17452.47642570725;17641.73537396966;17665.470035898943;17736.822631774034;18184.90907545454;10969.23215374916;11440.313581185155;11494.195406321478;11516.712082198012;11516.712082198012;12432.689182770504;12535.686607834878;12657.810132848199;12660.303683297507;12662.620121396372;10524.579016839241;10612.204084693833;10791.622293220014;10859.402732849769;10866.511007004861;10216.438095904796;10270.6405275815;10376.118029967236;10425.426601536989;10698.358098514114;9357.953210233905;9445.102715242041;9468.289878259297;9491.145796878314;9498.620055197714;6412.647304398303;6511.902321465276;6511.967440162769;6561.868762624817;6589.604623722592;6437.645929473924;6484.870302593828;6555.6066636002;6571.145751052332;6612.603243805387 05:25:25 INFO - PID 13297 | |4;prototype.html;497.90212581258317;499.43925233644836;525.9842204733858;529.3859123416837;533.9866503337414;6208.286047104584;6210.316865144836;6226;6264.62412255265;6271.435570798627;5828.184054232411;5949.762009519625;6048.637081775086;6049.576529642927;6159.998000649784;4908.312836202935;4909.926351104737;4931.090656512657;4955.4548999610015;4958.429780575226;4874.731889746063;4924.384451943507;4928.137575924216;4961.5286547777905;4993.900121997576;4896.8041278349;4944.406671199461;4945.134601444751;4957.975210123945;4972.632526055328;4872.951270487303;4874.634402419815;4956.950430495721;4973.154563724175;4987.361753569179;4461.732296062214;4475.57482039209;4487.887802804923;4499.955000449986;4507.21964823896;6017.157597936292;6056.454919057262;6065.969670151621;6095.359987201325;6108.847278818021;5685.289338832646;5710.486056254957;5722.54219662426;5733.799317023884;5747.626404283708;6487.204985083732;6554.508411869081;6570.375814297634;6585.934140658628;6627.304133066007;4860;4864.367632207825;4875.317455556225;4887.755612219375;4904.4605093439695;6687.933120668779;6744.898826517606;6764.188297404294;6848.760293389708;6922.723091076351;4958.727270000185;4966.882451448395;4967.031428871408;5015.749212539358;5033.4077949855855;5057.291979122926;5065.873353166126;5079.450767515943;5103.7192954387865;5108.565771909355;5692.719138193873;5694.06048002075;5716.857078573069;5732.3407808101765;5737.51231145349;6494.675266236669;6511.153550038464;6559.737610495622;6593.5384523083885;6620.801375958729;1690.729483282669;1703.9574010649585;1705.6929752644394;1736.4964160393597;1777.1647325756874;1211.6546784166471;1239.5227837282712;1240.7642547915866;1256.9874301257053;1265.5317532512845;5734.77060917567;5775.711214439261;5776.566757493205;5781.53747700183;5783.132530120515;6641.302663220389;6729.22613899398;6731.2932142125355;6772.11962444879;6843.8973415398805;5580.716435219841;5697.971510142423;5782.971085144632;5787.508061814793;5830.76676932918;3591.892243232707;3614.6385361464168;3619.782813031174;3633.4368172933237;3651.72612054097;6482;6499.967500162469;6545.21457425112;6568.113304703899;6625.813481551077;6882.621455819978;6946.6179360135675;6947.965260173667;6972.302769722987;6983.196932352743;6470.870582588228;6514.185726784152;6528.902066469007;6536.705848236841;6549.541532092803;6705.329467053256;6766.515244648911;6795.966020169867;6827.419669328163;6839.247682754993;6646.867062658623;6671.666416679243;6731.124953755981;6747.325267473213;6753.594784312957;6524.249711283263;6527;6564.343565643398;6571.244306904767;6597.3072827352435;4922.680025798311;4977.377827771528;4985.277134815504;4985.277134815504;4998.725070121032;6587.945928651393;6601.9009714853355;6702.19573651165;6723.932760672331;6791.762288319885;6478.6029169207695;6549.7380104795275;6551.936140116039;6571.310012448624;6636.83407914806;6326.6520341381665;6473.741050357933;6482.805515834344;6485.416312531895;6563.606183628997;6219.968900155471;6341.7950589387865;6384.680765961776;6390.7763228286785;6414.807555773335;6463.903041454476;6466.579672321284;6470.6441145737435;6513.902291465537;6559.6064236145985;6256.655883926428;6275;6321.33625969285;6352.841178970562;6395.968020160056 05:25:25 INFO - PID 13297 | |5;yui.html;905.3888625178004;914.2503147419114;937.1097457415452;939.9624015039399;941.60923216865;17029;17827.286908523674;17839.464816055508;17975.19111639976;20778.16887324509;20000.000000000015;20118.698219526683;20263.986800659983;20278.188872445084;20636.793632063676;1004.4029992312222;1067.8344856547208;1068.4444089073677;1070.5236169904397;1070.7430216748003;1059.184427990447;1059.7827445373719;1060.0247772049695;1062.6227689170348;1062.6652604429619;1068.1454836131104;1101.2346419238631;1120.1374941295198;1121.6354684727455;1123.3933675815051;1102.0577406317564;1104.5416152296787;1105.6019832860163;1107.396468924434;1108.384846410242;782.5656760497922;789.7867575754572;790.7232468635931;792.8850316704103;794.3843521271003;17449.04030278334;19228;19369.80630193694;19372.70940935887;19446.124924378437;18447.354342597944;18556.628867422576;18778.906105469385;19058.90470547652;19184.424467265864;16754;16767.245473953702;17100;17111.657766844717;17112;3581.4448760442174;3650.5801832789302;3651.72612054097;3653.8355773990234;3657.9451308230396;122540.38729806383;125395.3730231343;126657;128003;128824.35587822094;16230.431934882223;16419.096949667884;16471.6705665886;16541.090240036672;16872;29572.852135739184;30917;31457.8427107863;31649.208769780478;31717.04848854538;8579.742607721779;8635.309175265964;8707.825843483095;8709.520976346235;8764.386492945432;3780.9243815123546;3859.0352411897024;3878.127421330178;3883.49514563105;3886.7279290449965;5163.096458119814;5268.578513718893;5325.760340784674;5332.706701131475;5333.093374126331;1041.958321667125;1082.5561519776854;1085.630885498934;1086.5110700184948;1098.6758906122714;706.4030893894651;719.3346154806783;720.3876704800878;726.5495392856462;732.9413646908234;12298.569550065884;12300.138990270774;12325.260484370967;12514.81227781584;12567.748645027048;709.2163159708551;716.6452605960083;719.6221983458726;726.8255618651485;736.7789663101048;5375.892482150335;5377.193420986883;5403.567714582824;5403.621746477709;5440.401555828856;104180;104589;107673;107877.460612698;110219;95615;95862.52068739751;96885;96887.51556242173;100988.49505752571;81668;85395.57302213449;87929.56035219783;88338.55830720934;92815;12029.218100823418;12873.806892896428;12882.291473969022;12952.481900723866;13049.739005220032;36129.63870361368;36208.27583448369;36216.27567448689;37637.05907352229;38428.231435371694;43966.56033439624;44529;44826.10347792961;45026.77486612546;46009.30986035279;18780.812191878453;19242.134103965636;19284.325048623232;19448.4165475036;19542.804571954668;20438.795612044283;21025.474363141046;21173;21177.04703288325;21722.23972160967;18507.814921850608;18697;18773.34293299728;18780.436586902415;19144.138513766637;16355.427560035818;17115.486535403958;17568.648627027644;17572.91213543924;18355.35756248525;17529.737053944456;17648.294068237126;17757.73363399524;17783.110844457467;17896.46310610684;12858.742825143258;12984.415701293654;13213.832250354923;13226.140300880412;13242.271675057964;13017.284049377375;13158.802617960548;13232.669183270495;13334.799978000145;13495.325233738471 05:25:25 INFO - PID 13297 | __end_tp_report 05:25:25 INFO - PID 13297 | __start_cc_report 05:25:25 INFO - PID 13297 | _x_x_mozilla_cycle_collect,381 05:25:25 INFO - PID 13297 | __end_cc_report 05:25:25 INFO - PID 13297 | __startTimestamp1502195125720__endTimestamp 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | ------- Summary: start ------- 05:25:25 INFO - PID 13297 | Number of tests: 6 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | [#0] dojo.html Cycles:165 Average:6164.25 Median:6451.23 stddev:870.07 (13.5%) stddev-sans-first:838.88 05:25:25 INFO - PID 13297 | Values: 3100.1 3168.4 3175.5 3178.7 3244.0 6171.5 6307.1 6331.1 6331.3 6365.4 6134.5 6203.5 6209.0 6238.2 6398.6 5719.8 5741.4 5750.3 5803.0 5834.6 88.3 5750.5 5762.4 5836.6 5862.0 5360.2 5744.2 5820.8 5822.4 5827.0 5722.6 5731.4 5747.7 5830.9 5832.7 5613.5 5646.8 5686.6 5704.8 5743.8 6113.8 6124.2 6242.7 6263.7 6329.1 6591.2 6605.5 6610.7 6649.3 6720.2 6801.0 6806.6 6807.0 6811.1 6812.3 6265.7 6270.8 6318.7 6320.6 6324.5 6799.3 6873.9 6960.2 6974.2 6981.0 6521.1 6541.4 6584.1 6630.5 6651.8 6583.1 6687.8 6721.6 6772.6 6776.2 6709.8 6711.7 6717.1 6717.3 6719.6 6617.3 6699.9 6707.7 6760.1 6760.9 5421.2 5422.3 5423.1 5453.0 5545.4 4708.1 4728.1 4728.1 4729.7 4733.6 5776.0 5780.6 5845.9 5856.9 5861.1 6662.7 6740.8 6785.2 6786.2 6814.9 5807.2 5816.2 5817.0 5819.1 5820.6 5970.1 5977.0 5992.2 5993.0 5997.6 6417.6 6474.4 6491.7 6545.3 6550.1 6659.4 6726.1 6744.8 6763.0 6823.5 6385.3 6401.1 6406.6 6492.2 6508.5 6604.7 6653.4 6655.4 6731.2 6741.6 6820.2 6838.8 6841.3 6842.4 6846.1 6595.9 6605.9 6629.4 6642.9 6644.2 6541.5 6560.9 6561.8 6656.0 6659.6 6419.5 6473.4 6483.0 6566.6 6571.2 6557.2 6568.3 6583.9 6673.7 6707.9 6371.0 6380.1 6413.4 6451.2 6494.7 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | [#1] ext.html Cycles:180 Average:38254.79 Median:35699.82 stddev:53582.85 (150.1%) stddev-sans-first:53659.57 05:25:25 INFO - PID 13297 | Values: 852.2 859.6 879.3 907.0 908.1 41998.4 42911.4 42913.0 42940.8 43050.6 37756.6 37983.4 37984.0 38072.8 38087.6 7015.6 7089.8 7124.6 7158.5 7170.0 7046.9 7088.0 7119.1 7151.8 7155.5 7318.9 7901.2 7954.2 7993.5 7996.7 7882.5 7901.6 7921.7 7960.9 7961.5 7629.2 7757.3 7852.2 7855.7 7860.2 39323.2 39402.4 39470.8 39480.2 39597.6 3594.5 3609.8 3615.5 3640.8 3642.1 31661.5 31765.4 31800.2 31833.7 31853.2 5135.4 5161.6 5184.2 5194.4 5196.0 179580.0 180120.0 180253.0 180261.0 180474.0 49597.8 49893.5 50044.2 50101.5 50205.2 51479.7 52026.2 52061.0 52097.5 52148.7 16633.8 17084.6 17101.2 17101.5 17119.7 13941.2 14036.6 14046.2 14051.3 14084.9 14724.1 14771.8 15018.9 15063.7 15124.7 5746.3 5864.1 5876.6 6048.5 6049.9 994.6 1001.0 1020.9 1033.1 1034.4 22698.3 22777.8 22886.9 23128.0 23533.8 1115.2 1119.1 1119.8 1121.2 1126.4 12167.6 12197.5 12257.9 12305.4 12308.7 228783.0 229046.0 229435.0 230337.0 232747.0 53729.5 53929.5 55802.0 57233.4 59844.0 1462.5 1494.1 1506.1 1511.6 1515.8 26787.9 27101.5 27115.5 27221.5 27456.6 50605.7 51567.0 51636.0 51659.2 51678.7 204143.0 206055.0 207531.0 207999.0 208573.0 34473.5 34608.7 34867.8 34949.8 35129.6 41410.4 42931.6 43103.8 43109.6 43601.0 31808.0 32008.5 32107.4 32231.4 32520.2 31653.4 31967.4 31971.0 32116.7 32246.7 35558.1 35617.0 35782.6 35815.5 35957.6 31323.4 31550.4 31654.2 31774.5 32555.3 23050.7 23055.2 23975.0 24642.8 25311.4 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | [#2] jquery.html Cycles:180 Average:37257.30 Median:23357.03 stddev:90803.95 (388.8%) stddev-sans-first:91016.93 05:25:25 INFO - PID 13297 | Values: 581.8 583.7 589.8 591.5 598.6 22194.8 22583.8 23326.3 23535.8 23572.9 27244.2 27739.7 27833.6 27861.2 27885.0 6587.7 6740.3 6740.4 6742.6 6769.6 6000.9 6568.4 6599.1 6622.1 6648.9 6560.2 6566.7 6567.7 6569.9 6571.2 6534.8 6545.0 6557.8 6562.1 6568.0 6109.8 6111.5 6114.2 6132.7 6136.4 27476.0 29694.9 30272.8 30528.8 30867.4 1921.6 1944.3 1948.4 1949.6 1950.3 19753.4 20032.8 20033.3 20127.5 20189.2 2384.1 2416.9 2468.7 2525.8 2534.1 136272.0 142604.0 142641.0 142669.6 143346.3 14312.1 14809.8 15369.3 15436.7 15453.3 24244.1 24362.4 24424.9 24441.9 24476.1 10334.0 10456.3 10484.6 10570.2 10801.2 9942.2 9990.7 10070.9 10131.1 10335.6 7748.7 9117.9 9165.3 9212.7 9387.3 2672.7 2679.7 2770.9 2775.9 2823.4 960.5 972.0 987.5 988.5 991.4 19308.3 19770.0 20216.8 20285.1 20572.8 1050.0 1059.1 1062.3 1062.7 1066.2 11022.4 11369.2 11415.0 11437.3 11456.2 494155.0 537865.0 551512.0 554840.0 558726.0 125171.0 126912.0 128792.0 130474.3 131076.0 1275.1 1290.9 1324.7 1326.2 1339.3 20887.8 21087.0 21183.8 21190.8 21213.7 59932.0 61028.0 61362.7 62347.0 63367.4 76786.0 76936.2 77403.6 77783.6 77806.6 12481.0 13040.2 14556.9 14633.3 15170.5 23387.8 23677.0 23722.2 25291.0 25340.4 19153.8 19211.2 19277.8 19413.9 19441.4 17401.7 17461.2 17645.8 17665.7 17913.4 18836.4 18873.0 19039.0 19126.8 19957.6 14772.3 14920.0 14973.7 14976.9 14979.5 17355.6 17506.3 18146.2 18552.4 18658.3 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | [#3] mootools.html Cycles:180 Average:8772.08 Median:2627.45 stddev:6003.30 (228.5%) stddev-sans-first:5994.14 05:25:25 INFO - PID 13297 | Values: 1336.9 1368.9 1384.6 1404.6 1405.6 13664.3 14306.7 14311.1 14315.3 14350.9 13798.4 14598.9 14662.3 14674.3 14683.0 2686.1 2709.3 2718.1 2720.8 2725.9 2561.0 2583.2 2662.3 2710.5 2713.7 2755.4 2762.8 2773.3 2773.7 2774.8 2680.7 2704.6 2711.1 2721.5 2726.0 2592.1 2600.7 2626.5 2628.4 2643.3 13774.5 13894.8 14067.7 14071.9 14074.6 7472.6 7719.0 7743.6 7750.4 7759.3 5114.5 5125.3 5133.6 5294.3 5385.0 1924.9 1930.3 1933.3 1975.5 1976.2 23105.5 23196.3 23276.1 23380.8 23387.6 7077.1 7080.4 7224.5 7319.5 7333.0 15741.7 15793.9 15827.1 15847.6 15887.6 7486.4 7723.0 7730.3 7732.7 7734.7 6953.4 7002.8 7104.1 7109.8 7136.2 4959.6 5093.8 5102.9 5109.3 5121.7 1353.5 1385.4 1514.1 1530.6 1574.6 863.3 868.4 887.0 888.6 903.0 8211.8 8287.7 8328.3 8353.5 8443.8 700.1 799.1 951.2 997.3 1002.8 5012.6 5082.6 5254.8 5282.1 5316.6 19277.6 19922.1 20027.9 20072.1 20078.0 19097.2 19495.5 19736.3 19788.6 20168.5 10530.0 10749.5 10749.8 10777.8 10813.8 7721.7 8084.8 8158.4 8296.5 8582.0 16503.8 16657.1 16701.8 17009.4 17229.9 17452.5 17641.7 17665.5 17736.8 18184.9 10969.2 11440.3 11494.2 11516.7 11516.7 12432.7 12535.7 12657.8 12660.3 12662.6 10524.6 10612.2 10791.6 10859.4 10866.5 10216.4 10270.6 10376.1 10425.4 10698.4 9358.0 9445.1 9468.3 9491.1 9498.6 6412.6 6511.9 6512.0 6561.9 6589.6 6437.6 6484.9 6555.6 6571.1 6612.6 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | [#4] prototype.html Cycles:180 Average:5503.01 Median:6061.21 stddev:1543.88 (25.5%) stddev-sans-first:1501.81 05:25:25 INFO - PID 13297 | Values: 497.9 499.4 526.0 529.4 534.0 6208.3 6210.3 6226.0 6264.6 6271.4 5828.2 5949.8 6048.6 6049.6 6160.0 4908.3 4909.9 4931.1 4955.5 4958.4 4874.7 4924.4 4928.1 4961.5 4993.9 4896.8 4944.4 4945.1 4958.0 4972.6 4873.0 4874.6 4957.0 4973.2 4987.4 4461.7 4475.6 4487.9 4500.0 4507.2 6017.2 6056.5 6066.0 6095.4 6108.8 5685.3 5710.5 5722.5 5733.8 5747.6 6487.2 6554.5 6570.4 6585.9 6627.3 4860.0 4864.4 4875.3 4887.8 4904.5 6687.9 6744.9 6764.2 6848.8 6922.7 4958.7 4966.9 4967.0 5015.7 5033.4 5057.3 5065.9 5079.5 5103.7 5108.6 5692.7 5694.1 5716.9 5732.3 5737.5 6494.7 6511.2 6559.7 6593.5 6620.8 1690.7 1704.0 1705.7 1736.5 1777.2 1211.7 1239.5 1240.8 1257.0 1265.5 5734.8 5775.7 5776.6 5781.5 5783.1 6641.3 6729.2 6731.3 6772.1 6843.9 5580.7 5698.0 5783.0 5787.5 5830.8 3591.9 3614.6 3619.8 3633.4 3651.7 6482.0 6500.0 6545.2 6568.1 6625.8 6882.6 6946.6 6948.0 6972.3 6983.2 6470.9 6514.2 6528.9 6536.7 6549.5 6705.3 6766.5 6796.0 6827.4 6839.2 6646.9 6671.7 6731.1 6747.3 6753.6 6524.2 6527.0 6564.3 6571.2 6597.3 4922.7 4977.4 4985.3 4985.3 4998.7 6587.9 6601.9 6702.2 6723.9 6791.8 6478.6 6549.7 6551.9 6571.3 6636.8 6326.7 6473.7 6482.8 6485.4 6563.6 6220.0 6341.8 6384.7 6390.8 6414.8 6463.9 6466.6 6470.6 6513.9 6559.6 6256.7 6275.0 6321.3 6352.8 6396.0 05:25:25 INFO - PID 13297 | 05:25:25 INFO - PID 13297 | [#5] yui.html Cycles:180 Average:22820.47 Median:19164.28 stddev:31136.25 (162.5%) stddev-sans-first:31180.11 05:25:25 INFO - PID 13297 | Values: 905.4 914.3 937.1 940.0 941.6 17029.0 17827.3 17839.5 17975.2 20778.2 20000.0 20118.7 20264.0 20278.2 20636.8 1004.4 1067.8 1068.4 1070.5 1070.7 1059.2 1059.8 1060.0 1062.6 1062.7 1068.1 1101.2 1120.1 1121.6 1123.4 1102.1 1104.5 1105.6 1107.4 1108.4 782.6 789.8 790.7 792.9 794.4 17449.0 19228.0 19369.8 19372.7 19446.1 18447.4 18556.6 18778.9 19058.9 19184.4 16754.0 16767.2 17100.0 17111.7 17112.0 3581.4 3650.6 3651.7 3653.8 3657.9 122540.4 125395.4 126657.0 128003.0 128824.4 16230.4 16419.1 16471.7 16541.1 16872.0 29572.9 30917.0 31457.8 31649.2 31717.0 8579.7 8635.3 8707.8 8709.5 8764.4 3780.9 3859.0 3878.1 3883.5 3886.7 5163.1 5268.6 5325.8 5332.7 5333.1 1042.0 1082.6 1085.6 1086.5 1098.7 706.4 719.3 720.4 726.5 732.9 12298.6 12300.1 12325.3 12514.8 12567.7 709.2 716.6 719.6 726.8 736.8 5375.9 5377.2 5403.6 5403.6 5440.4 104180.0 104589.0 107673.0 107877.5 110219.0 95615.0 95862.5 96885.0 96887.5 100988.5 81668.0 85395.6 87929.6 88338.6 92815.0 12029.2 12873.8 12882.3 12952.5 13049.7 36129.6 36208.3 36216.3 37637.1 38428.2 43966.6 44529.0 44826.1 45026.8 46009.3 18780.8 19242.1 19284.3 19448.4 19542.8 20438.8 21025.5 21173.0 21177.0 21722.2 18507.8 18697.0 18773.3 18780.4 19144.1 16355.4 17115.5 17568.6 17572.9 18355.4 17529.7 17648.3 17757.7 17783.1 17896.5 12858.7 12984.4 13213.8 13226.1 13242.3 13017.3 13158.8 13232.7 13334.8 13495.3 05:25:25 INFO - PID 13297 | -------- Summary: end -------- 05:25:25 INFO - PID 13297 | 05:25:26 INFO - TEST-INFO | 13297: exit 0 05:25:26 INFO - TEST-OK | dromaeo_css | took 1112209ms 05:25:26 INFO - TEST-START | kraken 05:25:26 INFO - Initialising browser for kraken test... 05:25:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46230/getInfo.html -profile /tmp/tmpWh3kLI/profile 05:25:26 INFO - TEST-INFO | started process 13672 (/builds/slave/test/build/application/firefox/firefox http://localhost:46230/getInfo.html) 05:25:32 INFO - TEST-INFO | 13672: exit 0 05:25:32 INFO - Browser initialized. 05:25:32 INFO - Running cycle 1/1 for kraken test... 05:25:32 INFO - TEST-INFO | started process 13900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWh3kLI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:33 INFO - PID 13900 | 05:25:33 INFO - PID 13900 | (/builds/slave/test/build/application/firefox/firefox:13954): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:25:33 INFO - PID 13900 | 05:25:43 INFO - PID 13900 | RSS: Main: 173854720 05:25:43 INFO - PID 13900 | 05:25:46 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46230/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:47 INFO - PID 13900 | RSS: Main: 178049024 05:25:47 INFO - PID 13900 | 05:25:50 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46230/tests/kraken/driver.html?testName=audio-dft) 05:25:50 INFO - PID 13900 | RSS: Main: 178503680 05:25:50 INFO - PID 13900 | 05:25:53 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46230/tests/kraken/driver.html?testName=audio-fft) 05:25:54 INFO - PID 13900 | RSS: Main: 173449216 05:25:54 INFO - PID 13900 | 05:25:56 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46230/tests/kraken/driver.html?testName=audio-oscillator) 05:25:57 INFO - PID 13900 | RSS: Main: 174071808 05:25:57 INFO - PID 13900 | 05:25:59 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:00 INFO - PID 13900 | RSS: Main: 174231552 05:26:00 INFO - PID 13900 | 05:26:03 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46230/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:03 INFO - PID 13900 | RSS: Main: 177098752 05:26:03 INFO - PID 13900 | 05:26:07 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46230/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:08 INFO - PID 13900 | RSS: Main: 177139712 05:26:08 INFO - PID 13900 | 05:26:11 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46230/tests/kraken/driver.html?testName=json-parse-financial) 05:26:11 INFO - PID 13900 | RSS: Main: 177713152 05:26:11 INFO - PID 13900 | 05:26:13 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:13 INFO - PID 13900 | RSS: Main: 177520640 05:26:13 INFO - PID 13900 | 05:26:15 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:16 INFO - PID 13900 | RSS: Main: 174645248 05:26:16 INFO - PID 13900 | 05:26:18 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:19 INFO - PID 13900 | RSS: Main: 174465024 05:26:19 INFO - PID 13900 | 05:26:21 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:22 INFO - PID 13900 | RSS: Main: 174944256 05:26:22 INFO - PID 13900 | 05:26:25 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:26 INFO - PID 13900 | RSS: Main: 174768128 05:26:26 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | Cycle 1(1): loaded http://localhost:46230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46230/tests/kraken/driver.html?testName=ai-astar) 05:26:28 INFO - PID 13900 | RSS: Main: 176771072 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | __start_tp_report 05:26:28 INFO - PID 13900 | _x_x_mozilla_page_load 05:26:28 INFO - PID 13900 | _x_x_mozilla_page_load_details 05:26:28 INFO - PID 13900 | |i|pagename|runs| 05:26:28 INFO - PID 13900 | |0;ai-astar;98;107;101;107;108;110;111;102;107;107 05:26:28 INFO - PID 13900 | |1;audio-beat-detection;142;116;142;173;123;148;146;118;166;121 05:26:28 INFO - PID 13900 | |2;audio-dft;167;163;169;163;174;164;164;165;170;165 05:26:28 INFO - PID 13900 | |3;audio-fft;77;78;83;166;76;75;74;81;94;76 05:26:28 INFO - PID 13900 | |4;audio-oscillator;80;87;134;79;78;83;137;80;78;133 05:26:28 INFO - PID 13900 | |5;imaging-gaussian-blur;114;113;115;114;121;115;116;113;116;113 05:26:28 INFO - PID 13900 | |6;imaging-darkroom;157;153;155;152;150;150;151;150;151;150 05:26:28 INFO - PID 13900 | |7;imaging-desaturate;94;95;94;103;98;94;94;94;95;100 05:26:28 INFO - PID 13900 | |8;json-parse-financial;52;52;53;53;53;58;53;53;54;54 05:26:28 INFO - PID 13900 | |9;json-stringify-tinderbox;62;57;53;54;54;54;54;53;55;53 05:26:28 INFO - PID 13900 | |10;stanford-crypto-aes;86;80;83;79;88;84;78;86;78;77 05:26:28 INFO - PID 13900 | |11;stanford-crypto-ccm;130;140;131;133;125;130;126;138;133;170 05:26:28 INFO - PID 13900 | |12;stanford-crypto-pbkdf2;192;175;177;174;176;184;175;174;183;175 05:26:28 INFO - PID 13900 | |13;stanford-crypto-sha256-iterative;73;71;66;66;72;68;71;68;74;67 05:26:28 INFO - PID 13900 | __end_tp_report 05:26:28 INFO - PID 13900 | __start_cc_report 05:26:28 INFO - PID 13900 | _x_x_mozilla_cycle_collect,938 05:26:28 INFO - PID 13900 | __end_cc_report 05:26:28 INFO - PID 13900 | __startTimestamp1502195188583__endTimestamp 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | ------- Summary: start ------- 05:26:28 INFO - PID 13900 | Number of tests: 14 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#0] ai-astar Cycles:10 Average:105.80 Median:107.50 stddev:4.13 (3.8%) stddev-sans-first:3.28 05:26:28 INFO - PID 13900 | Values: 98.0 107.0 101.0 107.0 108.0 110.0 111.0 102.0 107.0 107.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:144.00 stddev:19.95 (13.9%) stddev-sans-first:21.14 05:26:28 INFO - PID 13900 | Values: 142.0 116.0 142.0 173.0 123.0 148.0 146.0 118.0 166.0 121.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:3.60 (2.2%) stddev-sans-first:3.81 05:26:28 INFO - PID 13900 | Values: 167.0 163.0 169.0 163.0 174.0 164.0 164.0 165.0 170.0 165.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#3] audio-fft Cycles:10 Average:88.00 Median:77.50 stddev:28.02 (36.2%) stddev-sans-first:29.44 05:26:28 INFO - PID 13900 | Values: 77.0 78.0 83.0 166.0 76.0 75.0 74.0 81.0 94.0 76.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:79.50 stddev:26.21 (33.0%) stddev-sans-first:27.08 05:26:28 INFO - PID 13900 | Values: 80.0 87.0 134.0 79.0 78.0 83.0 137.0 80.0 78.0 133.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:2.40 (2.1%) stddev-sans-first:2.52 05:26:28 INFO - PID 13900 | Values: 114.0 113.0 115.0 114.0 121.0 115.0 116.0 113.0 116.0 113.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:151.50 stddev:2.42 (1.6%) stddev-sans-first:1.73 05:26:28 INFO - PID 13900 | Values: 157.0 153.0 155.0 152.0 150.0 150.0 151.0 150.0 151.0 150.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:94.00 stddev:3.18 (3.4%) stddev-sans-first:3.28 05:26:28 INFO - PID 13900 | Values: 94.0 95.0 94.0 103.0 98.0 94.0 94.0 94.0 95.0 100.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:1.72 (3.2%) stddev-sans-first:1.73 05:26:28 INFO - PID 13900 | Values: 52.0 52.0 53.0 53.0 53.0 58.0 53.0 53.0 54.0 54.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:54.00 stddev:2.77 (5.1%) stddev-sans-first:1.27 05:26:28 INFO - PID 13900 | Values: 62.0 57.0 53.0 54.0 54.0 54.0 54.0 53.0 55.0 53.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:83.50 stddev:3.98 (4.8%) stddev-sans-first:3.94 05:26:28 INFO - PID 13900 | Values: 86.0 80.0 83.0 79.0 88.0 84.0 78.0 86.0 78.0 77.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:133.00 stddev:12.95 (9.7%) stddev-sans-first:13.58 05:26:28 INFO - PID 13900 | Values: 130.0 140.0 131.0 133.0 125.0 130.0 126.0 138.0 133.0 170.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:176.50 stddev:5.95 (3.4%) stddev-sans-first:3.81 05:26:28 INFO - PID 13900 | Values: 192.0 175.0 177.0 174.0 176.0 184.0 175.0 174.0 183.0 175.0 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:71.00 stddev:2.95 (4.2%) stddev-sans-first:2.86 05:26:28 INFO - PID 13900 | Values: 73.0 71.0 66.0 66.0 72.0 68.0 71.0 68.0 74.0 67.0 05:26:28 INFO - PID 13900 | -------- Summary: end -------- 05:26:28 INFO - PID 13900 | 05:26:28 INFO - PID 13900 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:26:29 INFO - TEST-INFO | 13900: exit 0 05:26:29 INFO - TEST-OK | kraken | took 62810ms 05:26:29 INFO - SUITE-END | took 1175s 05:26:29 INFO - Completed test suite (00:19:35) 05:26:29 INFO - javascript benchmark 05:26:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8539.334793412221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.054483382569, 3168.429682657122, 3175.4760464523356, 3178.6821317868216, 3243.983780081099, 6171.47542458891, 6307.053941908716, 6331.145295385128, 6331.303556608781, 6365.42711155997, 6134.478569321613, 6203.472704820085, 6209.0, 6238.220222472191, 6398.648074355909, 5719.771209151629, 5741.425857414246, 5750.281214848144, 5803.01348770709, 5834.649921004753, 88.32219938335042, 5750.482456578907, 5762.366139724627, 5836.620619659709, 5862.032764593858, 5360.2227676987, 5744.224529688522, 5820.767169313222, 5822.359540450547, 5826.970865145647, 5722.62802917809, 5731.398203188647, 5747.712614369307, 5830.941690583082, 5832.737526811304, 5613.46672066153, 5646.774129034875, 5686.5735069869925, 5704.828855134353, 5743.827685169452, 6113.786017489367, 6124.203853499062, 6242.656653884034, 6263.655498947556, 6329.145565348711, 6591.209054913393, 6605.504587155982, 6610.7025183866845, 6649.3350664933605, 6720.19357677077, 6801.0, 6806.6256355900405, 6807.047013418125, 6811.114555107804, 6812.284710105417, 6265.655388953605, 6270.78052268173, 6318.715657795365, 6320.5891617044745, 6324.494040476751, 6799.3200679931615, 6873.931260687429, 6960.164780226304, 6974.232834388214, 6980.965095174492, 6521.054447105238, 6541.378569035934, 6584.144061272004, 6630.469562434993, 6651.800445986628, 6583.111279977237, 6687.832804179934, 6721.596704197764, 6772.55978361405, 6776.15298087739, 6709.798706038827, 6711.7315307388135, 6717.059611654372, 6717.328267173243, 6719.563228390139, 6617.272100068989, 6699.933000669931, 6707.6981535831, 6760.0535924970545, 6760.864782704319, 5421.213923981, 5422.295101636762, 5423.105187644073, 5452.972735136299, 5545.417731138253, 4708.081924024782, 4728.0780247851335, 4728.1252968201, 4729.69256998294, 4733.644976626767, 5775.971120144372, 5780.624259423208, 5845.853853653693, 5856.94143058564, 5861.0915308127305, 6662.6668666566475, 6740.83147921296, 6785.1518560179975, 6786.151731033621, 6814.93185068143, 5807.216025836458, 5816.214811000461, 5816.970915145397, 5819.0689489681445, 5820.592558520948, 5970.13433052205, 5977.013792724239, 5992.191054207713, 5992.970035149797, 5997.640141591519, 6417.614943103429, 6474.417302442803, 6491.740330386731, 6545.345465453416, 6550.0829883816305, 6659.433948114464, 6726.125603671491, 6744.797656070227, 6762.966185169043, 6823.522353435411, 6385.329540398191, 6401.103845461546, 6406.647634379968, 6492.156019717407, 6508.479321654351, 6604.735810567524, 6653.367930046831, 6655.401013908578, 6731.225909020525, 6741.629210393476, 6820.181578210647, 6838.794836154923, 6841.315868413119, 6842.384185423336, 6846.075779769866, 6595.868082638416, 6605.933940660532, 6629.370209830058, 6642.933570664231, 6644.202695676549, 6541.476681865534, 6560.868782624225, 6561.80314590563, 6656.034874943203, 6659.600423974577, 6419.45434638061, 6473.385028422293, 6482.962725963823, 6566.606003639797, 6571.178602674666, 6557.245916719638, 6568.343165683585, 6583.868322633425, 6673.666316684244, 6707.899381509379, 6370.96814515943, 6380.138681277968, 6413.390727880844, 6451.225852897683, 6494.74021039172], "value": 6103.5841632660195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.2372476633413, 859.6303589456531, 879.2921698033084, 906.9591868365923, 908.087372190948, 41998.37002444966, 42911.35632965508, 42913.0, 42940.785296073474, 43050.56949430505, 37756.62243377566, 37983.43024854629, 37984.0, 38072.80963595178, 38087.61912380882, 7015.6141412222305, 7089.751858684947, 7124.5725256484775, 7158.46311526635, 7169.964150179242, 7046.894296585555, 7087.964560177192, 7119.074520312378, 7151.821204469878, 7155.534890232144, 7318.926810731904, 7901.170377110407, 7954.16481269467, 7993.480423772466, 7996.720114795983, 7882.5270483771155, 7901.565413902233, 7921.683132674686, 7960.9203907960755, 7961.482503637274, 7629.198934111894, 7757.301842834172, 7852.21477852216, 7855.725049623293, 7860.174681658458, 39323.21353572941, 39402.408963865564, 39470.80264598687, 39480.210395791924, 39597.60402395997, 3594.51474051005, 3609.8014609196484, 3615.5119058927235, 3640.8179591020344, 3642.1076836175043, 31661.52507712386, 31765.364692706247, 31800.204994875083, 31833.681663183535, 31853.203669908205, 5135.3837539495125, 5161.612879034087, 5184.196449550326, 5194.35070616173, 5195.974020129913, 179580.0, 180120.0, 180253.0, 180261.0, 180474.0, 49597.75201124044, 49893.501064989614, 50044.24933625926, 50101.49898500968, 50205.24692129621, 51479.74260128675, 52026.21960670593, 52061.0, 52097.47902521002, 52148.739256303474, 16633.750493742602, 17084.57288567771, 17101.230444630022, 17101.48695539136, 17119.657606848043, 13941.163530188222, 14036.578902632937, 14046.227457489731, 14051.297435128407, 14084.929575352058, 14724.116553006854, 14771.778423323658, 15018.924905375621, 15063.719583835278, 15124.697506049817, 5746.310442746897, 5864.149698293723, 5876.559258055663, 6048.516118710492, 6049.939500605025, 994.6419289055934, 1000.9949950250202, 1020.9234307426973, 1033.0857191385528, 1034.4310629153936, 22698.319050428512, 22777.80275891691, 22886.8855655724, 23128.0, 23533.76466235316, 1115.1524841120645, 1119.1158984402393, 1119.7928383249125, 1121.1647322744607, 1126.3523474002482, 12167.634970950709, 12197.512099516098, 12257.938710306391, 12305.384730763426, 12308.692282692826, 228783.0, 229046.0, 229435.0, 230337.0, 232747.0, 53729.46270537245, 53929.46070539323, 55802.0, 57233.42766572281, 59844.0, 1462.473509536566, 1494.0662086196128, 1506.0812904128254, 1511.6220944763809, 1515.7650564162573, 26787.86606066957, 27101.457970840867, 27115.457690846466, 27221.455570888076, 27456.588151177348, 50605.74697126491, 51567.0, 51636.0, 51659.22511162411, 51678.74160629323, 204143.0, 206055.0, 207531.0, 207999.0, 208573.0, 34473.48289775706, 34608.65391346054, 34867.82566087255, 34949.77675781336, 35129.64870351264, 41410.378844317966, 42931.570684292754, 43103.7844810774, 43109.56890431055, 43601.0, 31808.0, 32008.51987220147, 32107.35785284328, 32231.35537289288, 32520.186995325304, 31653.36693266168, 31967.36065278728, 31971.0, 32116.67883321137, 32246.677533225306, 35558.111047224025, 35617.0, 35782.64217357897, 35815.46276805798, 35957.64042359647, 31323.373532529677, 31550.36899262048, 31654.208644784063, 31774.52338214975, 32555.34889302153, 23050.654240186745, 23055.19306824253, 23975.0, 24642.753572464047, 25311.36721581975], "value": 17540.25173446379, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.7672930827669, 583.7431530126746, 589.7906243283633, 591.5385998920843, 598.5989387110635, 22194.778052219513, 22583.774162258393, 23326.300210993697, 23535.76464235359, 23572.88213558934, 27244.182674519798, 27739.722602773967, 27833.582496262523, 27861.164165075028, 27885.0, 6587.703553340088, 6740.32596740327, 6740.427063699592, 6742.595444273359, 6769.593824370529, 6000.909986350208, 6568.441682456997, 6599.10912026875, 6622.106015687868, 6648.900266496006, 6560.2455717592375, 6566.704498297588, 6567.704453299613, 6569.868602627945, 6571.178602674666, 6534.836629084263, 6545.0, 6557.803265902031, 6562.114114594517, 6568.0, 6109.755609775603, 6111.480524155452, 6114.1745864308195, 6132.662703551303, 6136.386361363872, 27476.03833865825, 29694.851525742233, 30272.84863575668, 30528.84735576308, 30867.382652346827, 1921.567647279365, 1944.3097700316325, 1948.4349538633778, 1949.629570381623, 1950.317388913883, 19753.40739777809, 20032.79967200324, 20033.29883454072, 20127.496812579655, 20189.19243230269, 2384.07960199005, 2416.9274921752376, 2468.7037555493275, 2525.835820671669, 2534.0750626021554, 136272.0, 142604.0, 142641.0, 142669.57330426667, 143346.28326858403, 14312.141271523742, 14809.777853332209, 15369.308381122877, 15436.691266174837, 15453.304601292968, 24244.090709114666, 24362.390940226283, 24424.87787561051, 24441.87779061093, 24476.14333498319, 10334.0, 10456.32033917793, 10484.63303784364, 10570.207234457446, 10801.189910756724, 9942.154916832005, 9990.700278991642, 10070.949645251727, 10131.138853197413, 10335.586576537005, 7748.690052397954, 9117.908820911705, 9165.312601554777, 9212.677556285631, 9387.295952803566, 2672.6525551678546, 2679.7454241846995, 2770.9307267318477, 2775.9028434004713, 2823.378856651533, 960.4813400763649, 971.9805603887883, 987.4914419074182, 988.4909271725068, 991.4447909170888, 19308.32420865263, 19770.0, 20216.797832021784, 20285.087171077335, 20572.79427205739, 1050.0444595418132, 1059.1050562274866, 1062.325423356159, 1062.7077553672802, 1066.1950227578284, 11022.393768342818, 11369.204155709022, 11415.0, 11437.313761174357, 11456.19806613529, 494155.0, 537865.0, 551512.0, 554840.0, 558726.0, 125171.0, 126912.0, 128792.0, 130474.34762826315, 131076.0, 1275.0819410024767, 1290.851552071505, 1324.6555895467247, 1326.1777697827408, 1339.2634051271762, 20887.791122088584, 21087.0, 21183.7881621188, 21190.78809211888, 21213.681794773398, 59932.0, 61028.0, 61362.69318653378, 62347.0, 63367.36632633799, 76786.0, 76936.2306376929, 77403.61298193473, 77783.6110819465, 77806.6109669448, 12481.0, 13040.217586944813, 14556.85443145555, 14633.268336582916, 15170.469033583771, 23387.76612233924, 23677.0, 23722.169724059575, 25291.0, 25340.366490837878, 19153.808461915203, 19211.231550737815, 19277.8072219276, 19413.902930485256, 19441.416757497296, 17401.738973915653, 17461.214245358737, 17645.823541764417, 17665.735013975056, 17913.373031944342, 18836.434906952814, 18873.0, 19039.0, 19126.808731912504, 19957.60084798325, 14772.33524491379, 14920.0, 14973.700525989638, 14976.850231497545, 14979.475718349806, 17355.56611084733, 17506.299748009937, 18146.18342174632, 18552.350667726565, 18658.253669853053], "value": 12376.810415894563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.9131006484579, 1368.8631136886313, 1384.6123085536042, 1404.6137312239132, 1405.5853523210646, 13664.31678416079, 14306.713865722691, 14311.141331520103, 14315.284235788222, 14350.856491435083, 13798.379072941716, 14598.854011459882, 14662.26688665565, 14674.339654715537, 14683.0, 2686.1001564475923, 2709.282040259333, 2718.0894400375896, 2720.8231464954715, 2725.9045933392335, 2561.0140096062964, 2583.173384516946, 2662.294491959632, 2710.471458065678, 2713.7014928357867, 2755.3524921643398, 2762.8342299461997, 2773.320536468568, 2773.736495032979, 2774.833509989397, 2680.7453291937236, 2704.594310853368, 2711.1188863619304, 2721.4557088582264, 2725.99999999999, 2592.0798116668498, 2600.7139214686367, 2626.500964816679, 2628.4086080631896, 2643.299525625711, 13774.517891873737, 13894.791578126336, 14067.718645627132, 14071.859281407158, 14074.648133796634, 7472.58900760458, 7718.9965304510615, 7743.612819359009, 7750.418718596128, 7759.340456061242, 5114.462981386975, 5125.282460455539, 5133.614978876599, 5294.285271488338, 5384.973075134639, 1924.9326273580357, 1930.2954421636002, 1933.2750218668, 1975.5357490989607, 1976.179885347579, 23105.53788924229, 23196.3041108767, 23276.06895724169, 23380.76619233803, 23387.649185262235, 7077.128250722423, 7080.362767350963, 7224.530405523624, 7319.5242309249725, 7332.96333518329, 15741.68516629661, 15793.921030394775, 15827.050376977419, 15847.603809904844, 15887.602809929844, 7486.401087912954, 7723.0, 7730.265624765639, 7732.729354472679, 7734.729284475016, 6953.4089602384365, 7002.7899163025195, 7104.076470058859, 7109.822254443577, 7136.179339375934, 4959.628027897922, 5093.770780314895, 5102.923456148161, 5109.284700141909, 5121.718305493159, 1353.5059703208258, 1385.3835043405588, 1514.0612820051417, 1530.5637893200385, 1574.6220906982242, 863.3222920007764, 868.4268382867277, 886.9733907982642, 888.6134531478828, 903.0472851142108, 8211.794705132419, 8287.668493260322, 8328.250457458858, 8353.457025293337, 8443.831123377498, 700.0793955947912, 799.1409235072321, 951.2009911674088, 997.3218211616171, 1002.7593377589326, 5012.624053196025, 5082.567981721595, 5254.79139797841, 5282.128448805904, 5316.627836051439, 19277.614447710966, 19922.103505342293, 20027.899860500605, 20072.09675564603, 20078.0, 19097.2361105557, 19495.512612184808, 19736.309229177197, 19788.604227915363, 20168.49578760543, 10530.0, 10749.462526873625, 10749.78500429987, 10777.78444431107, 10813.83779243312, 7721.652525636472, 8084.797880052811, 8158.4289099762445, 8296.460730052528, 8582.0, 16503.83496165071, 16657.083860387796, 16701.832981670028, 17009.404670836462, 17229.91385043067, 17452.47642570725, 17641.73537396966, 17665.470035898943, 17736.822631774034, 18184.90907545454, 10969.23215374916, 11440.313581185155, 11494.195406321478, 11516.712082198012, 11516.712082198012, 12432.689182770504, 12535.686607834878, 12657.810132848199, 12660.303683297507, 12662.620121396372, 10524.579016839241, 10612.204084693833, 10791.622293220014, 10859.402732849769, 10866.511007004861, 10216.438095904796, 10270.6405275815, 10376.118029967236, 10425.426601536989, 10698.358098514114, 9357.953210233905, 9445.102715242041, 9468.289878259297, 9491.145796878314, 9498.620055197714, 6412.647304398303, 6511.902321465276, 6511.967440162769, 6561.868762624817, 6589.604623722592, 6437.645929473924, 6484.870302593828, 6555.6066636002, 6571.145751052332, 6612.603243805387], "value": 6399.175156398625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.90212581258317, 499.43925233644836, 525.9842204733858, 529.3859123416837, 533.9866503337414, 6208.286047104584, 6210.316865144836, 6226.0, 6264.62412255265, 6271.435570798627, 5828.184054232411, 5949.762009519625, 6048.637081775086, 6049.576529642927, 6159.998000649784, 4908.312836202935, 4909.926351104737, 4931.090656512657, 4955.4548999610015, 4958.429780575226, 4874.731889746063, 4924.384451943507, 4928.137575924216, 4961.5286547777905, 4993.900121997576, 4896.8041278349, 4944.406671199461, 4945.134601444751, 4957.975210123945, 4972.632526055328, 4872.951270487303, 4874.634402419815, 4956.950430495721, 4973.154563724175, 4987.361753569179, 4461.732296062214, 4475.57482039209, 4487.887802804923, 4499.955000449986, 4507.21964823896, 6017.157597936292, 6056.454919057262, 6065.969670151621, 6095.359987201325, 6108.847278818021, 5685.289338832646, 5710.486056254957, 5722.54219662426, 5733.799317023884, 5747.626404283708, 6487.204985083732, 6554.508411869081, 6570.375814297634, 6585.934140658628, 6627.304133066007, 4860.0, 4864.367632207825, 4875.317455556225, 4887.755612219375, 4904.4605093439695, 6687.933120668779, 6744.898826517606, 6764.188297404294, 6848.760293389708, 6922.723091076351, 4958.727270000185, 4966.882451448395, 4967.031428871408, 5015.749212539358, 5033.4077949855855, 5057.291979122926, 5065.873353166126, 5079.450767515943, 5103.7192954387865, 5108.565771909355, 5692.719138193873, 5694.06048002075, 5716.857078573069, 5732.3407808101765, 5737.51231145349, 6494.675266236669, 6511.153550038464, 6559.737610495622, 6593.5384523083885, 6620.801375958729, 1690.729483282669, 1703.9574010649585, 1705.6929752644394, 1736.4964160393597, 1777.1647325756874, 1211.6546784166471, 1239.5227837282712, 1240.7642547915866, 1256.9874301257053, 1265.5317532512845, 5734.77060917567, 5775.711214439261, 5776.566757493205, 5781.53747700183, 5783.132530120515, 6641.302663220389, 6729.22613899398, 6731.2932142125355, 6772.11962444879, 6843.8973415398805, 5580.716435219841, 5697.971510142423, 5782.971085144632, 5787.508061814793, 5830.76676932918, 3591.892243232707, 3614.6385361464168, 3619.782813031174, 3633.4368172933237, 3651.72612054097, 6482.0, 6499.967500162469, 6545.21457425112, 6568.113304703899, 6625.813481551077, 6882.621455819978, 6946.6179360135675, 6947.965260173667, 6972.302769722987, 6983.196932352743, 6470.870582588228, 6514.185726784152, 6528.902066469007, 6536.705848236841, 6549.541532092803, 6705.329467053256, 6766.515244648911, 6795.966020169867, 6827.419669328163, 6839.247682754993, 6646.867062658623, 6671.666416679243, 6731.124953755981, 6747.325267473213, 6753.594784312957, 6524.249711283263, 6527.0, 6564.343565643398, 6571.244306904767, 6597.3072827352435, 4922.680025798311, 4977.377827771528, 4985.277134815504, 4985.277134815504, 4998.725070121032, 6587.945928651393, 6601.9009714853355, 6702.19573651165, 6723.932760672331, 6791.762288319885, 6478.6029169207695, 6549.7380104795275, 6551.936140116039, 6571.310012448624, 6636.83407914806, 6326.6520341381665, 6473.741050357933, 6482.805515834344, 6485.416312531895, 6563.606183628997, 6219.968900155471, 6341.7950589387865, 6384.680765961776, 6390.7763228286785, 6414.807555773335, 6463.903041454476, 6466.579672321284, 6470.6441145737435, 6513.902291465537, 6559.6064236145985, 6256.655883926428, 6275.0, 6321.33625969285, 6352.841178970562, 6395.968020160056], "value": 5050.485374637826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.3888625178004, 914.2503147419114, 937.1097457415452, 939.9624015039399, 941.60923216865, 17029.0, 17827.286908523674, 17839.464816055508, 17975.19111639976, 20778.16887324509, 20000.000000000015, 20118.698219526683, 20263.986800659983, 20278.188872445084, 20636.793632063676, 1004.4029992312222, 1067.8344856547208, 1068.4444089073677, 1070.5236169904397, 1070.7430216748003, 1059.184427990447, 1059.7827445373719, 1060.0247772049695, 1062.6227689170348, 1062.6652604429619, 1068.1454836131104, 1101.2346419238631, 1120.1374941295198, 1121.6354684727455, 1123.3933675815051, 1102.0577406317564, 1104.5416152296787, 1105.6019832860163, 1107.396468924434, 1108.384846410242, 782.5656760497922, 789.7867575754572, 790.7232468635931, 792.8850316704103, 794.3843521271003, 17449.04030278334, 19228.0, 19369.80630193694, 19372.70940935887, 19446.124924378437, 18447.354342597944, 18556.628867422576, 18778.906105469385, 19058.90470547652, 19184.424467265864, 16754.0, 16767.245473953702, 17100.0, 17111.657766844717, 17112.0, 3581.4448760442174, 3650.5801832789302, 3651.72612054097, 3653.8355773990234, 3657.9451308230396, 122540.38729806383, 125395.3730231343, 126657.0, 128003.0, 128824.35587822094, 16230.431934882223, 16419.096949667884, 16471.6705665886, 16541.090240036672, 16872.0, 29572.852135739184, 30917.0, 31457.8427107863, 31649.208769780478, 31717.04848854538, 8579.742607721779, 8635.309175265964, 8707.825843483095, 8709.520976346235, 8764.386492945432, 3780.9243815123546, 3859.0352411897024, 3878.127421330178, 3883.49514563105, 3886.7279290449965, 5163.096458119814, 5268.578513718893, 5325.760340784674, 5332.706701131475, 5333.093374126331, 1041.958321667125, 1082.5561519776854, 1085.630885498934, 1086.5110700184948, 1098.6758906122714, 706.4030893894651, 719.3346154806783, 720.3876704800878, 726.5495392856462, 732.9413646908234, 12298.569550065884, 12300.138990270774, 12325.260484370967, 12514.81227781584, 12567.748645027048, 709.2163159708551, 716.6452605960083, 719.6221983458726, 726.8255618651485, 736.7789663101048, 5375.892482150335, 5377.193420986883, 5403.567714582824, 5403.621746477709, 5440.401555828856, 104180.0, 104589.0, 107673.0, 107877.460612698, 110219.0, 95615.0, 95862.52068739751, 96885.0, 96887.51556242173, 100988.49505752571, 81668.0, 85395.57302213449, 87929.56035219783, 88338.55830720934, 92815.0, 12029.218100823418, 12873.806892896428, 12882.291473969022, 12952.481900723866, 13049.739005220032, 36129.63870361368, 36208.27583448369, 36216.27567448689, 37637.05907352229, 38428.231435371694, 43966.56033439624, 44529.0, 44826.10347792961, 45026.77486612546, 46009.30986035279, 18780.812191878453, 19242.134103965636, 19284.325048623232, 19448.4165475036, 19542.804571954668, 20438.795612044283, 21025.474363141046, 21173.0, 21177.04703288325, 21722.23972160967, 18507.814921850608, 18697.0, 18773.34293299728, 18780.436586902415, 19144.138513766637, 16355.427560035818, 17115.486535403958, 17568.648627027644, 17572.91213543924, 18355.35756248525, 17529.737053944456, 17648.294068237126, 17757.73363399524, 17783.110844457467, 17896.46310610684, 12858.742825143258, 12984.415701293654, 13213.832250354923, 13226.140300880412, 13242.271675057964, 13017.284049377375, 13158.802617960548, 13232.669183270495, 13334.799978000145, 13495.325233738471], "value": 9053.780417439191, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 101.0, 107.0, 108.0, 110.0, 111.0, 102.0, 107.0, 107.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 142.0, 173.0, 123.0, 148.0, 146.0, 118.0, 166.0, 121.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 169.0, 163.0, 174.0, 164.0, 164.0, 165.0, 170.0, 165.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 83.0, 166.0, 76.0, 75.0, 74.0, 81.0, 94.0, 76.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 87.0, 134.0, 79.0, 78.0, 83.0, 137.0, 80.0, 78.0, 133.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 121.0, 115.0, 116.0, 113.0, 116.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 155.0, 152.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 103.0, 98.0, 94.0, 94.0, 94.0, 95.0, 100.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 53.0, 58.0, 53.0, 53.0, 54.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 57.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 83.0, 79.0, 88.0, 84.0, 78.0, 86.0, 78.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 140.0, 131.0, 133.0, 125.0, 130.0, 126.0, 138.0, 133.0, 170.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 175.0, 177.0, 174.0, 176.0, 184.0, 175.0, 174.0, 183.0, 175.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 66.0, 66.0, 72.0, 68.0, 71.0, 68.0, 74.0, 67.0], "value": 69.6, "unit": "score"}]}]} 05:26:29 INFO - Return code: 0 05:26:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:29 INFO - # TBPL SUCCESS # 05:26:29 INFO - Running post-action listener: _package_coverage_data 05:26:29 INFO - Running post-action listener: _resource_record_post_action 05:26:29 INFO - [mozharness: 2017-08-08 12:26:29.870299Z] Finished run-tests step (success) 05:26:29 INFO - Running post-run listener: _resource_record_post_run 05:26:29 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431788032; Read time: 8; Write time: 258660 05:26:29 INFO - TinderboxPrint: CPU usage
13.2% 05:26:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:26:29 INFO - TinderboxPrint: I/O write bytes / time
431,788,032 / 258,660 05:26:29 INFO - TinderboxPrint: CPU idle
8,265.3 (86.8%) 05:26:29 INFO - TinderboxPrint: CPU user
1,204.2 (12.6%) 05:26:29 INFO - TinderboxPrint: Swap in / out
0 / 0 05:26:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107175936; Read time: 0; Write time: 79232 05:26:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:26:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 324612096; Read time: 0; Write time: 179428 05:26:30 INFO - Running post-run listener: _upload_blobber_files 05:26:30 INFO - Blob upload gear active. 05:26:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:30 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 05:26:30 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'] 05:26:30 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 05:26:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:31 INFO - (blobuploader) - INFO - Done attempting. 05:26:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:26:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:32 INFO - (blobuploader) - INFO - Done attempting. 05:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:39 INFO - (blobuploader) - INFO - Done attempting. 05:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:40 INFO - (blobuploader) - INFO - Done attempting. 05:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:40 INFO - Return code: 0 05:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb69ac997b4772fc23998c19fee22ec679cac4556f8888033a187175cb82f0181a59a46817844a6ce9e228dae233b5d9c4d9ff783af002f3b2dd67b9ae187a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2bc1fe6ff555761cfb23e3edd2d71b3eecfb83e92f7b12b000461b5c4e2c7ae6122f0cfcb35dfa8d1f249ca5a00c78cf1f022dd4c35f82312e3915e49c4ac8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a29ff99ed910b13939509261f33906a99c2b5af340dc652b63d42693b6b2b9e61f9e98c90f21144e20c230c283b5ef5db49e2b89675756d90e7c8d63c30928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b1939d9dcb7d23b28d7b7c56621ae2d06e9c897c41039efffd316ccb69b14d79fcd968893c5ed51b693e9a519b3973aa7a2bbd6603e4b8a0eecfbe9fb07d59"} 05:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:40 INFO - Contents: 05:26:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb69ac997b4772fc23998c19fee22ec679cac4556f8888033a187175cb82f0181a59a46817844a6ce9e228dae233b5d9c4d9ff783af002f3b2dd67b9ae187a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2bc1fe6ff555761cfb23e3edd2d71b3eecfb83e92f7b12b000461b5c4e2c7ae6122f0cfcb35dfa8d1f249ca5a00c78cf1f022dd4c35f82312e3915e49c4ac8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a29ff99ed910b13939509261f33906a99c2b5af340dc652b63d42693b6b2b9e61f9e98c90f21144e20c230c283b5ef5db49e2b89675756d90e7c8d63c30928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b1939d9dcb7d23b28d7b7c56621ae2d06e9c897c41039efffd316ccb69b14d79fcd968893c5ed51b693e9a519b3973aa7a2bbd6603e4b8a0eecfbe9fb07d59"} 05:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:40 INFO - Copying logs to upload dir... 05:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.168111 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-08 05:26:40.027837) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 05:26:40.033015) ========= 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=483e410453545d07cca6935c000001ab-1502193804.354225-1683656443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb69ac997b4772fc23998c19fee22ec679cac4556f8888033a187175cb82f0181a59a46817844a6ce9e228dae233b5d9c4d9ff783af002f3b2dd67b9ae187a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2bc1fe6ff555761cfb23e3edd2d71b3eecfb83e92f7b12b000461b5c4e2c7ae6122f0cfcb35dfa8d1f249ca5a00c78cf1f022dd4c35f82312e3915e49c4ac8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a29ff99ed910b13939509261f33906a99c2b5af340dc652b63d42693b6b2b9e61f9e98c90f21144e20c230c283b5ef5db49e2b89675756d90e7c8d63c30928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b1939d9dcb7d23b28d7b7c56621ae2d06e9c897c41039efffd316ccb69b14d79fcd968893c5ed51b693e9a519b3973aa7a2bbd6603e4b8a0eecfbe9fb07d59"} build_url:https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/At2ih0kyQ7Ka5Inf4WhGAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb69ac997b4772fc23998c19fee22ec679cac4556f8888033a187175cb82f0181a59a46817844a6ce9e228dae233b5d9c4d9ff783af002f3b2dd67b9ae187a44", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2bc1fe6ff555761cfb23e3edd2d71b3eecfb83e92f7b12b000461b5c4e2c7ae6122f0cfcb35dfa8d1f249ca5a00c78cf1f022dd4c35f82312e3915e49c4ac8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a29ff99ed910b13939509261f33906a99c2b5af340dc652b63d42693b6b2b9e61f9e98c90f21144e20c230c283b5ef5db49e2b89675756d90e7c8d63c30928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b1939d9dcb7d23b28d7b7c56621ae2d06e9c897c41039efffd316ccb69b14d79fcd968893c5ed51b693e9a519b3973aa7a2bbd6603e4b8a0eecfbe9fb07d59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 05:26:40.061777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:26:40.062119) ========= 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=483e410453545d07cca6935c000001ab-1502193804.354225-1683656443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:26:40.145748) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 05:26:40.146104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 05:26:40.146439) ========= ========= Total master_lag: 0.38 =========