builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1500897089.87 results: success (0) revision: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:29.870668) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:29.871129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:29.871404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:29.906536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:29.906827) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 04:51:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.6M=0s 2017-07-24 04:51:30 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.187750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.112577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.112888) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044237 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.167085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.167418) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 --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 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 --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=ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 04:51:30,122 truncating revision to first 12 chars 2017-07-24 04:51:30,122 Setting DEBUG logging. 2017-07-24 04:51:30,122 attempt 1/10 2017-07-24 04:51:30,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60a5308fa987?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 04:51:30,449 unpacking tar archive at: mozilla-central-60a5308fa987/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.823254) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.823593) ========= script_repo_revision: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.824012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.824335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 04:51:30.834059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-24 04:51:30.834440) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:51:30 INFO - MultiFileLogger online at 20170724 04:51:30 in /builds/slave/test 04:51:30 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 04:51:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:31 INFO - {'append_to_log': False, 04:51:31 INFO - 'base_work_dir': '/builds/slave/test', 04:51:31 INFO - 'blob_upload_branch': 'Firefox', 04:51:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:31 INFO - 'branch': 'Firefox', 04:51:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:31 INFO - 'code_coverage': False, 04:51:31 INFO - 'config_files': ('talos/linux_config.py',), 04:51:31 INFO - 'default_actions': ('clobber', 04:51:31 INFO - 'read-buildbot-config', 04:51:31 INFO - 'download-and-extract', 04:51:31 INFO - 'populate-webroot', 04:51:31 INFO - 'create-virtualenv', 04:51:31 INFO - 'install', 04:51:31 INFO - 'setup-mitmproxy', 04:51:31 INFO - 'run-tests'), 04:51:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:31 INFO - 'disable_ccov_upload': False, 04:51:31 INFO - 'download_minidump_stackwalk': True, 04:51:31 INFO - 'download_symbols': 'ondemand', 04:51:31 INFO - 'enable_stylo': False, 04:51:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:31 INFO - 'gecko_profile': False, 04:51:31 INFO - 'gecko_profile_interval': 0, 04:51:31 INFO - 'installer_path': 'installer.exe', 04:51:31 INFO - 'log_level': 'info', 04:51:31 INFO - 'log_name': 'talos', 04:51:31 INFO - 'log_to_console': True, 04:51:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:51:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:51:31 INFO - 'opt_config_files': (), 04:51:31 INFO - 'pip_index': False, 04:51:31 INFO - 'suite': 'dromaeojs-e10s', 04:51:31 INFO - 'system_bits': '32', 04:51:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:31 INFO - 'title': 'talos-linux64-ix-087', 04:51:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:31 INFO - 'use_talos_json': True, 04:51:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:31 INFO - 'work_dir': 'build'} 04:51:31 INFO - [mozharness: 2017-07-24 11:51:31.009991Z] Running clobber step. 04:51:31 INFO - Running pre-action listener: _resource_record_pre_action 04:51:31 INFO - Running main action method: clobber 04:51:31 INFO - rmtree: /builds/slave/test/build 04:51:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:33 INFO - Running post-action listener: _resource_record_post_action 04:51:33 INFO - [mozharness: 2017-07-24 11:51:33.053616Z] Finished clobber step (success) 04:51:33 INFO - [mozharness: 2017-07-24 11:51:33.053740Z] Running read-buildbot-config step. 04:51:33 INFO - Running pre-action listener: _resource_record_pre_action 04:51:33 INFO - Running main action method: read_buildbot_config 04:51:33 INFO - Using buildbot properties: 04:51:33 INFO - { 04:51:33 INFO - "project": "", 04:51:33 INFO - "product": "firefox", 04:51:33 INFO - "who": "cbook@mozilla.com", 04:51:33 INFO - "installer_path": "public/build/target.tar.bz2", 04:51:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:51:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:51:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:51:33 INFO - "stage_platform": "linux64-stylosequential", 04:51:33 INFO - "basedir": "/builds/slave/test", 04:51:33 INFO - "buildnumber": 143, 04:51:33 INFO - "platform": "ubuntu64_hw_styloseq", 04:51:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:51:33 INFO - "slavebuilddir": "test", 04:51:33 INFO - "taskId": "LpUMbnBHSu6UbuN3uxN8Sw", 04:51:33 INFO - "branch": "mozilla-central", 04:51:33 INFO - "script_repo_revision": "production", 04:51:33 INFO - "revision": "60a5308fa987676fa5ed9fd5b3ad6c9938af0539", 04:51:33 INFO - "slavename": "talos-linux64-ix-087", 04:51:33 INFO - "repo_path": "mozilla-central" 04:51:33 INFO - } 04:51:33 INFO - Finding installer, test and symbols from parent task. 04:51:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LpUMbnBHSu6UbuN3uxN8Sw'}, attempt #1 04:51:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LpUMbnBHSu6UbuN3uxN8Sw'}, attempt #1 04:51:33 INFO - Task dependencies: PE7z0GOQSrS6K7moteSUmw 04:51:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw'}, attempt #1 04:51:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:51:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/test_packages.json 04:51:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip 04:51:34 INFO - Running post-action listener: _resource_record_post_action 04:51:34 INFO - [mozharness: 2017-07-24 11:51:34.431416Z] Finished read-buildbot-config step (success) 04:51:34 INFO - [mozharness: 2017-07-24 11:51:34.431639Z] Running download-and-extract step. 04:51:34 INFO - Running pre-action listener: _resource_record_pre_action 04:51:34 INFO - Running main action method: download_and_extract 04:51:34 INFO - mkdir: /builds/slave/test/build/tests 04:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:34 INFO - trying https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.test_packages.json 04:51:34 INFO - Downloading https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:51:34 INFO - Downloaded 989 bytes. 04:51:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:51:34 INFO - Using the following test package requirements: 04:51:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:51:34 INFO - u'common': [u'target.common.tests.zip'], 04:51:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:51:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:51:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:51:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:51:34 INFO - u'mozbase': [u'target.common.tests.zip'], 04:51:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:51:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:51:34 INFO - u'web-platform': [u'target.common.tests.zip', 04:51:34 INFO - u'target.web-platform.tests.tar.gz'], 04:51:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:51:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:51:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip 04:51:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:51:34 INFO - Fetch https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip into memory 04:51:36 INFO - Content-Length response header: 72761289 04:51:36 INFO - Bytes received: 72761289 04:51:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:51:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip 04:51:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:51:48 INFO - Fetch https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.common.tests.zip into memory 04:51:50 INFO - Content-Length response header: 72761289 04:51:50 INFO - Bytes received: 72761289 04:52:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.talos.tests.zip 04:52:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:52:02 INFO - Fetch https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.talos.tests.zip into memory 04:52:03 INFO - Content-Length response header: 14498976 04:52:03 INFO - Bytes received: 14498976 04:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:03 INFO - trying https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:52:03 INFO - Downloading https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:52:04 INFO - Downloaded 62005184 bytes. 04:52:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:52:04 INFO - mkdir: /builds/slave/test/properties 04:52:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:04 INFO - Contents: 04:52:04 INFO - build_url:https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 04:52:04 INFO - Running post-action listener: _resource_record_post_action 04:52:04 INFO - Running post-action listener: set_extra_try_arguments 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.603435Z] Finished download-and-extract step (success) 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.603531Z] Running populate-webroot step. 04:52:04 INFO - Running pre-action listener: _resource_record_pre_action 04:52:04 INFO - Running main action method: populate_webroot 04:52:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:04 INFO - 'tests': ['damp', 'tps']}, 04:52:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:52:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:52:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:52:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:04 INFO - 'ts_paint', 04:52:04 INFO - 'tpaint', 04:52:04 INFO - 'sessionrestore', 04:52:04 INFO - 'sessionrestore_many_windows', 04:52:04 INFO - 'sessionrestore_no_auto_restore', 04:52:04 INFO - 'tabpaint']}, 04:52:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:52:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:52:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:52:04 INFO - 'talos_options': ['--mitmproxy', 04:52:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:52:04 INFO - '--firstNonBlankPaint'], 04:52:04 INFO - 'tests': ['quantum_pageload_google', 04:52:04 INFO - 'quantum_pageload_youtube', 04:52:04 INFO - 'quantum_pageload_amazon', 04:52:04 INFO - 'quantum_pageload_facebook']}, 04:52:04 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:52:04 INFO - 'talos_options': ['--stylo', 04:52:04 INFO - '--mitmproxy', 04:52:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:52:04 INFO - '--firstNonBlankPaint'], 04:52:04 INFO - 'tests': ['quantum_pageload_google', 04:52:04 INFO - 'quantum_pageload_youtube', 04:52:04 INFO - 'quantum_pageload_amazon', 04:52:04 INFO - 'quantum_pageload_facebook']}, 04:52:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:04 INFO - 'tsvgr_opacity', 04:52:04 INFO - 'tart', 04:52:04 INFO - 'tscrollx', 04:52:04 INFO - 'cart', 04:52:04 INFO - 'tsvg_static']}, 04:52:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:04 INFO - 'talos_options': ['--xperf_path', 04:52:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:04 INFO - 'tests': ['tp5n']}}} 04:52:04 INFO - Running post-action listener: _resource_record_post_action 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.612798Z] Finished populate-webroot step (success) 04:52:04 INFO - [mozharness: 2017-07-24 11:52:04.612936Z] Running create-virtualenv step. 04:52:04 INFO - Running pre-action listener: _resource_record_pre_action 04:52:04 INFO - Running main action method: create_virtualenv 04:52:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:04 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 04:52:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:52:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:05 INFO - Using real prefix '/usr' 04:52:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:07 INFO - Installing pip.................done. 04:52:07 INFO - Return code: 0 04:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:08 INFO - Reading from file tmpfile_stdout 04:52:08 INFO - Output received: 04:52:08 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) 04:52:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:08 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 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:08 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 04:52:08 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 04:52:08 INFO - Using env: {'DISPLAY': ':0', 04:52:08 INFO - 'HOME': '/home/cltbld', 04:52:08 INFO - 'LANG': 'en_US.UTF-8', 04:52:08 INFO - 'LANGUAGE': 'en_US:en', 04:52:08 INFO - 'LOGNAME': 'cltbld', 04:52:08 INFO - 'MAIL': '/var/mail/cltbld', 04:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:08 INFO - 'MOZ_NO_REMOTE': '1', 04:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:08 INFO - 'NO_EM_RESTART': '1', 04:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:08 INFO - 'PWD': '/builds/slave/test', 04:52:08 INFO - 'SHELL': '/bin/bash', 04:52:08 INFO - 'SHLVL': '1', 04:52:08 INFO - 'TERM': 'linux', 04:52:08 INFO - 'TMOUT': '86400', 04:52:08 INFO - 'USER': 'cltbld', 04:52:08 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:08 INFO - '_': '/tools/buildbot/bin/python'} 04:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:08 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 04:52:08 INFO - Cleaning up... 04:52:08 INFO - Return code: 0 04:52:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:08 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 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:08 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 04:52:08 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 04:52:08 INFO - Using env: {'DISPLAY': ':0', 04:52:08 INFO - 'HOME': '/home/cltbld', 04:52:08 INFO - 'LANG': 'en_US.UTF-8', 04:52:08 INFO - 'LANGUAGE': 'en_US:en', 04:52:08 INFO - 'LOGNAME': 'cltbld', 04:52:08 INFO - 'MAIL': '/var/mail/cltbld', 04:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:08 INFO - 'MOZ_NO_REMOTE': '1', 04:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:08 INFO - 'NO_EM_RESTART': '1', 04:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:08 INFO - 'PWD': '/builds/slave/test', 04:52:08 INFO - 'SHELL': '/bin/bash', 04:52:08 INFO - 'SHLVL': '1', 04:52:08 INFO - 'TERM': 'linux', 04:52:08 INFO - 'TMOUT': '86400', 04:52:08 INFO - 'USER': 'cltbld', 04:52:08 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:08 INFO - '_': '/tools/buildbot/bin/python'} 04:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:08 INFO - Downloading/unpacking psutil>=3.1.1 04:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:09 INFO - Installing collected packages: psutil 04:52:09 INFO - Running setup.py install for psutil 04:52:10 INFO - building 'psutil._psutil_linux' extension 04:52:10 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 04:52:10 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 04:52:10 INFO - building 'psutil._psutil_posix' extension 04:52:10 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 04:52:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:52:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:11 INFO - Successfully installed psutil 04:52:11 INFO - Cleaning up... 04:52:11 INFO - Return code: 0 04:52:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:52:11 INFO - Using env: {'DISPLAY': ':0', 04:52:11 INFO - 'HOME': '/home/cltbld', 04:52:11 INFO - 'LANG': 'en_US.UTF-8', 04:52:11 INFO - 'LANGUAGE': 'en_US:en', 04:52:11 INFO - 'LOGNAME': 'cltbld', 04:52:11 INFO - 'MAIL': '/var/mail/cltbld', 04:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:11 INFO - 'MOZ_NO_REMOTE': '1', 04:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:11 INFO - 'NO_EM_RESTART': '1', 04:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:11 INFO - 'PWD': '/builds/slave/test', 04:52:11 INFO - 'SHELL': '/bin/bash', 04:52:11 INFO - 'SHLVL': '1', 04:52:11 INFO - 'TERM': 'linux', 04:52:11 INFO - 'TMOUT': '86400', 04:52:11 INFO - 'USER': 'cltbld', 04:52:11 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:11 INFO - '_': '/tools/buildbot/bin/python'} 04:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:52:12 INFO - Installing collected packages: mozsystemmonitor 04:52:12 INFO - Running setup.py install for mozsystemmonitor 04:52:12 INFO - Successfully installed mozsystemmonitor 04:52:12 INFO - Cleaning up... 04:52:12 INFO - Return code: 0 04:52:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:12 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 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:52:12 INFO - Using env: {'DISPLAY': ':0', 04:52:12 INFO - 'HOME': '/home/cltbld', 04:52:12 INFO - 'LANG': 'en_US.UTF-8', 04:52:12 INFO - 'LANGUAGE': 'en_US:en', 04:52:12 INFO - 'LOGNAME': 'cltbld', 04:52:12 INFO - 'MAIL': '/var/mail/cltbld', 04:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:12 INFO - 'MOZ_NO_REMOTE': '1', 04:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:12 INFO - 'NO_EM_RESTART': '1', 04:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:12 INFO - 'PWD': '/builds/slave/test', 04:52:12 INFO - 'SHELL': '/bin/bash', 04:52:12 INFO - 'SHLVL': '1', 04:52:12 INFO - 'TERM': 'linux', 04:52:12 INFO - 'TMOUT': '86400', 04:52:12 INFO - 'USER': 'cltbld', 04:52:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:12 INFO - '_': '/tools/buildbot/bin/python'} 04:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:12 INFO - Downloading/unpacking jsonschema==2.5.1 04:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:14 INFO - warning: no files found matching '*.txt' 04:52:14 INFO - no previously-included directories found matching 'build' 04:52:14 INFO - no previously-included directories found matching 'dist' 04:52:14 INFO - no previously-included directories found matching '.git*' 04:52:14 INFO - Installing collected packages: jsonschema, functools32 04:52:14 INFO - Running setup.py install for functools32 04:52:14 INFO - warning: no files found matching '*.txt' 04:52:14 INFO - no previously-included directories found matching 'build' 04:52:14 INFO - no previously-included directories found matching 'dist' 04:52:14 INFO - no previously-included directories found matching '.git*' 04:52:14 INFO - Successfully installed jsonschema functools32 04:52:14 INFO - Cleaning up... 04:52:14 INFO - Return code: 0 04:52:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:52:14 INFO - Using env: {'DISPLAY': ':0', 04:52:14 INFO - 'HOME': '/home/cltbld', 04:52:14 INFO - 'LANG': 'en_US.UTF-8', 04:52:14 INFO - 'LANGUAGE': 'en_US:en', 04:52:14 INFO - 'LOGNAME': 'cltbld', 04:52:14 INFO - 'MAIL': '/var/mail/cltbld', 04:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:14 INFO - 'MOZ_NO_REMOTE': '1', 04:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:14 INFO - 'NO_EM_RESTART': '1', 04:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:14 INFO - 'PWD': '/builds/slave/test', 04:52:14 INFO - 'SHELL': '/bin/bash', 04:52:14 INFO - 'SHLVL': '1', 04:52:14 INFO - 'TERM': 'linux', 04:52:14 INFO - 'TMOUT': '86400', 04:52:14 INFO - 'USER': 'cltbld', 04:52:14 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:14 INFO - '_': '/tools/buildbot/bin/python'} 04:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:52:14 INFO - Cleaning up... 04:52:14 INFO - Return code: 0 04:52:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:14 INFO - Using env: {'DISPLAY': ':0', 04:52:14 INFO - 'HOME': '/home/cltbld', 04:52:14 INFO - 'LANG': 'en_US.UTF-8', 04:52:14 INFO - 'LANGUAGE': 'en_US:en', 04:52:14 INFO - 'LOGNAME': 'cltbld', 04:52:14 INFO - 'MAIL': '/var/mail/cltbld', 04:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:14 INFO - 'MOZ_NO_REMOTE': '1', 04:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:14 INFO - 'NO_EM_RESTART': '1', 04:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:14 INFO - 'PWD': '/builds/slave/test', 04:52:14 INFO - 'SHELL': '/bin/bash', 04:52:14 INFO - 'SHLVL': '1', 04:52:14 INFO - 'TERM': 'linux', 04:52:14 INFO - 'TMOUT': '86400', 04:52:14 INFO - 'USER': 'cltbld', 04:52:14 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:14 INFO - '_': '/tools/buildbot/bin/python'} 04:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:16 INFO - Downloading docopt-0.6.1.tar.gz 04:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:16 INFO - Running setup.py install for blobuploader 04:52:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:16 INFO - Running setup.py install for requests 04:52:16 INFO - Running setup.py install for docopt 04:52:16 INFO - Successfully installed blobuploader requests docopt 04:52:16 INFO - Cleaning up... 04:52:17 INFO - Return code: 0 04:52:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:17 INFO - Using env: {'DISPLAY': ':0', 04:52:17 INFO - 'HOME': '/home/cltbld', 04:52:17 INFO - 'LANG': 'en_US.UTF-8', 04:52:17 INFO - 'LANGUAGE': 'en_US:en', 04:52:17 INFO - 'LOGNAME': 'cltbld', 04:52:17 INFO - 'MAIL': '/var/mail/cltbld', 04:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:17 INFO - 'MOZ_NO_REMOTE': '1', 04:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:17 INFO - 'NO_EM_RESTART': '1', 04:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:17 INFO - 'PWD': '/builds/slave/test', 04:52:17 INFO - 'SHELL': '/bin/bash', 04:52:17 INFO - 'SHLVL': '1', 04:52:17 INFO - 'TERM': 'linux', 04:52:17 INFO - 'TMOUT': '86400', 04:52:17 INFO - 'USER': 'cltbld', 04:52:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:17 INFO - '_': '/tools/buildbot/bin/python'} 04:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:17 INFO - Running setup.py (path:/tmp/pip-O9EcVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:17 INFO - Running setup.py (path:/tmp/pip-wXy2z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:17 INFO - Running setup.py (path:/tmp/pip-OOTKif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:17 INFO - Running setup.py (path:/tmp/pip-ArmjyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:17 INFO - Running setup.py (path:/tmp/pip-GJQ6c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:17 INFO - Running setup.py (path:/tmp/pip-68hWKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:17 INFO - Running setup.py (path:/tmp/pip-40kRil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:17 INFO - Running setup.py (path:/tmp/pip-9BWhle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:17 INFO - Running setup.py (path:/tmp/pip-zR7eNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:17 INFO - Running setup.py (path:/tmp/pip-cjBbR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:17 INFO - Running setup.py (path:/tmp/pip-YhykD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:18 INFO - Running setup.py (path:/tmp/pip-aYngD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:18 INFO - Running setup.py (path:/tmp/pip-1Gp09j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:18 INFO - Running setup.py (path:/tmp/pip-Nj3SFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:18 INFO - Running setup.py (path:/tmp/pip-2_lwTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:18 INFO - Running setup.py (path:/tmp/pip-Di5_y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:18 INFO - Running setup.py (path:/tmp/pip-yKb6Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:18 INFO - Running setup.py install for manifestparser 04:52:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:18 INFO - Running setup.py install for mozcrash 04:52:18 INFO - Running setup.py install for mozdebug 04:52:18 INFO - Running setup.py install for mozdevice 04:52:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:18 INFO - Running setup.py install for mozfile 04:52:18 INFO - Running setup.py install for mozhttpd 04:52:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for mozinfo 04:52:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for mozInstall 04:52:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for mozleak 04:52:19 INFO - Running setup.py install for mozlog 04:52:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for moznetwork 04:52:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for mozprocess 04:52:19 INFO - Running setup.py install for mozprofile 04:52:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for mozrunner 04:52:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:19 INFO - Running setup.py install for mozscreenshot 04:52:20 INFO - Running setup.py install for moztest 04:52:20 INFO - Running setup.py install for mozversion 04:52:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:20 INFO - Cleaning up... 04:52:20 INFO - Return code: 0 04:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52: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')]} 04:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:20 INFO - Using env: {'DISPLAY': ':0', 04:52:20 INFO - 'HOME': '/home/cltbld', 04:52:20 INFO - 'LANG': 'en_US.UTF-8', 04:52:20 INFO - 'LANGUAGE': 'en_US:en', 04:52:20 INFO - 'LOGNAME': 'cltbld', 04:52:20 INFO - 'MAIL': '/var/mail/cltbld', 04:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:20 INFO - 'MOZ_NO_REMOTE': '1', 04:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:20 INFO - 'NO_EM_RESTART': '1', 04:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:20 INFO - 'PWD': '/builds/slave/test', 04:52:20 INFO - 'SHELL': '/bin/bash', 04:52:20 INFO - 'SHLVL': '1', 04:52:20 INFO - 'TERM': 'linux', 04:52:20 INFO - 'TMOUT': '86400', 04:52:20 INFO - 'USER': 'cltbld', 04:52:20 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:20 INFO - '_': '/tools/buildbot/bin/python'} 04:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:20 INFO - Running setup.py (path:/tmp/pip-bsugFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:20 INFO - Running setup.py (path:/tmp/pip-610qco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:20 INFO - Running setup.py (path:/tmp/pip-_Nzx_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:20 INFO - Running setup.py (path:/tmp/pip-bMcQeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:20 INFO - Running setup.py (path:/tmp/pip-_bBgwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:20 INFO - Running setup.py (path:/tmp/pip-2pf8F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:20 INFO - Running setup.py (path:/tmp/pip-9oAaZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:20 INFO - Running setup.py (path:/tmp/pip-jJlyAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:21 INFO - Running setup.py (path:/tmp/pip-7pKvPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:21 INFO - Running setup.py (path:/tmp/pip-4IFAJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:21 INFO - Running setup.py (path:/tmp/pip-6cd03u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:21 INFO - Running setup.py (path:/tmp/pip-ArcT_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:21 INFO - Running setup.py (path:/tmp/pip-vMamua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:21 INFO - Running setup.py (path:/tmp/pip-EGc2Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:21 INFO - Running setup.py (path:/tmp/pip-AHVBkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:21 INFO - Running setup.py (path:/tmp/pip-YsaeNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:21 INFO - Running setup.py (path:/tmp/pip-AGPzEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:22 INFO - Downloading blessings-1.6.tar.gz 04:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:22 INFO - Installing collected packages: blessings 04:52:22 INFO - Running setup.py install for blessings 04:52:23 INFO - Successfully installed blessings 04:52:23 INFO - Cleaning up... 04:52:23 INFO - Return code: 0 04:52:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:23 INFO - Reading from file tmpfile_stdout 04:52:23 INFO - Current package versions: 04:52:23 INFO - argparse == 1.2.1 04:52:23 INFO - blessings == 1.6 04:52:23 INFO - blobuploader == 1.2.4 04:52:23 INFO - docopt == 0.6.1 04:52:23 INFO - functools32 == 3.2.3-2 04:52:23 INFO - jsonschema == 2.5.1 04:52:23 INFO - manifestparser == 1.1 04:52:23 INFO - mozInstall == 1.13 04:52:23 INFO - mozcrash == 1.0 04:52:23 INFO - mozdebug == 0.1 04:52:23 INFO - mozdevice == 0.51 04:52:23 INFO - mozfile == 1.2 04:52:23 INFO - mozhttpd == 0.7 04:52:23 INFO - mozinfo == 0.10 04:52:23 INFO - mozleak == 0.1 04:52:23 INFO - mozlog == 3.5 04:52:23 INFO - moznetwork == 0.27 04:52:23 INFO - mozprocess == 0.25 04:52:23 INFO - mozprofile == 0.28 04:52:23 INFO - mozrunner == 6.13 04:52:23 INFO - mozscreenshot == 0.1 04:52:23 INFO - mozsystemmonitor == 0.3 04:52:23 INFO - moztest == 0.8 04:52:23 INFO - mozversion == 1.4 04:52:23 INFO - psutil == 3.1.1 04:52:23 INFO - requests == 1.2.3 04:52:23 INFO - wsgiref == 0.1.2 04:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52: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')]} 04:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:23 INFO - Using env: {'DISPLAY': ':0', 04:52:23 INFO - 'HOME': '/home/cltbld', 04:52:23 INFO - 'LANG': 'en_US.UTF-8', 04:52:23 INFO - 'LANGUAGE': 'en_US:en', 04:52:23 INFO - 'LOGNAME': 'cltbld', 04:52:23 INFO - 'MAIL': '/var/mail/cltbld', 04:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:23 INFO - 'MOZ_NO_REMOTE': '1', 04:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:23 INFO - 'NO_EM_RESTART': '1', 04:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:23 INFO - 'PWD': '/builds/slave/test', 04:52:23 INFO - 'SHELL': '/bin/bash', 04:52:23 INFO - 'SHLVL': '1', 04:52:23 INFO - 'TERM': 'linux', 04:52:23 INFO - 'TMOUT': '86400', 04:52:23 INFO - 'USER': 'cltbld', 04:52:23 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:23 INFO - '_': '/tools/buildbot/bin/python'} 04:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:52:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:52: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 04:52: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 04:52: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 04:52: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 04:52:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:52:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:52: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 04:52: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 04:52: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 04:52: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 04:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:52:24 INFO - Installing collected packages: marionette-driver, simplejson 04:52:24 INFO - Running setup.py install for marionette-driver 04:52:25 INFO - Running setup.py install for simplejson 04:52:25 INFO - building 'simplejson._speedups' extension 04:52:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:52:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:52:26 INFO - Successfully installed marionette-driver simplejson 04:52:26 INFO - Cleaning up... 04:52:26 INFO - Return code: 0 04:52:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52: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')]} 04:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbfd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:52:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:52:26 INFO - Using env: {'DISPLAY': ':0', 04:52:26 INFO - 'HOME': '/home/cltbld', 04:52:26 INFO - 'LANG': 'en_US.UTF-8', 04:52:26 INFO - 'LANGUAGE': 'en_US:en', 04:52:26 INFO - 'LOGNAME': 'cltbld', 04:52:26 INFO - 'MAIL': '/var/mail/cltbld', 04:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:26 INFO - 'MOZ_NO_REMOTE': '1', 04:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:26 INFO - 'NO_EM_RESTART': '1', 04:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:26 INFO - 'PWD': '/builds/slave/test', 04:52:26 INFO - 'SHELL': '/bin/bash', 04:52:26 INFO - 'SHLVL': '1', 04:52:26 INFO - 'TERM': 'linux', 04:52:26 INFO - 'TMOUT': '86400', 04:52:26 INFO - 'USER': 'cltbld', 04:52:26 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:26 INFO - '_': '/tools/buildbot/bin/python'} 04:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:52:26 INFO - Cleaning up... 04:52:26 INFO - Return code: 0 04:52:26 INFO - Running post-action listener: _resource_record_post_action 04:52:26 INFO - Running post-action listener: _start_resource_monitoring 04:52:26 INFO - Starting resource monitoring. 04:52:26 INFO - [mozharness: 2017-07-24 11:52:26.344780Z] Finished create-virtualenv step (success) 04:52:26 INFO - [mozharness: 2017-07-24 11:52:26.345820Z] Running install step. 04:52:26 INFO - Running pre-action listener: _resource_record_pre_action 04:52:26 INFO - Running main action method: install 04:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:26 INFO - Reading from file tmpfile_stdout 04:52:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:26 INFO - Reading from file tmpfile_stdout 04:52:26 INFO - Output received: 04:52:26 INFO - Usage: mozinstall [options] installer 04:52:26 INFO - Options: 04:52:26 INFO - -h, --help show this help message and exit 04:52:26 INFO - -d DEST, --destination=DEST 04:52:26 INFO - Directory to install application into. [default: 04:52:26 INFO - "/builds/slave/test"] 04:52:26 INFO - --app=APP Application being installed. [default: firefox] 04:52:26 INFO - mkdir: /builds/slave/test/build/application 04:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:52:44 INFO - Reading from file tmpfile_stdout 04:52:44 INFO - Output received: 04:52:44 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:44 INFO - Running post-action listener: _resource_record_post_action 04:52:44 INFO - [mozharness: 2017-07-24 11:52:44.647268Z] Finished install step (success) 04:52:44 INFO - [mozharness: 2017-07-24 11:52:44.647519Z] Running setup-mitmproxy step. 04:52:44 INFO - Running pre-action listener: _resource_record_pre_action 04:52:44 INFO - Running main action method: setup_mitmproxy 04:52:44 INFO - Skipping: mitmproxy is not required 04:52:44 INFO - Running post-action listener: _resource_record_post_action 04:52:44 INFO - [mozharness: 2017-07-24 11:52:44.648651Z] Finished setup-mitmproxy step (success) 04:52:44 INFO - [mozharness: 2017-07-24 11:52:44.648873Z] Running run-tests step. 04:52:44 INFO - Running pre-action listener: _resource_record_pre_action 04:52:44 INFO - Running pre-action listener: _set_gcov_prefix 04:52:44 INFO - Running main action method: run_tests 04:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:44 INFO - Python 2.7.3 04:52:44 INFO - Return code: 0 04:52:44 INFO - grabbing minidump binary from tooltool 04:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfbceb0>, '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 0xfbddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfbe240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:52:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:52:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:52:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:44 INFO - Return code: 0 04:52:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:44 INFO - ENV: RUST_BACKTRACE is now 1 04:52:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:52:44 INFO - Using env: {'DISPLAY': ':0', 04:52:44 INFO - 'HOME': '/home/cltbld', 04:52:44 INFO - 'LANG': 'en_US.UTF-8', 04:52:44 INFO - 'LANGUAGE': 'en_US:en', 04:52:44 INFO - 'LOGNAME': 'cltbld', 04:52:44 INFO - 'MAIL': '/var/mail/cltbld', 04:52:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:44 INFO - 'MOZ_NO_REMOTE': '1', 04:52:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:44 INFO - 'NO_EM_RESTART': '1', 04:52:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:44 INFO - 'PWD': '/builds/slave/test', 04:52:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:44 INFO - 'RUST_BACKTRACE': '1', 04:52:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:52:44 INFO - 'SHELL': '/bin/bash', 04:52:44 INFO - 'SHLVL': '1', 04:52:44 INFO - 'STYLO_FORCE_ENABLED': '1', 04:52:44 INFO - 'TERM': 'linux', 04:52:44 INFO - 'TMOUT': '86400', 04:52:44 INFO - 'USER': 'cltbld', 04:52:44 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986', 04:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:44 INFO - '_': '/tools/buildbot/bin/python'} 04:52:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:52:45 INFO - mozversion application_buildid: 20170724110158 04:52:45 INFO - mozversion application_changeset: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 04:52:45 INFO - mozversion application_display_name: Nightly 04:52:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:45 INFO - mozversion application_name: Firefox 04:52:45 INFO - mozversion application_remotingname: firefox 04:52:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:52:45 INFO - mozversion application_vendor: Mozilla 04:52:45 INFO - mozversion application_version: 56.0a1 04:52:45 INFO - mozversion platform_buildid: 20170724110158 04:52:45 INFO - mozversion platform_changeset: 60a5308fa987676fa5ed9fd5b3ad6c9938af0539 04:52:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:52:45 INFO - mozversion platform_version: 56.0a1 04:52:45 INFO - using testdate: 1500897165 04:52:45 INFO - actual date: 1500897165 04:52:45 INFO - starting webserver on 'localhost:40798' 04:52:45 INFO - SUITE-START | Running 2 tests 04:52:45 INFO - TEST-START | dromaeo_css 04:52:45 INFO - Initialising browser for dromaeo_css test... 04:52:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40798/getInfo.html -profile /tmp/tmpqMSRHE/profile 04:52:45 INFO - TEST-INFO | started process 3336 (/builds/slave/test/build/application/firefox/firefox http://localhost:40798/getInfo.html) 04:52:54 INFO - TEST-INFO | 3336: exit 0 04:52:55 INFO - Browser initialized. 04:52:55 INFO - Running cycle 1/1 for dromaeo_css test... 04:52:55 INFO - TEST-INFO | started process 3561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqMSRHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:06 INFO - PID 3561 | RSS: Main: 175812608 04:53:06 INFO - PID 3561 | 04:56:06 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40798/tests/dromaeo/cssquery-ext.html) 04:56:07 INFO - PID 3561 | RSS: Main: 181288960 04:56:07 INFO - PID 3561 | 04:59:09 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-ext.html (next: http://localhost:40798/tests/dromaeo/cssquery-jquery.html) 04:59:10 INFO - PID 3561 | RSS: Main: 179236864 04:59:10 INFO - PID 3561 | 05:02:11 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40798/tests/dromaeo/cssquery-mootools.html) 05:02:12 INFO - PID 3561 | RSS: Main: 180744192 05:02:12 INFO - PID 3561 | 05:05:14 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40798/tests/dromaeo/cssquery-prototype.html) 05:05:15 INFO - PID 3561 | RSS: Main: 179400704 05:05:15 INFO - PID 3561 | 05:08:19 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40798/tests/dromaeo/cssquery-yui.html) 05:08:19 INFO - PID 3561 | RSS: Main: 181264384 05:08:19 INFO - PID 3561 | 05:11:21 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:40798/tests/dromaeo/cssquery-yui.html (next: http://localhost:40798/tests/dromaeo/cssquery-dojo.html) 05:11:22 INFO - PID 3561 | RSS: Main: 183218176 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | __start_tp_report 05:11:22 INFO - PID 3561 | _x_x_mozilla_page_load 05:11:22 INFO - PID 3561 | _x_x_mozilla_page_load_details 05:11:22 INFO - PID 3561 | |i|pagename|runs| 05:11:22 INFO - PID 3561 | |0;dojo.html;3103.984480077599;3142.8585713642883;3153;3161.178093695639;3212.5181222816573;5966.671833049186;5970.6716130612795;6026.668533230676;6116.908246376308;6205.255369355672;5957.910631340534;5993.910091348634;6062.060380641008;6067.9696601516935;6099.695015249231;5444.992676354867;5507.972460137694;5576.637518561301;5601.775928962837;5601.859953501154;5471.179323101546;5591.189277554752;5627.184058311543;5676.035074037423;5680.431956804307;5577.776888924438;5585.636933599323;5665.660060396369;5670.716464176816;5688.60179787413;5469;5541.196526503634;5570.415106413809;5643.746031428595;5650.5479561634975;5489.807856724996;5499.890002199973;5546.140348246028;5599.160125981095;5605.495505404533;6039.063945088518;6068.120122582201;6101.450869421729;6102.481289090432;6139.631622102688;6377.298497165308;6456.870047741627;6484.578502397329;6505.251896031969;6544.476441884638;6497.870042599122;6505.60966342021;6512.772052978123;6525.902111468332;6618.4705223582;6092;6175.59858609189;6179.50563954887;6184.87630247397;6208.441240288395;6511.739530418825;6644.036614690843;6690.498212634072;6779.2881747416795;6795.7961261162245;6231.563790534619;6242.656653883989;6250.843728906722;6275.623462592259;6308.558400911892;6276.811695649138;6286.968565157236;6356.237251529846;6356.300806911236;6460.580062295936;6496.090547323379;6496.512761542903;6513.3812287833525;6535.183102112236;6543.1166792483355;6423.646699431576;6546.607203567801;6554.3117972613145;6582.967085164543;6583;5312.123499622519;5335.146376579806;5381.919271210935;5391.137418013099;5397.622166448311;4496.955030449719;4541.818327266872;4559.247724125548;4615.653825963066;4616.930746038812;5628.915566266509;5682.289713785777;5767.596268261265;5773.16289138081;5799.536037117021;6517.771877984343;6519.380658837403;6595.604263744191;6615.900761488581;6655.301193374723;5664;5677.744501497443;5747.310322761212;5752.07966725322;5762.0204565223175;5655.406182350876;5706.457886500776;5775.422457754191;5777.768889244468;5813.157092221604;6383.39357761012;6389.936100639027;6398.168238129107;6421.229452465641;6442.420182183626;6586.242582103119;6587.769428070186;6589.7364105435245;6659.800205993828;6680.164979377578;6172.290186628596;6306.527010474325;6313.2424109107205;6320.683965801783;6354.52341074412;6338.429541341301;6340.619562826245;6345.555811093179;6355.3644635536075;6386.584871983492;6504.479641628753;6597.967010164918;6611.33886611335;6613.041109039066;6622.602643841385;6286.119943208046;6333.271673757393;6414.326495717883;6425.036244563353;6425.9036114457385;6293.118963345044;6307.936920630918;6400.231972163184;6410.583312084699;6413.935860641521;6173.69131543412;6228.065790131335;6253.906191407224;6254.718537665725;6344.841378965562;6234.906476402948;6353.5870168438905;6422.6467544285515;6428.067930150196;6463.903041454288;6132.834761395321;6148;6166.321704612399;6228.844278893064;6242.469390101892 05:11:22 INFO - PID 3561 | |1;ext.html;809.668036105197;846.5428668519;860.0883063952211;864.7708357285317;1157.670064031751;30963.38073238534;31507.84246078769;41912.16175676489;42816;42869.35695964563;43156;43650;43668.563314366846;43676;43712.562874371244;7494.325510704036;7552.88670669939;7753.728619498319;7775.766726998199;7781.338586220149;7630.732924347649;7741.767746967572;7749.186335434782;7751.914731937533;7752.728654497094;7722.073351197864;7736.032995875516;7747.96126019372;7752.689892404297;7780.494267872598;7629.809254768647;7689.615519224044;7724.266194711521;7731.072271327476;7749.7675069748;7521.623918804038;7615.80960475987;7617.46677732559;7619.619019049025;7632.1986191450205;39513;39605.217765200636;39645.80177099096;39645.801770991246;39984;3549.396602577568;3567.661072198137;3587.7488575799703;3591.515145455356;3598.1904071583945;32276.354472910643;32375.6762432375;32399.51400728991;32407.35185296281;32425.51361729576;4845.345878306419;4885.218365061573;4933.457319694867;4940.876478088041;4979.327790748239;189027;189489;189716;190104;190405;48068.519314807105;48530.27204591934;48574.27138592924;48639.75680121648;48753.75623121862;51423;51567.74216128895;51601;51605.22592161121;51644.22533661998;16228.594285142966;16797.748033779502;16801.07594082337;16803.66392672164;16880.915595421946;11356.659300221007;11566.30602163873;12971;13251.072424930162;13791.241481718602;14366.281685915663;14370.281485925661;14370.353334099991;14381.209033503257;14567.92716036413;5547.389787123494;5746.195532625436;5758.683272419973;5814.273215848019;5881.3530511643685;962.552413127899;968.3608818179968;981.9214462842956;990.6235630460379;1012.3824467075078;22467.438314041952;22547.43631409228;22790.202342917917;23100.65349019766;23118;1082.123479981202;1087.7933192693363;1104.8066588347008;1112.3492756737237;1114.916381271408;11782.410879455992;11848.763024739457;11938.343391113573;12144.635660930186;12235.755284894252;219629;222550;222821.8858905695;223712;223924;53700.462995370326;57272.42727572671;57746.422535774946;58167.12749308764;58295.70852145797;1440;1474.0860666386695;1475.1296734926445;1478.7855760914608;1486.37572219668;23763.287101386984;26673.599896001964;26806;26928.192154235403;27020.45959080768;51558.226626599884;51832.22251666304;51873.48126518838;51874;51929;197194;197701;197708;198137;198561;33928.83035584905;34083.48874766831;34113.14717132092;34389.65610343865;34411.65588344084;42517.787411062745;43856.34215486707;44036.11927761491;44254.11491770082;44428;30900.227494311923;31643.683563164996;31987.520187197675;32716.34567308593;32720.509192361656;30976.84511577428;32558.83720581382;33079.33841323208;33082.17294567655;33405.33189336151;33687.83156084204;35494;36015.099622509646;36118.638813612575;36130.45804312885;29327.706722932497;31379;32050.19874503156;32268.35463290674;32377.35245295128;23465.765342346356;23487.530249394575;23495.41261468477;23572.88213558921;23689.881550592138 05:11:22 INFO - PID 3561 | |2;jquery.html;569.4789267819942;574.8045664474083;578.5342799046766;582.7202942587558;609.8536351275694;16352;21821.127154913804;22773.658395124086;22899;23011;22233.44416389591;24619.26142215732;24802.627960580605;24802.627960580605;24931.87806548705;6362.268339141;6530.183727034121;6530.967345163268;6538.574992625464;6548.738050477975;6062.424069713392;6317.2735135459325;6340.017297318923;6384.872302553946;6474.741010359604;6285.748570057192;6288.119663247149;6294.7482100715915;6302.779402720906;6309.6845157742155;6288.937110628881;6290.433860952537;6311.274203466592;6324.272708638497;6333.55665103443;5750.482456578928;5821.941780582182;5843.211166492554;5858.648481091105;5863.706814659293;26946.191614251602;28222.858885705646;28378.43243135126;28569.000084997133;28844.134675959755;1905.7141428785656;1953.257762050426;1954.2378472395776;1954.4332143678316;1957.5889063296725;18544.16551255197;18994.62010759777;19056;19069.427917162368;19110.71333929992;2224.7219097612797;2232.9553408931893;2366.408397900525;2394.608476153812;2456.6683497727936;137347;138548;141148;141255.58744412527;142682;14140.717185656435;14647.414103435956;14778.63053423673;14901.180435076174;14987.250637468083;23199.884000580227;23200.18799342015;23211;23234.1868034618;23283.7671623285;10027.247956403298;10370.11853992404;10458.215633827342;10499.317544359592;10671.73320666974;7604.771856844193;9590.08894155054;9604.615815367308;9685.515724213761;9774.462404567676;7978.361731061501;9257.629694812267;9313.254939604816;9334.486603236752;9474.247264256135;2441.316431399211;2468.5556599812207;2528.153068721999;2576.3172759218824;2668.0795125681607;943.9103285188033;965.3628605120587;975.2441857560306;977.1596427072711;990.4693508086907;18693.626127477375;18914.716279255823;18932.71600925987;18961.24155033811;19160.80839191618;977.7604486900755;1023.7235946294459;1032.4992378696327;1061.4374381577777;1069.1019543583427;10082.848757268646;10298.433586152834;10317;10546.209034322457;12595.622131336075;468531;471812;474682;480844;484747;114795;118253;119927.40036299937;120171;121187.39406303088;1269.7079671675567;1285.8842704156484;1301.5444594391888;1302.1145620977827;1308.8036794480904;19002.809971900104;19704.90147549253;19817.20731170737;20016.99915004215;20260;57770.42229577818;58393.70803145957;58957;59041.40958590359;60182.69908650429;71836.28163718505;72377.63811180911;72654.63672681602;73230.63384683043;73460.63269683617;14045.789313160107;14202.644933876323;14394.640133996734;14463.421463141778;14467;22006.669899951194;22336.66495002544;22460.887695561418;22710;22982.770172298064;17692.93842369462;17871.73192402141;18113.366032189337;18118.728219076987;18160.364387246384;14593;15036.924815376291;15857.286422111263;15899.682006360039;16139.435119770751;16793.41223057187;18099.276028959222;19636.312729054414;19665.80334196697;19774.307899224033;14300.499482518062;14539;14547.490837820626;14560.563183104523;14628.122312661275;17325.740113898555;18182.81817181811;18317.267309307477;18367;18510.16704248285 05:11:22 INFO - PID 3561 | |3;mootools.html;1338.7054847933455;1403.16511675553;1412.3644360037986;1422.982567464263;1431.5204406523817;13717.314134293283;13869;14322.713545729079;14357;14362.281885905702;14346.995710300283;14676.412943482275;14683;14697.118172909633;14701.117932924006;2588.9093881714143;2706.07993282284;2743.5747459143763;2744.533429317021;2745.341118131654;2644;2675.5719084946413;2678.07606375801;2678.183154137987;2679.490896729615;2623.9212823615226;2625.6061590761346;2641.696204936438;2645.034562384735;2655.0839960213793;2549;2553.6424900513757;2563.1925943327883;2573.073693470349;2576.729443408434;2572.2026171886587;2603.4923189977962;2606.2832721001687;2611.9869400652874;2613.3074735195187;13607.659808504768;13906.30468476572;13952.790708139284;13986.16083035011;14009.089409188473;7467;7505.474616776828;7715.575643339614;7753.224677532258;7794.493357931717;5167.863070124567;5207.557357624606;5334.0665383557725;5345.198220266952;5387.865303367408;1876.1557299215272;1893.933712320076;1896.544829240986;1968.2717394564104;1982.117957508909;22788.31635050951;23040.884795576083;23143.53712925749;23171.420714482105;23178.65232021521;6308.274548426898;6319.58922670025;6422;6516;6531.510136739764;15129.924350378178;15590.9220453897;15658.68682626341;15674;16146.596335091717;7422.665980030912;7633.084029916335;7637.961810190914;7640.770776876702;7645.082590089114;6615.106960560262;7047.295270473014;7064.470164737665;7117.64411779409;7121.216666166718;4960.355153829979;5110.540051395392;5120.948790512121;5121.743912804345;5131.179011358239;1488.9851101489064;1499.6250937265684;1515.6817068415535;1516.2797671106357;1519.5973067137218;869.1829680100685;889.213046453893;896.5562046786882;930.1210356213448;936.5083331251011;7380.151282602462;7851.411144164211;8616.353773467015;8666.826663466696;8859.64561417536;943.1228957069853;954.2842867849113;963.1139351796364;1012.8885822559513;1032.2258306270298;5181;5292.708901010481;5330;5351.839444816662;5620.835978148442;18728.53178670544;19246.23015079381;19266.614667706566;19271.614567708566;19308.61382772365;17766.378176763752;18992;19100.61798764017;19222.327218547285;19294.32469863548;10822;10964.068054215322;10979.560817567368;11017.504212310465;11041.171912106623;7689.3464055555905;8002.399820013406;8055.798605034921;8234.176582341717;8522.403431759965;15976.760348594547;16052.839471605135;16563;16744.91158074721;16908;16111.436099736453;16467.34130634809;16601.41895033668;16602.003879767253;16650.417235397188;11164;11377.715557111138;11386.259893106922;11389.088872890314;11395.772084558097;12503.56237531682;12640.43118059708;12967.610971670865;12969.610911672666;13015.284159371326;10168.542415591464;10679.89320106789;10703.464826758474;10918.399488028235;11237.71905702364;10059.849102263326;10268.897311026794;10500.842487362543;10552.947235263775;10606.098481629147;9497.762555936157;9609.279304052085;9637.469939153414;9640.373375730554;9644.517774111408;6394.936050639434;6758.8648227036165;6762.729490820312;6963.6866341013765;7162.606056666933;6947.93052069493;7103.112110986127;7149.964250178716;7229.7469588564145;7370.262973702587 05:11:22 INFO - PID 3561 | |4;prototype.html;469.65715028029535;489.89957058802946;492.4828929623894;495.0714747114137;520.9843704688858;6193.597416167946;6302.149209856674;6307.873842523147;6317.273513545943;6348.841278968028;5967.701614919259;6060.696950155716;6094.8171554853425;6182.7217775200115;6184.979478386061;4911.778969946361;4927.802887884481;4972.328735620699;4989.825356112546;5024.924626130611;4936.851894443154;4936.901261974776;4953.306537084811;4971.37857767779;5025.899482010358;4762.261849413347;4842.491538388454;4861.027794441108;4888.780004899771;4922.187839006559;4884.8534543963915;4897.926531102036;4907.582855457273;4942.9011419771405;4966.776495057731;4400.427944367212;4444.31113177458;4457.108578284324;4461.420015397977;4473.686841921067;5975.910361344583;6046.304674962392;6050.122732203849;6054.909176362358;6063.696815159225;5649.23735295734;5716.942365662366;5723.456271654228;5741.167530708024;5744.454276843693;6375;6474.805755827333;6502.902456463157;6546.378094081055;6577.638229897354;4750.168720473937;4830.6135509159185;4833.951660483421;4836.564709176156;4841.2496063110275;6849.897251541231;6872.828179295508;6928.896066558956;6974.128233970754;6980.581165130057;4829.348038014893;4857.781399837016;4867.294242334841;4923.876903077452;4970.627202959792;4952.777125029383;4968.22992436173;4982.153033984231;5005.799768009311;5013.5989120870245;5576.553875689935;5639.520640745501;5673.886522269531;5681.119426488901;5708.486236238676;6489.383508566679;6509.349065093453;6597.934020659732;6619.768308109193;6649.534532582769;1658.1957750491001;1696.2282161616436;1710.1363811275476;1711.4865540337848;1773.645270945816;1206.2641788509002;1210.7045461356265;1230.2249582762802;1234.3087870792385;1242.099477878549;5602.215689803431;5677.261955945701;5701.403606990049;5706.546185140346;5739.540836733051;6504.349565043458;6615.404613584704;6664.700088496029;6764.458843292525;6774.593524388552;5750.30996280449;5795.826565038111;5823.184754134425;5823.534117270693;5927.3776253493625;3573.8927832165077;3583.7133029357587;3593.2454184621;3608.6210947850623;3614.6204648512053;6546.509011824132;6602.966985165043;6620.735170593219;6638.933610663831;6649.966750166218;6830.453563714891;6889.448844092461;6890.552114112566;6892.965535172292;6948.478864085214;6378.2346118466085;6408.711607977652;6487.3836985486305;6513.589971710592;6522.543421960512;6678.7328506859185;6705.9882035390165;6753.763618273337;6773.322667733384;6775;6554.246261679968;6592.0111983202905;6605.702743376656;6636.279125558498;6646.767363142267;6365.267994180728;6402.871942561216;6506.804795856132;6527.445167160845;6574.4740420765265;4970.478099799614;4982.402111746614;5021.342956824166;5029.874253143555;5059.721715305694;6761.256261811295;6766.93233067663;6778.796636100925;6796.864062718817;6838.14523184602;6370.872582548416;6394.200724909387;6488.70800813974;6543.116679248241;6547.214334279917;6283.115065480246;6388.456981156468;6511.120998665119;6524.151860258136;6620.735170593315;6147.293061298008;6325.936740632719;6424.678766061772;6448.451881590117;6471.935280647322;6442.002979076501;6444.2911279758255;6570.507211959218;6578.967105164444;6618.933810661832;6202.472789812736;6349.428551430394;6354.809355719336;6362.363763623601;6385.616862988236 05:11:22 INFO - PID 3561 | |5;yui.html;893.1291990309445;908.1191244492842;929.5538141691992;931.1573026411096;931.874196983407;15766.763498547516;16471.42350017748;16475.75286370704;16483.258253378597;19286.132124054417;19741.713086703454;21826.563468730616;21879.453013674665;21928.561428771416;21937.670934935948;1036.383351905615;1067.391586795523;1069.9732506687317;1073.6617965340931;1074.274864466486;950.653011650746;1031.5306535526356;1043.2488608202082;1048.6015314180602;1048.937063776172;1086.1962148010493;1100.031971864762;1104.6133853151373;1105.309181761399;1105.4307031878589;1090.0571006079763;1091.0943916549245;1091.110744743032;1091.307020042279;1095.1950316517352;790.9802254943614;795.2842441802367;799.312591171592;801.3669201330999;805.4885147931047;19548.31580894662;19982.200711971505;20200.292989745434;20265.696014559795;20286.289979850633;20495.28266510665;20593.794062059336;21046.158153673834;21047.368578942504;21114.472138196514;15816.76274855878;16172.272247748879;16187.433439829667;16281.755773663404;16536.83463165377;3441.48377743338;3499.7725147865563;3499.7900125992523;3501.859925602973;3502.2120022994877;120798.39600802115;127444.08833867499;128548;130194;130480;15895.841041589667;16016.11911344864;16284.51146465608;16292.266847991868;16318.836811631969;30069.699303007128;30440;30518.54222186669;30596;30697.539536906963;7369.115706115301;7682.500637458547;8441.07148213696;8701.216890479887;8702.95648521766;4023.979880100639;4198.874033778991;4229.217594744982;4236.724612900151;4239.1521695660995;5061.468545802638;5115.693058416507;5184.662996905189;5191.974040129775;5253.264542963988;1072.265498133781;1081.3079629037265;1105.8783533811275;1107.855978722777;1108.3294606762793;632.2286810091681;658.8912829383098;681.0227323790376;687.0724521895402;693.8646963842103;11252.43737813106;12289.754204916031;12447.190932589352;12492.375381230902;12556.748865022648;644.1304239277032;682.7610336382326;694.5069001009239;694.5658963148032;697.6755808549049;5367.624266301399;5470.8085217017215;5539.972300138474;5599.860003499945;5701.771929122871;99302;103215.48392257991;108955.45522272497;109295.45352273187;110290;88467;90170.54914725384;92666.53666731624;96282;97492.51253743687;75316;78292;79840.80238796423;82372;86214.56892715496;10665.520051597852;11019.118470522179;12089;12246.731659104196;13062.88761722147;36247.41862523376;36868;37717.434238486996;38087.23825523419;38888.416673750486;64533.67733161304;65690.01464978125;68725.31274687189;69235.30764692288;73270.26729732634;18069.27722891122;18456.630867382846;18526.444206673823;18626.72059919075;18841.15214815309;20127.698084528452;20182;20874.165033398494;21780.673289900347;21879.781202187773;17330.480085597454;18303.54241143982;18881;18973.71539426882;19149.712754308417;16797.496075117768;16901.830981690517;16978;17091.572710682332;17313.307467701656;16960.151992400577;17329.653406932044;17589.912050439667;17850.107494625478;18224;12161.452734626786;12573.497060117494;12582.119251652663;12629.431675574437;13522.053456258362;13510.769276047728;13676.111052781538;14193;14318.782903453322;14482.927585362428 05:11:22 INFO - PID 3561 | __end_tp_report 05:11:22 INFO - PID 3561 | __start_cc_report 05:11:22 INFO - PID 3561 | _x_x_mozilla_cycle_collect,362 05:11:22 INFO - PID 3561 | __end_cc_report 05:11:22 INFO - PID 3561 | __startTimestamp1500898282002__endTimestamp 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | ------- Summary: start ------- 05:11:22 INFO - PID 3561 | Number of tests: 6 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | [#0] dojo.html Cycles:165 Average:6009.28 Median:6231.56 stddev:686.77 (11.0%) stddev-sans-first:649.96 05:11:22 INFO - PID 3561 | Values: 3104.0 3142.9 3153.0 3161.2 3212.5 5966.7 5970.7 6026.7 6116.9 6205.3 5957.9 5993.9 6062.1 6068.0 6099.7 5445.0 5508.0 5576.6 5601.8 5601.9 5471.2 5591.2 5627.2 5676.0 5680.4 5577.8 5585.6 5665.7 5670.7 5688.6 5469.0 5541.2 5570.4 5643.7 5650.5 5489.8 5499.9 5546.1 5599.2 5605.5 6039.1 6068.1 6101.5 6102.5 6139.6 6377.3 6456.9 6484.6 6505.3 6544.5 6497.9 6505.6 6512.8 6525.9 6618.5 6092.0 6175.6 6179.5 6184.9 6208.4 6511.7 6644.0 6690.5 6779.3 6795.8 6231.6 6242.7 6250.8 6275.6 6308.6 6276.8 6287.0 6356.2 6356.3 6460.6 6496.1 6496.5 6513.4 6535.2 6543.1 6423.6 6546.6 6554.3 6583.0 6583.0 5312.1 5335.1 5381.9 5391.1 5397.6 4497.0 4541.8 4559.2 4615.7 4616.9 5628.9 5682.3 5767.6 5773.2 5799.5 6517.8 6519.4 6595.6 6615.9 6655.3 5664.0 5677.7 5747.3 5752.1 5762.0 5655.4 5706.5 5775.4 5777.8 5813.2 6383.4 6389.9 6398.2 6421.2 6442.4 6586.2 6587.8 6589.7 6659.8 6680.2 6172.3 6306.5 6313.2 6320.7 6354.5 6338.4 6340.6 6345.6 6355.4 6386.6 6504.5 6598.0 6611.3 6613.0 6622.6 6286.1 6333.3 6414.3 6425.0 6425.9 6293.1 6307.9 6400.2 6410.6 6413.9 6173.7 6228.1 6253.9 6254.7 6344.8 6234.9 6353.6 6422.6 6428.1 6463.9 6132.8 6148.0 6166.3 6228.8 6242.5 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | [#1] ext.html Cycles:180 Average:37992.54 Median:19521.70 stddev:52856.23 (270.8%) stddev-sans-first:52930.77 05:11:22 INFO - PID 3561 | Values: 809.7 846.5 860.1 864.8 1157.7 30963.4 31507.8 41912.2 42816.0 42869.4 43156.0 43650.0 43668.6 43676.0 43712.6 7494.3 7552.9 7753.7 7775.8 7781.3 7630.7 7741.8 7749.2 7751.9 7752.7 7722.1 7736.0 7748.0 7752.7 7780.5 7629.8 7689.6 7724.3 7731.1 7749.8 7521.6 7615.8 7617.5 7619.6 7632.2 39513.0 39605.2 39645.8 39645.8 39984.0 3549.4 3567.7 3587.7 3591.5 3598.2 32276.4 32375.7 32399.5 32407.4 32425.5 4845.3 4885.2 4933.5 4940.9 4979.3 189027.0 189489.0 189716.0 190104.0 190405.0 48068.5 48530.3 48574.3 48639.8 48753.8 51423.0 51567.7 51601.0 51605.2 51644.2 16228.6 16797.7 16801.1 16803.7 16880.9 11356.7 11566.3 12971.0 13251.1 13791.2 14366.3 14370.3 14370.4 14381.2 14567.9 5547.4 5746.2 5758.7 5814.3 5881.4 962.6 968.4 981.9 990.6 1012.4 22467.4 22547.4 22790.2 23100.7 23118.0 1082.1 1087.8 1104.8 1112.3 1114.9 11782.4 11848.8 11938.3 12144.6 12235.8 219629.0 222550.0 222821.9 223712.0 223924.0 53700.5 57272.4 57746.4 58167.1 58295.7 1440.0 1474.1 1475.1 1478.8 1486.4 23763.3 26673.6 26806.0 26928.2 27020.5 51558.2 51832.2 51873.5 51874.0 51929.0 197194.0 197701.0 197708.0 198137.0 198561.0 33928.8 34083.5 34113.1 34389.7 34411.7 42517.8 43856.3 44036.1 44254.1 44428.0 30900.2 31643.7 31987.5 32716.3 32720.5 30976.8 32558.8 33079.3 33082.2 33405.3 33687.8 35494.0 36015.1 36118.6 36130.5 29327.7 31379.0 32050.2 32268.4 32377.4 23465.8 23487.5 23495.4 23572.9 23689.9 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | [#2] jquery.html Cycles:180 Average:34427.19 Median:22398.78 stddev:80691.67 (360.3%) stddev-sans-first:80877.98 05:11:22 INFO - PID 3561 | Values: 569.5 574.8 578.5 582.7 609.9 16352.0 21821.1 22773.7 22899.0 23011.0 22233.4 24619.3 24802.6 24802.6 24931.9 6362.3 6530.2 6531.0 6538.6 6548.7 6062.4 6317.3 6340.0 6384.9 6474.7 6285.7 6288.1 6294.7 6302.8 6309.7 6288.9 6290.4 6311.3 6324.3 6333.6 5750.5 5821.9 5843.2 5858.6 5863.7 26946.2 28222.9 28378.4 28569.0 28844.1 1905.7 1953.3 1954.2 1954.4 1957.6 18544.2 18994.6 19056.0 19069.4 19110.7 2224.7 2233.0 2366.4 2394.6 2456.7 137347.0 138548.0 141148.0 141255.6 142682.0 14140.7 14647.4 14778.6 14901.2 14987.3 23199.9 23200.2 23211.0 23234.2 23283.8 10027.2 10370.1 10458.2 10499.3 10671.7 7604.8 9590.1 9604.6 9685.5 9774.5 7978.4 9257.6 9313.3 9334.5 9474.2 2441.3 2468.6 2528.2 2576.3 2668.1 943.9 965.4 975.2 977.2 990.5 18693.6 18914.7 18932.7 18961.2 19160.8 977.8 1023.7 1032.5 1061.4 1069.1 10082.8 10298.4 10317.0 10546.2 12595.6 468531.0 471812.0 474682.0 480844.0 484747.0 114795.0 118253.0 119927.4 120171.0 121187.4 1269.7 1285.9 1301.5 1302.1 1308.8 19002.8 19704.9 19817.2 20017.0 20260.0 57770.4 58393.7 58957.0 59041.4 60182.7 71836.3 72377.6 72654.6 73230.6 73460.6 14045.8 14202.6 14394.6 14463.4 14467.0 22006.7 22336.7 22460.9 22710.0 22982.8 17692.9 17871.7 18113.4 18118.7 18160.4 14593.0 15036.9 15857.3 15899.7 16139.4 16793.4 18099.3 19636.3 19665.8 19774.3 14300.5 14539.0 14547.5 14560.6 14628.1 17325.7 18182.8 18317.3 18367.0 18510.2 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | [#3] mootools.html Cycles:180 Average:8689.49 Median:2572.64 stddev:5852.38 (227.5%) stddev-sans-first:5842.73 05:11:22 INFO - PID 3561 | Values: 1338.7 1403.2 1412.4 1423.0 1431.5 13717.3 13869.0 14322.7 14357.0 14362.3 14347.0 14676.4 14683.0 14697.1 14701.1 2588.9 2706.1 2743.6 2744.5 2745.3 2644.0 2675.6 2678.1 2678.2 2679.5 2623.9 2625.6 2641.7 2645.0 2655.1 2549.0 2553.6 2563.2 2573.1 2576.7 2572.2 2603.5 2606.3 2612.0 2613.3 13607.7 13906.3 13952.8 13986.2 14009.1 7467.0 7505.5 7715.6 7753.2 7794.5 5167.9 5207.6 5334.1 5345.2 5387.9 1876.2 1893.9 1896.5 1968.3 1982.1 22788.3 23040.9 23143.5 23171.4 23178.7 6308.3 6319.6 6422.0 6516.0 6531.5 15129.9 15590.9 15658.7 15674.0 16146.6 7422.7 7633.1 7638.0 7640.8 7645.1 6615.1 7047.3 7064.5 7117.6 7121.2 4960.4 5110.5 5120.9 5121.7 5131.2 1489.0 1499.6 1515.7 1516.3 1519.6 869.2 889.2 896.6 930.1 936.5 7380.2 7851.4 8616.4 8666.8 8859.6 943.1 954.3 963.1 1012.9 1032.2 5181.0 5292.7 5330.0 5351.8 5620.8 18728.5 19246.2 19266.6 19271.6 19308.6 17766.4 18992.0 19100.6 19222.3 19294.3 10822.0 10964.1 10979.6 11017.5 11041.2 7689.3 8002.4 8055.8 8234.2 8522.4 15976.8 16052.8 16563.0 16744.9 16908.0 16111.4 16467.3 16601.4 16602.0 16650.4 11164.0 11377.7 11386.3 11389.1 11395.8 12503.6 12640.4 12967.6 12969.6 13015.3 10168.5 10679.9 10703.5 10918.4 11237.7 10059.8 10268.9 10500.8 10552.9 10606.1 9497.8 9609.3 9637.5 9640.4 9644.5 6394.9 6758.9 6762.7 6963.7 7162.6 6947.9 7103.1 7150.0 7229.7 7370.3 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | [#4] prototype.html Cycles:180 Average:5488.31 Median:6062.20 stddev:1550.43 (25.6%) stddev-sans-first:1508.32 05:11:22 INFO - PID 3561 | Values: 469.7 489.9 492.5 495.1 521.0 6193.6 6302.1 6307.9 6317.3 6348.8 5967.7 6060.7 6094.8 6182.7 6185.0 4911.8 4927.8 4972.3 4989.8 5024.9 4936.9 4936.9 4953.3 4971.4 5025.9 4762.3 4842.5 4861.0 4888.8 4922.2 4884.9 4897.9 4907.6 4942.9 4966.8 4400.4 4444.3 4457.1 4461.4 4473.7 5975.9 6046.3 6050.1 6054.9 6063.7 5649.2 5716.9 5723.5 5741.2 5744.5 6375.0 6474.8 6502.9 6546.4 6577.6 4750.2 4830.6 4834.0 4836.6 4841.2 6849.9 6872.8 6928.9 6974.1 6980.6 4829.3 4857.8 4867.3 4923.9 4970.6 4952.8 4968.2 4982.2 5005.8 5013.6 5576.6 5639.5 5673.9 5681.1 5708.5 6489.4 6509.3 6597.9 6619.8 6649.5 1658.2 1696.2 1710.1 1711.5 1773.6 1206.3 1210.7 1230.2 1234.3 1242.1 5602.2 5677.3 5701.4 5706.5 5739.5 6504.3 6615.4 6664.7 6764.5 6774.6 5750.3 5795.8 5823.2 5823.5 5927.4 3573.9 3583.7 3593.2 3608.6 3614.6 6546.5 6603.0 6620.7 6638.9 6650.0 6830.5 6889.4 6890.6 6893.0 6948.5 6378.2 6408.7 6487.4 6513.6 6522.5 6678.7 6706.0 6753.8 6773.3 6775.0 6554.2 6592.0 6605.7 6636.3 6646.8 6365.3 6402.9 6506.8 6527.4 6574.5 4970.5 4982.4 5021.3 5029.9 5059.7 6761.3 6766.9 6778.8 6796.9 6838.1 6370.9 6394.2 6488.7 6543.1 6547.2 6283.1 6388.5 6511.1 6524.2 6620.7 6147.3 6325.9 6424.7 6448.5 6471.9 6442.0 6444.3 6570.5 6579.0 6618.9 6202.5 6349.4 6354.8 6362.4 6385.6 05:11:22 INFO - PID 3561 | 05:11:22 INFO - PID 3561 | [#5] yui.html Cycles:180 Average:23151.13 Median:20054.95 stddev:31299.70 (156.1%) stddev-sans-first:31342.88 05:11:22 INFO - PID 3561 | Values: 893.1 908.1 929.6 931.2 931.9 15766.8 16471.4 16475.8 16483.3 19286.1 19741.7 21826.6 21879.5 21928.6 21937.7 1036.4 1067.4 1070.0 1073.7 1074.3 950.7 1031.5 1043.2 1048.6 1048.9 1086.2 1100.0 1104.6 1105.3 1105.4 1090.1 1091.1 1091.1 1091.3 1095.2 791.0 795.3 799.3 801.4 805.5 19548.3 19982.2 20200.3 20265.7 20286.3 20495.3 20593.8 21046.2 21047.4 21114.5 15816.8 16172.3 16187.4 16281.8 16536.8 3441.5 3499.8 3499.8 3501.9 3502.2 120798.4 127444.1 128548.0 130194.0 130480.0 15895.8 16016.1 16284.5 16292.3 16318.8 30069.7 30440.0 30518.5 30596.0 30697.5 7369.1 7682.5 8441.1 8701.2 8703.0 4024.0 4198.9 4229.2 4236.7 4239.2 5061.5 5115.7 5184.7 5192.0 5253.3 1072.3 1081.3 1105.9 1107.9 1108.3 632.2 658.9 681.0 687.1 693.9 11252.4 12289.8 12447.2 12492.4 12556.7 644.1 682.8 694.5 694.6 697.7 5367.6 5470.8 5540.0 5599.9 5701.8 99302.0 103215.5 108955.5 109295.5 110290.0 88467.0 90170.5 92666.5 96282.0 97492.5 75316.0 78292.0 79840.8 82372.0 86214.6 10665.5 11019.1 12089.0 12246.7 13062.9 36247.4 36868.0 37717.4 38087.2 38888.4 64533.7 65690.0 68725.3 69235.3 73270.3 18069.3 18456.6 18526.4 18626.7 18841.2 20127.7 20182.0 20874.2 21780.7 21879.8 17330.5 18303.5 18881.0 18973.7 19149.7 16797.5 16901.8 16978.0 17091.6 17313.3 16960.2 17329.7 17589.9 17850.1 18224.0 12161.5 12573.5 12582.1 12629.4 13522.1 13510.8 13676.1 14193.0 14318.8 14482.9 05:11:22 INFO - PID 3561 | -------- Summary: end -------- 05:11:22 INFO - PID 3561 | 05:11:22 INFO - TEST-INFO | 3561: exit 0 05:11:22 INFO - TEST-OK | dromaeo_css | took 1117635ms 05:11:22 INFO - TEST-START | kraken 05:11:22 INFO - Initialising browser for kraken test... 05:11:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40798/getInfo.html -profile /tmp/tmpsv245K/profile 05:11:22 INFO - TEST-INFO | started process 3928 (/builds/slave/test/build/application/firefox/firefox http://localhost:40798/getInfo.html) 05:11:29 INFO - TEST-INFO | 3928: exit 0 05:11:29 INFO - Browser initialized. 05:11:29 INFO - Running cycle 1/1 for kraken test... 05:11:29 INFO - TEST-INFO | started process 4154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsv245K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:40 INFO - PID 4154 | RSS: Main: 173023232 05:11:40 INFO - PID 4154 | 05:11:43 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:44 INFO - PID 4154 | RSS: Main: 179326976 05:11:44 INFO - PID 4154 | 05:11:47 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-dft) 05:11:47 INFO - PID 4154 | RSS: Main: 179650560 05:11:47 INFO - PID 4154 | 05:11:50 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-fft) 05:11:51 INFO - PID 4154 | RSS: Main: 173510656 05:11:51 INFO - PID 4154 | 05:11:53 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40798/tests/kraken/driver.html?testName=audio-oscillator) 05:11:54 INFO - PID 4154 | RSS: Main: 174911488 05:11:54 INFO - PID 4154 | 05:11:56 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:11:56 INFO - PID 4154 | RSS: Main: 174678016 05:11:56 INFO - PID 4154 | 05:12:00 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40798/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:00 INFO - PID 4154 | RSS: Main: 177520640 05:12:00 INFO - PID 4154 | 05:12:04 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40798/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:04 INFO - PID 4154 | RSS: Main: 177049600 05:12:04 INFO - PID 4154 | 05:12:07 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40798/tests/kraken/driver.html?testName=json-parse-financial) 05:12:08 INFO - PID 4154 | RSS: Main: 177639424 05:12:08 INFO - PID 4154 | 05:12:09 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:10 INFO - PID 4154 | RSS: Main: 178130944 05:12:10 INFO - PID 4154 | 05:12:12 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:13 INFO - PID 4154 | RSS: Main: 177430528 05:12:13 INFO - PID 4154 | 05:12:15 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:15 INFO - PID 4154 | RSS: Main: 178126848 05:12:15 INFO - PID 4154 | 05:12:18 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:19 INFO - PID 4154 | RSS: Main: 178462720 05:12:19 INFO - PID 4154 | 05:12:22 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:22 INFO - PID 4154 | RSS: Main: 178352128 05:12:22 INFO - PID 4154 | 05:12:24 INFO - PID 4154 | Cycle 1(1): loaded http://localhost:40798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40798/tests/kraken/driver.html?testName=ai-astar) 05:12:25 INFO - PID 4154 | RSS: Main: 180019200 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | __start_tp_report 05:12:25 INFO - PID 4154 | _x_x_mozilla_page_load 05:12:25 INFO - PID 4154 | _x_x_mozilla_page_load_details 05:12:25 INFO - PID 4154 | |i|pagename|runs| 05:12:25 INFO - PID 4154 | |0;ai-astar;100;109;103;113;113;110;116;100;109;112 05:12:25 INFO - PID 4154 | |1;audio-beat-detection;147;117;141;179;120;144;153;118;179;125 05:12:25 INFO - PID 4154 | |2;audio-dft;164;164;167;166;164;162;166;171;168;164 05:12:25 INFO - PID 4154 | |3;audio-fft;74;73;76;167;74;75;76;88;100;74 05:12:25 INFO - PID 4154 | |4;audio-oscillator;81;81;128;81;80;82;147;81;81;135 05:12:25 INFO - PID 4154 | |5;imaging-gaussian-blur;114;114;114;114;114;114;113;113;114;118 05:12:25 INFO - PID 4154 | |6;imaging-darkroom;151;153;152;153;151;152;152;153;151;151 05:12:25 INFO - PID 4154 | |7;imaging-desaturate;98;96;95;94;95;95;95;94;95;94 05:12:25 INFO - PID 4154 | |8;json-parse-financial;56;55;57;65;55;54;55;54;55;56 05:12:25 INFO - PID 4154 | |9;json-stringify-tinderbox;54;54;55;56;54;55;55;54;54;54 05:12:25 INFO - PID 4154 | |10;stanford-crypto-aes;79;77;78;77;78;77;79;78;77;79 05:12:25 INFO - PID 4154 | |11;stanford-crypto-ccm;142;144;126;127;135;127;143;127;132;159 05:12:25 INFO - PID 4154 | |12;stanford-crypto-pbkdf2;176;196;191;180;177;173;175;175;173;171 05:12:25 INFO - PID 4154 | |13;stanford-crypto-sha256-iterative;72;68;68;69;67;69;69;68;67;67 05:12:25 INFO - PID 4154 | __end_tp_report 05:12:25 INFO - PID 4154 | __start_cc_report 05:12:25 INFO - PID 4154 | _x_x_mozilla_cycle_collect,968 05:12:25 INFO - PID 4154 | __end_cc_report 05:12:25 INFO - PID 4154 | __startTimestamp1500898345030__endTimestamp 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | ------- Summary: start ------- 05:12:25 INFO - PID 4154 | Number of tests: 14 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#0] ai-astar Cycles:10 Average:108.50 Median:111.00 stddev:5.64 (5.1%) stddev-sans-first:5.08 05:12:25 INFO - PID 4154 | Values: 100.0 109.0 103.0 113.0 113.0 110.0 116.0 100.0 109.0 112.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:145.50 stddev:23.24 (16.0%) stddev-sans-first:24.59 05:12:25 INFO - PID 4154 | Values: 147.0 117.0 141.0 179.0 120.0 144.0 153.0 118.0 179.0 125.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:2.59 (1.6%) stddev-sans-first:2.68 05:12:25 INFO - PID 4154 | Values: 164.0 164.0 167.0 166.0 164.0 162.0 166.0 171.0 168.0 164.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#3] audio-fft Cycles:10 Average:87.70 Median:74.50 stddev:29.16 (39.1%) stddev-sans-first:30.51 05:12:25 INFO - PID 4154 | Values: 74.0 73.0 76.0 167.0 74.0 75.0 76.0 88.0 100.0 74.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:81.00 stddev:27.27 (33.7%) stddev-sans-first:28.25 05:12:25 INFO - PID 4154 | Values: 81.0 81.0 128.0 81.0 80.0 82.0 147.0 81.0 81.0 135.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.40 (1.2%) stddev-sans-first:1.48 05:12:25 INFO - PID 4154 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 118.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 05:12:25 INFO - PID 4154 | Values: 151.0 153.0 152.0 153.0 151.0 152.0 152.0 153.0 151.0 151.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:0.67 05:12:25 INFO - PID 4154 | Values: 98.0 96.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:3.22 (5.8%) stddev-sans-first:3.42 05:12:25 INFO - PID 4154 | Values: 56.0 55.0 57.0 65.0 55.0 54.0 55.0 54.0 55.0 56.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 05:12:25 INFO - PID 4154 | Values: 54.0 54.0 55.0 56.0 54.0 55.0 55.0 54.0 54.0 54.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:0.88 (1.1%) stddev-sans-first:0.83 05:12:25 INFO - PID 4154 | Values: 79.0 77.0 78.0 77.0 78.0 77.0 79.0 78.0 77.0 79.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:138.50 stddev:10.74 (7.8%) stddev-sans-first:11.18 05:12:25 INFO - PID 4154 | Values: 142.0 144.0 126.0 127.0 135.0 127.0 143.0 127.0 132.0 159.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:176.50 stddev:8.26 (4.7%) stddev-sans-first:8.70 05:12:25 INFO - PID 4154 | Values: 176.0 196.0 191.0 180.0 177.0 173.0 175.0 175.0 173.0 171.0 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.51 (2.2%) stddev-sans-first:0.87 05:12:25 INFO - PID 4154 | Values: 72.0 68.0 68.0 69.0 67.0 69.0 69.0 68.0 67.0 67.0 05:12:25 INFO - PID 4154 | -------- Summary: end -------- 05:12:25 INFO - PID 4154 | 05:12:25 INFO - PID 4154 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:12:25 INFO - TEST-INFO | 4154: exit 0 05:12:25 INFO - TEST-OK | kraken | took 62997ms 05:12:25 INFO - SUITE-END | took 1180s 05:12:26 INFO - Completed test suite (00:19:41) 05:12:26 INFO - javascript benchmark 05:12:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8422.734191392014, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.984480077599, 3142.8585713642883, 3153.0, 3161.178093695639, 3212.5181222816573, 5966.671833049186, 5970.6716130612795, 6026.668533230676, 6116.908246376308, 6205.255369355672, 5957.910631340534, 5993.910091348634, 6062.060380641008, 6067.9696601516935, 6099.695015249231, 5444.992676354867, 5507.972460137694, 5576.637518561301, 5601.775928962837, 5601.859953501154, 5471.179323101546, 5591.189277554752, 5627.184058311543, 5676.035074037423, 5680.431956804307, 5577.776888924438, 5585.636933599323, 5665.660060396369, 5670.716464176816, 5688.60179787413, 5469.0, 5541.196526503634, 5570.415106413809, 5643.746031428595, 5650.5479561634975, 5489.807856724996, 5499.890002199973, 5546.140348246028, 5599.160125981095, 5605.495505404533, 6039.063945088518, 6068.120122582201, 6101.450869421729, 6102.481289090432, 6139.631622102688, 6377.298497165308, 6456.870047741627, 6484.578502397329, 6505.251896031969, 6544.476441884638, 6497.870042599122, 6505.60966342021, 6512.772052978123, 6525.902111468332, 6618.4705223582, 6092.0, 6175.59858609189, 6179.50563954887, 6184.87630247397, 6208.441240288395, 6511.739530418825, 6644.036614690843, 6690.498212634072, 6779.2881747416795, 6795.7961261162245, 6231.563790534619, 6242.656653883989, 6250.843728906722, 6275.623462592259, 6308.558400911892, 6276.811695649138, 6286.968565157236, 6356.237251529846, 6356.300806911236, 6460.580062295936, 6496.090547323379, 6496.512761542903, 6513.3812287833525, 6535.183102112236, 6543.1166792483355, 6423.646699431576, 6546.607203567801, 6554.3117972613145, 6582.967085164543, 6583.0, 5312.123499622519, 5335.146376579806, 5381.919271210935, 5391.137418013099, 5397.622166448311, 4496.955030449719, 4541.818327266872, 4559.247724125548, 4615.653825963066, 4616.930746038812, 5628.915566266509, 5682.289713785777, 5767.596268261265, 5773.16289138081, 5799.536037117021, 6517.771877984343, 6519.380658837403, 6595.604263744191, 6615.900761488581, 6655.301193374723, 5664.0, 5677.744501497443, 5747.310322761212, 5752.07966725322, 5762.0204565223175, 5655.406182350876, 5706.457886500776, 5775.422457754191, 5777.768889244468, 5813.157092221604, 6383.39357761012, 6389.936100639027, 6398.168238129107, 6421.229452465641, 6442.420182183626, 6586.242582103119, 6587.769428070186, 6589.7364105435245, 6659.800205993828, 6680.164979377578, 6172.290186628596, 6306.527010474325, 6313.2424109107205, 6320.683965801783, 6354.52341074412, 6338.429541341301, 6340.619562826245, 6345.555811093179, 6355.3644635536075, 6386.584871983492, 6504.479641628753, 6597.967010164918, 6611.33886611335, 6613.041109039066, 6622.602643841385, 6286.119943208046, 6333.271673757393, 6414.326495717883, 6425.036244563353, 6425.9036114457385, 6293.118963345044, 6307.936920630918, 6400.231972163184, 6410.583312084699, 6413.935860641521, 6173.69131543412, 6228.065790131335, 6253.906191407224, 6254.718537665725, 6344.841378965562, 6234.906476402948, 6353.5870168438905, 6422.6467544285515, 6428.067930150196, 6463.903041454288, 6132.834761395321, 6148.0, 6166.321704612399, 6228.844278893064, 6242.469390101892], "value": 5959.670436129855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.668036105197, 846.5428668519, 860.0883063952211, 864.7708357285317, 1157.670064031751, 30963.38073238534, 31507.84246078769, 41912.16175676489, 42816.0, 42869.35695964563, 43156.0, 43650.0, 43668.563314366846, 43676.0, 43712.562874371244, 7494.325510704036, 7552.88670669939, 7753.728619498319, 7775.766726998199, 7781.338586220149, 7630.732924347649, 7741.767746967572, 7749.186335434782, 7751.914731937533, 7752.728654497094, 7722.073351197864, 7736.032995875516, 7747.96126019372, 7752.689892404297, 7780.494267872598, 7629.809254768647, 7689.615519224044, 7724.266194711521, 7731.072271327476, 7749.7675069748, 7521.623918804038, 7615.80960475987, 7617.46677732559, 7619.619019049025, 7632.1986191450205, 39513.0, 39605.217765200636, 39645.80177099096, 39645.801770991246, 39984.0, 3549.396602577568, 3567.661072198137, 3587.7488575799703, 3591.515145455356, 3598.1904071583945, 32276.354472910643, 32375.6762432375, 32399.51400728991, 32407.35185296281, 32425.51361729576, 4845.345878306419, 4885.218365061573, 4933.457319694867, 4940.876478088041, 4979.327790748239, 189027.0, 189489.0, 189716.0, 190104.0, 190405.0, 48068.519314807105, 48530.27204591934, 48574.27138592924, 48639.75680121648, 48753.75623121862, 51423.0, 51567.74216128895, 51601.0, 51605.22592161121, 51644.22533661998, 16228.594285142966, 16797.748033779502, 16801.07594082337, 16803.66392672164, 16880.915595421946, 11356.659300221007, 11566.30602163873, 12971.0, 13251.072424930162, 13791.241481718602, 14366.281685915663, 14370.281485925661, 14370.353334099991, 14381.209033503257, 14567.92716036413, 5547.389787123494, 5746.195532625436, 5758.683272419973, 5814.273215848019, 5881.3530511643685, 962.552413127899, 968.3608818179968, 981.9214462842956, 990.6235630460379, 1012.3824467075078, 22467.438314041952, 22547.43631409228, 22790.202342917917, 23100.65349019766, 23118.0, 1082.123479981202, 1087.7933192693363, 1104.8066588347008, 1112.3492756737237, 1114.916381271408, 11782.410879455992, 11848.763024739457, 11938.343391113573, 12144.635660930186, 12235.755284894252, 219629.0, 222550.0, 222821.8858905695, 223712.0, 223924.0, 53700.462995370326, 57272.42727572671, 57746.422535774946, 58167.12749308764, 58295.70852145797, 1440.0, 1474.0860666386695, 1475.1296734926445, 1478.7855760914608, 1486.37572219668, 23763.287101386984, 26673.599896001964, 26806.0, 26928.192154235403, 27020.45959080768, 51558.226626599884, 51832.22251666304, 51873.48126518838, 51874.0, 51929.0, 197194.0, 197701.0, 197708.0, 198137.0, 198561.0, 33928.83035584905, 34083.48874766831, 34113.14717132092, 34389.65610343865, 34411.65588344084, 42517.787411062745, 43856.34215486707, 44036.11927761491, 44254.11491770082, 44428.0, 30900.227494311923, 31643.683563164996, 31987.520187197675, 32716.34567308593, 32720.509192361656, 30976.84511577428, 32558.83720581382, 33079.33841323208, 33082.17294567655, 33405.33189336151, 33687.83156084204, 35494.0, 36015.099622509646, 36118.638813612575, 36130.45804312885, 29327.706722932497, 31379.0, 32050.19874503156, 32268.35463290674, 32377.35245295128, 23465.765342346356, 23487.530249394575, 23495.41261468477, 23572.88213558921, 23689.881550592138], "value": 17406.91408965661, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4789267819942, 574.8045664474083, 578.5342799046766, 582.7202942587558, 609.8536351275694, 16352.0, 21821.127154913804, 22773.658395124086, 22899.0, 23011.0, 22233.44416389591, 24619.26142215732, 24802.627960580605, 24802.627960580605, 24931.87806548705, 6362.268339141, 6530.183727034121, 6530.967345163268, 6538.574992625464, 6548.738050477975, 6062.424069713392, 6317.2735135459325, 6340.017297318923, 6384.872302553946, 6474.741010359604, 6285.748570057192, 6288.119663247149, 6294.7482100715915, 6302.779402720906, 6309.6845157742155, 6288.937110628881, 6290.433860952537, 6311.274203466592, 6324.272708638497, 6333.55665103443, 5750.482456578928, 5821.941780582182, 5843.211166492554, 5858.648481091105, 5863.706814659293, 26946.191614251602, 28222.858885705646, 28378.43243135126, 28569.000084997133, 28844.134675959755, 1905.7141428785656, 1953.257762050426, 1954.2378472395776, 1954.4332143678316, 1957.5889063296725, 18544.16551255197, 18994.62010759777, 19056.0, 19069.427917162368, 19110.71333929992, 2224.7219097612797, 2232.9553408931893, 2366.408397900525, 2394.608476153812, 2456.6683497727936, 137347.0, 138548.0, 141148.0, 141255.58744412527, 142682.0, 14140.717185656435, 14647.414103435956, 14778.63053423673, 14901.180435076174, 14987.250637468083, 23199.884000580227, 23200.18799342015, 23211.0, 23234.1868034618, 23283.7671623285, 10027.247956403298, 10370.11853992404, 10458.215633827342, 10499.317544359592, 10671.73320666974, 7604.771856844193, 9590.08894155054, 9604.615815367308, 9685.515724213761, 9774.462404567676, 7978.361731061501, 9257.629694812267, 9313.254939604816, 9334.486603236752, 9474.247264256135, 2441.316431399211, 2468.5556599812207, 2528.153068721999, 2576.3172759218824, 2668.0795125681607, 943.9103285188033, 965.3628605120587, 975.2441857560306, 977.1596427072711, 990.4693508086907, 18693.626127477375, 18914.716279255823, 18932.71600925987, 18961.24155033811, 19160.80839191618, 977.7604486900755, 1023.7235946294459, 1032.4992378696327, 1061.4374381577777, 1069.1019543583427, 10082.848757268646, 10298.433586152834, 10317.0, 10546.209034322457, 12595.622131336075, 468531.0, 471812.0, 474682.0, 480844.0, 484747.0, 114795.0, 118253.0, 119927.40036299937, 120171.0, 121187.39406303088, 1269.7079671675567, 1285.8842704156484, 1301.5444594391888, 1302.1145620977827, 1308.8036794480904, 19002.809971900104, 19704.90147549253, 19817.20731170737, 20016.99915004215, 20260.0, 57770.42229577818, 58393.70803145957, 58957.0, 59041.40958590359, 60182.69908650429, 71836.28163718505, 72377.63811180911, 72654.63672681602, 73230.63384683043, 73460.63269683617, 14045.789313160107, 14202.644933876323, 14394.640133996734, 14463.421463141778, 14467.0, 22006.669899951194, 22336.66495002544, 22460.887695561418, 22710.0, 22982.770172298064, 17692.93842369462, 17871.73192402141, 18113.366032189337, 18118.728219076987, 18160.364387246384, 14593.0, 15036.924815376291, 15857.286422111263, 15899.682006360039, 16139.435119770751, 16793.41223057187, 18099.276028959222, 19636.312729054414, 19665.80334196697, 19774.307899224033, 14300.499482518062, 14539.0, 14547.490837820626, 14560.563183104523, 14628.122312661275, 17325.740113898555, 18182.81817181811, 18317.267309307477, 18367.0, 18510.16704248285], "value": 11825.429776628403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.7054847933455, 1403.16511675553, 1412.3644360037986, 1422.982567464263, 1431.5204406523817, 13717.314134293283, 13869.0, 14322.713545729079, 14357.0, 14362.281885905702, 14346.995710300283, 14676.412943482275, 14683.0, 14697.118172909633, 14701.117932924006, 2588.9093881714143, 2706.07993282284, 2743.5747459143763, 2744.533429317021, 2745.341118131654, 2644.0, 2675.5719084946413, 2678.07606375801, 2678.183154137987, 2679.490896729615, 2623.9212823615226, 2625.6061590761346, 2641.696204936438, 2645.034562384735, 2655.0839960213793, 2549.0, 2553.6424900513757, 2563.1925943327883, 2573.073693470349, 2576.729443408434, 2572.2026171886587, 2603.4923189977962, 2606.2832721001687, 2611.9869400652874, 2613.3074735195187, 13607.659808504768, 13906.30468476572, 13952.790708139284, 13986.16083035011, 14009.089409188473, 7467.0, 7505.474616776828, 7715.575643339614, 7753.224677532258, 7794.493357931717, 5167.863070124567, 5207.557357624606, 5334.0665383557725, 5345.198220266952, 5387.865303367408, 1876.1557299215272, 1893.933712320076, 1896.544829240986, 1968.2717394564104, 1982.117957508909, 22788.31635050951, 23040.884795576083, 23143.53712925749, 23171.420714482105, 23178.65232021521, 6308.274548426898, 6319.58922670025, 6422.0, 6516.0, 6531.510136739764, 15129.924350378178, 15590.9220453897, 15658.68682626341, 15674.0, 16146.596335091717, 7422.665980030912, 7633.084029916335, 7637.961810190914, 7640.770776876702, 7645.082590089114, 6615.106960560262, 7047.295270473014, 7064.470164737665, 7117.64411779409, 7121.216666166718, 4960.355153829979, 5110.540051395392, 5120.948790512121, 5121.743912804345, 5131.179011358239, 1488.9851101489064, 1499.6250937265684, 1515.6817068415535, 1516.2797671106357, 1519.5973067137218, 869.1829680100685, 889.213046453893, 896.5562046786882, 930.1210356213448, 936.5083331251011, 7380.151282602462, 7851.411144164211, 8616.353773467015, 8666.826663466696, 8859.64561417536, 943.1228957069853, 954.2842867849113, 963.1139351796364, 1012.8885822559513, 1032.2258306270298, 5181.0, 5292.708901010481, 5330.0, 5351.839444816662, 5620.835978148442, 18728.53178670544, 19246.23015079381, 19266.614667706566, 19271.614567708566, 19308.61382772365, 17766.378176763752, 18992.0, 19100.61798764017, 19222.327218547285, 19294.32469863548, 10822.0, 10964.068054215322, 10979.560817567368, 11017.504212310465, 11041.171912106623, 7689.3464055555905, 8002.399820013406, 8055.798605034921, 8234.176582341717, 8522.403431759965, 15976.760348594547, 16052.839471605135, 16563.0, 16744.91158074721, 16908.0, 16111.436099736453, 16467.34130634809, 16601.41895033668, 16602.003879767253, 16650.417235397188, 11164.0, 11377.715557111138, 11386.259893106922, 11389.088872890314, 11395.772084558097, 12503.56237531682, 12640.43118059708, 12967.610971670865, 12969.610911672666, 13015.284159371326, 10168.542415591464, 10679.89320106789, 10703.464826758474, 10918.399488028235, 11237.71905702364, 10059.849102263326, 10268.897311026794, 10500.842487362543, 10552.947235263775, 10606.098481629147, 9497.762555936157, 9609.279304052085, 9637.469939153414, 9640.373375730554, 9644.517774111408, 6394.936050639434, 6758.8648227036165, 6762.729490820312, 6963.6866341013765, 7162.606056666933, 6947.93052069493, 7103.112110986127, 7149.964250178716, 7229.7469588564145, 7370.262973702587], "value": 6387.443642414132, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.65715028029535, 489.89957058802946, 492.4828929623894, 495.0714747114137, 520.9843704688858, 6193.597416167946, 6302.149209856674, 6307.873842523147, 6317.273513545943, 6348.841278968028, 5967.701614919259, 6060.696950155716, 6094.8171554853425, 6182.7217775200115, 6184.979478386061, 4911.778969946361, 4927.802887884481, 4972.328735620699, 4989.825356112546, 5024.924626130611, 4936.851894443154, 4936.901261974776, 4953.306537084811, 4971.37857767779, 5025.899482010358, 4762.261849413347, 4842.491538388454, 4861.027794441108, 4888.780004899771, 4922.187839006559, 4884.8534543963915, 4897.926531102036, 4907.582855457273, 4942.9011419771405, 4966.776495057731, 4400.427944367212, 4444.31113177458, 4457.108578284324, 4461.420015397977, 4473.686841921067, 5975.910361344583, 6046.304674962392, 6050.122732203849, 6054.909176362358, 6063.696815159225, 5649.23735295734, 5716.942365662366, 5723.456271654228, 5741.167530708024, 5744.454276843693, 6375.0, 6474.805755827333, 6502.902456463157, 6546.378094081055, 6577.638229897354, 4750.168720473937, 4830.6135509159185, 4833.951660483421, 4836.564709176156, 4841.2496063110275, 6849.897251541231, 6872.828179295508, 6928.896066558956, 6974.128233970754, 6980.581165130057, 4829.348038014893, 4857.781399837016, 4867.294242334841, 4923.876903077452, 4970.627202959792, 4952.777125029383, 4968.22992436173, 4982.153033984231, 5005.799768009311, 5013.5989120870245, 5576.553875689935, 5639.520640745501, 5673.886522269531, 5681.119426488901, 5708.486236238676, 6489.383508566679, 6509.349065093453, 6597.934020659732, 6619.768308109193, 6649.534532582769, 1658.1957750491001, 1696.2282161616436, 1710.1363811275476, 1711.4865540337848, 1773.645270945816, 1206.2641788509002, 1210.7045461356265, 1230.2249582762802, 1234.3087870792385, 1242.099477878549, 5602.215689803431, 5677.261955945701, 5701.403606990049, 5706.546185140346, 5739.540836733051, 6504.349565043458, 6615.404613584704, 6664.700088496029, 6764.458843292525, 6774.593524388552, 5750.30996280449, 5795.826565038111, 5823.184754134425, 5823.534117270693, 5927.3776253493625, 3573.8927832165077, 3583.7133029357587, 3593.2454184621, 3608.6210947850623, 3614.6204648512053, 6546.509011824132, 6602.966985165043, 6620.735170593219, 6638.933610663831, 6649.966750166218, 6830.453563714891, 6889.448844092461, 6890.552114112566, 6892.965535172292, 6948.478864085214, 6378.2346118466085, 6408.711607977652, 6487.3836985486305, 6513.589971710592, 6522.543421960512, 6678.7328506859185, 6705.9882035390165, 6753.763618273337, 6773.322667733384, 6775.0, 6554.246261679968, 6592.0111983202905, 6605.702743376656, 6636.279125558498, 6646.767363142267, 6365.267994180728, 6402.871942561216, 6506.804795856132, 6527.445167160845, 6574.4740420765265, 4970.478099799614, 4982.402111746614, 5021.342956824166, 5029.874253143555, 5059.721715305694, 6761.256261811295, 6766.93233067663, 6778.796636100925, 6796.864062718817, 6838.14523184602, 6370.872582548416, 6394.200724909387, 6488.70800813974, 6543.116679248241, 6547.214334279917, 6283.115065480246, 6388.456981156468, 6511.120998665119, 6524.151860258136, 6620.735170593315, 6147.293061298008, 6325.936740632719, 6424.678766061772, 6448.451881590117, 6471.935280647322, 6442.002979076501, 6444.2911279758255, 6570.507211959218, 6578.967105164444, 6618.933810661832, 6202.472789812736, 6349.428551430394, 6354.809355719336, 6362.363763623601, 6385.616862988236], "value": 5027.905561354712, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.1291990309445, 908.1191244492842, 929.5538141691992, 931.1573026411096, 931.874196983407, 15766.763498547516, 16471.42350017748, 16475.75286370704, 16483.258253378597, 19286.132124054417, 19741.713086703454, 21826.563468730616, 21879.453013674665, 21928.561428771416, 21937.670934935948, 1036.383351905615, 1067.391586795523, 1069.9732506687317, 1073.6617965340931, 1074.274864466486, 950.653011650746, 1031.5306535526356, 1043.2488608202082, 1048.6015314180602, 1048.937063776172, 1086.1962148010493, 1100.031971864762, 1104.6133853151373, 1105.309181761399, 1105.4307031878589, 1090.0571006079763, 1091.0943916549245, 1091.110744743032, 1091.307020042279, 1095.1950316517352, 790.9802254943614, 795.2842441802367, 799.312591171592, 801.3669201330999, 805.4885147931047, 19548.31580894662, 19982.200711971505, 20200.292989745434, 20265.696014559795, 20286.289979850633, 20495.28266510665, 20593.794062059336, 21046.158153673834, 21047.368578942504, 21114.472138196514, 15816.76274855878, 16172.272247748879, 16187.433439829667, 16281.755773663404, 16536.83463165377, 3441.48377743338, 3499.7725147865563, 3499.7900125992523, 3501.859925602973, 3502.2120022994877, 120798.39600802115, 127444.08833867499, 128548.0, 130194.0, 130480.0, 15895.841041589667, 16016.11911344864, 16284.51146465608, 16292.266847991868, 16318.836811631969, 30069.699303007128, 30440.0, 30518.54222186669, 30596.0, 30697.539536906963, 7369.115706115301, 7682.500637458547, 8441.07148213696, 8701.216890479887, 8702.95648521766, 4023.979880100639, 4198.874033778991, 4229.217594744982, 4236.724612900151, 4239.1521695660995, 5061.468545802638, 5115.693058416507, 5184.662996905189, 5191.974040129775, 5253.264542963988, 1072.265498133781, 1081.3079629037265, 1105.8783533811275, 1107.855978722777, 1108.3294606762793, 632.2286810091681, 658.8912829383098, 681.0227323790376, 687.0724521895402, 693.8646963842103, 11252.43737813106, 12289.754204916031, 12447.190932589352, 12492.375381230902, 12556.748865022648, 644.1304239277032, 682.7610336382326, 694.5069001009239, 694.5658963148032, 697.6755808549049, 5367.624266301399, 5470.8085217017215, 5539.972300138474, 5599.860003499945, 5701.771929122871, 99302.0, 103215.48392257991, 108955.45522272497, 109295.45352273187, 110290.0, 88467.0, 90170.54914725384, 92666.53666731624, 96282.0, 97492.51253743687, 75316.0, 78292.0, 79840.80238796423, 82372.0, 86214.56892715496, 10665.520051597852, 11019.118470522179, 12089.0, 12246.731659104196, 13062.88761722147, 36247.41862523376, 36868.0, 37717.434238486996, 38087.23825523419, 38888.416673750486, 64533.67733161304, 65690.01464978125, 68725.31274687189, 69235.30764692288, 73270.26729732634, 18069.27722891122, 18456.630867382846, 18526.444206673823, 18626.72059919075, 18841.15214815309, 20127.698084528452, 20182.0, 20874.165033398494, 21780.673289900347, 21879.781202187773, 17330.480085597454, 18303.54241143982, 18881.0, 18973.71539426882, 19149.712754308417, 16797.496075117768, 16901.830981690517, 16978.0, 17091.572710682332, 17313.307467701656, 16960.151992400577, 17329.653406932044, 17589.912050439667, 17850.107494625478, 18224.0, 12161.452734626786, 12573.497060117494, 12582.119251652663, 12629.431675574437, 13522.053456258362, 13510.769276047728, 13676.111052781538, 14193.0, 14318.782903453322, 14482.927585362428], "value": 9061.83087758993, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 103.0, 113.0, 113.0, 110.0, 116.0, 100.0, 109.0, 112.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 141.0, 179.0, 120.0, 144.0, 153.0, 118.0, 179.0, 125.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 167.0, 166.0, 164.0, 162.0, 166.0, 171.0, 168.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 167.0, 74.0, 75.0, 76.0, 88.0, 100.0, 74.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 128.0, 81.0, 80.0, 82.0, 147.0, 81.0, 81.0, 135.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 118.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 152.0, 153.0, 151.0, 152.0, 152.0, 153.0, 151.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 65.0, 55.0, 54.0, 55.0, 54.0, 55.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 56.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 77.0, 78.0, 77.0, 79.0, 78.0, 77.0, 79.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 126.0, 127.0, 135.0, 127.0, 143.0, 127.0, 132.0, 159.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 196.0, 191.0, 180.0, 177.0, 173.0, 175.0, 175.0, 173.0, 171.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 69.0, 67.0, 69.0, 69.0, 68.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 05:12:26 INFO - Return code: 0 05:12:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:12:26 INFO - # TBPL SUCCESS # 05:12:26 INFO - Running post-action listener: _package_coverage_data 05:12:26 INFO - Running post-action listener: _resource_record_post_action 05:12:26 INFO - [mozharness: 2017-07-24 12:12:26.326335Z] Finished run-tests step (success) 05:12:26 INFO - Running post-run listener: _resource_record_post_run 05:12:26 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 5427200; Write bytes: 445972480; Read time: 2480; Write time: 367300 05:12:26 INFO - TinderboxPrint: CPU usage
13.2% 05:12:26 INFO - TinderboxPrint: I/O read bytes / time
5,427,200 / 2,480 05:12:26 INFO - TinderboxPrint: I/O write bytes / time
445,972,480 / 367,300 05:12:26 INFO - TinderboxPrint: CPU idle
8,299.0 (86.8%) 05:12:26 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 05:12:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:12:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117055488; Read time: 184; Write time: 74648 05:12:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:12:26 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 2928640; Write bytes: 328916992; Read time: 1780; Write time: 292652 05:12:26 INFO - Running post-run listener: _upload_blobber_files 05:12:26 INFO - Blob upload gear active. 05:12:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:26 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:12:26 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:12:26 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:12:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:12:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:28 INFO - (blobuploader) - INFO - Done attempting. 05:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:12:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:12:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:28 INFO - (blobuploader) - INFO - Done attempting. 05:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:33 INFO - (blobuploader) - INFO - Done attempting. 05:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:35 INFO - (blobuploader) - INFO - Done attempting. 05:12:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:12:35 INFO - Return code: 0 05:12:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:12:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:12:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c0816e1d9e7f4f650c28b1d7e40cdf68f78ad52e509e449e8ee4feb42c3e4b25e94c104b33b049a0fd422389b8c7013ade382edc3d005c8b429406b44965ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6eb97417e97dfd404e6e8d509c68a8309fc1afd3158ef961e9916016ec3ad73a29f890bdf0b18d613e420e1640d8ce036d09bbf760bbd063cb9e667fe0ffd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d03952fb1364f9bfa30a38514e0f7e943a99bc43c8e7028215135e8a065d1d2eaccc0c22ebf0eb37725292e1a13a09514af08b65c94071ecfef3d934eb1c9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3583bd7019e52648be92909a843e7f8fa38c026515f2f98505e140fa8e6c196679a603b036b73b4d782e0b9206398b28f489f2bc8d0576f388327e9fc9da8d1"} 05:12:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:12:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:12:35 INFO - Contents: 05:12:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c0816e1d9e7f4f650c28b1d7e40cdf68f78ad52e509e449e8ee4feb42c3e4b25e94c104b33b049a0fd422389b8c7013ade382edc3d005c8b429406b44965ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6eb97417e97dfd404e6e8d509c68a8309fc1afd3158ef961e9916016ec3ad73a29f890bdf0b18d613e420e1640d8ce036d09bbf760bbd063cb9e667fe0ffd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d03952fb1364f9bfa30a38514e0f7e943a99bc43c8e7028215135e8a065d1d2eaccc0c22ebf0eb37725292e1a13a09514af08b65c94071ecfef3d934eb1c9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3583bd7019e52648be92909a843e7f8fa38c026515f2f98505e140fa8e6c196679a603b036b73b4d782e0b9206398b28f489f2bc8d0576f388327e9fc9da8d1"} 05:12:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:12:35 INFO - Copying logs to upload dir... 05:12:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:12:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.344059 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-07-24 05:12:35.035398) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:12:35.041400) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986 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/24c0816e1d9e7f4f650c28b1d7e40cdf68f78ad52e509e449e8ee4feb42c3e4b25e94c104b33b049a0fd422389b8c7013ade382edc3d005c8b429406b44965ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6eb97417e97dfd404e6e8d509c68a8309fc1afd3158ef961e9916016ec3ad73a29f890bdf0b18d613e420e1640d8ce036d09bbf760bbd063cb9e667fe0ffd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d03952fb1364f9bfa30a38514e0f7e943a99bc43c8e7028215135e8a065d1d2eaccc0c22ebf0eb37725292e1a13a09514af08b65c94071ecfef3d934eb1c9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3583bd7019e52648be92909a843e7f8fa38c026515f2f98505e140fa8e6c196679a603b036b73b4d782e0b9206398b28f489f2bc8d0576f388327e9fc9da8d1"} build_url:https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/PE7z0GOQSrS6K7moteSUmw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c0816e1d9e7f4f650c28b1d7e40cdf68f78ad52e509e449e8ee4feb42c3e4b25e94c104b33b049a0fd422389b8c7013ade382edc3d005c8b429406b44965ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6eb97417e97dfd404e6e8d509c68a8309fc1afd3158ef961e9916016ec3ad73a29f890bdf0b18d613e420e1640d8ce036d09bbf760bbd063cb9e667fe0ffd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90d03952fb1364f9bfa30a38514e0f7e943a99bc43c8e7028215135e8a065d1d2eaccc0c22ebf0eb37725292e1a13a09514af08b65c94071ecfef3d934eb1c9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3583bd7019e52648be92909a843e7f8fa38c026515f2f98505e140fa8e6c196679a603b036b73b4d782e0b9206398b28f489f2bc8d0576f388327e9fc9da8d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 05:12:35.073161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:12:35.073495) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1500897088.612265-2025447986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004372 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 05:12:35.156101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:12:35.156811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 05:12:35.157479) ========= ========= Total master_lag: -0.00 =========