builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1500218079.49 results: success (0) revision: bc3f73d54feeaf0e97b30496574357f05b2d5307 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:39.494589) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:39.495077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:39.495347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:40.164729) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:40.165048) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 08:14:40-- 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% 222M=0s 2017-07-16 08:14:40 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.230155 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:40.452697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:40.452973) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077824 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:40.541804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:40.545150) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc3f73d54feeaf0e97b30496574357f05b2d5307 --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 bc3f73d54feeaf0e97b30496574357f05b2d5307 --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=d6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 08:14:40,534 truncating revision to first 12 chars 2017-07-16 08:14:40,534 Setting DEBUG logging. 2017-07-16 08:14:40,534 attempt 1/10 2017-07-16 08:14:40,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc3f73d54fee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 08:14:40,821 unpacking tar archive at: mozilla-central-bc3f73d54fee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:41.147492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:41.147790) ========= script_repo_revision: bc3f73d54feeaf0e97b30496574357f05b2d5307 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:41.148177) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:41.148439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:14:41.171596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-16 08:14:41.171854) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:41 INFO - MultiFileLogger online at 20170716 08:14:41 in /builds/slave/test 08:14:41 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 08:14:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:41 INFO - {'append_to_log': False, 08:14:41 INFO - 'base_work_dir': '/builds/slave/test', 08:14:41 INFO - 'blob_upload_branch': 'Firefox', 08:14:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:41 INFO - 'branch': 'Firefox', 08:14:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:41 INFO - 'code_coverage': False, 08:14:41 INFO - 'config_files': ('talos/linux_config.py',), 08:14:41 INFO - 'default_actions': ('clobber', 08:14:41 INFO - 'read-buildbot-config', 08:14:41 INFO - 'download-and-extract', 08:14:41 INFO - 'populate-webroot', 08:14:41 INFO - 'create-virtualenv', 08:14:41 INFO - 'install', 08:14:41 INFO - 'setup-mitmproxy', 08:14:41 INFO - 'run-tests'), 08:14:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:41 INFO - 'disable_ccov_upload': False, 08:14:41 INFO - 'download_minidump_stackwalk': True, 08:14:41 INFO - 'download_symbols': 'ondemand', 08:14:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:41 INFO - 'gecko_profile': False, 08:14:41 INFO - 'gecko_profile_interval': 0, 08:14:41 INFO - 'installer_path': 'installer.exe', 08:14:41 INFO - 'log_level': 'info', 08:14:41 INFO - 'log_name': 'talos', 08:14:41 INFO - 'log_to_console': True, 08:14:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:41 INFO - 'opt_config_files': (), 08:14:41 INFO - 'pip_index': False, 08:14:41 INFO - 'suite': 'dromaeojs-e10s', 08:14:41 INFO - 'system_bits': '32', 08:14:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:41 INFO - 'title': 'talos-linux64-ix-034', 08:14:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:41 INFO - 'use_talos_json': True, 08:14:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:41 INFO - 'work_dir': 'build'} 08:14:41 INFO - [mozharness: 2017-07-16 15:14:41.456072Z] Running clobber step. 08:14:41 INFO - Running pre-action listener: _resource_record_pre_action 08:14:41 INFO - Running main action method: clobber 08:14:41 INFO - rmtree: /builds/slave/test/build 08:14:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:47 INFO - Running post-action listener: _resource_record_post_action 08:14:47 INFO - [mozharness: 2017-07-16 15:14:47.543239Z] Finished clobber step (success) 08:14:47 INFO - [mozharness: 2017-07-16 15:14:47.543395Z] Running read-buildbot-config step. 08:14:47 INFO - Running pre-action listener: _resource_record_pre_action 08:14:47 INFO - Running main action method: read_buildbot_config 08:14:47 INFO - Using buildbot properties: 08:14:47 INFO - { 08:14:47 INFO - "project": "", 08:14:47 INFO - "product": "firefox", 08:14:47 INFO - "who": "archaeopteryx@coole-files.de", 08:14:47 INFO - "installer_path": "public/build/target.tar.bz2", 08:14:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:14:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:14:47 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:14:47 INFO - "stage_platform": "linux64-stylo", 08:14:47 INFO - "basedir": "/builds/slave/test", 08:14:47 INFO - "buildnumber": 203, 08:14:47 INFO - "platform": "ubuntu64_hw_stylo", 08:14:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:47 INFO - "slavebuilddir": "test", 08:14:47 INFO - "taskId": "TDRrEGtmQl-I97Pwl179xw", 08:14:47 INFO - "branch": "mozilla-central", 08:14:47 INFO - "script_repo_revision": "production", 08:14:47 INFO - "revision": "bc3f73d54feeaf0e97b30496574357f05b2d5307", 08:14:47 INFO - "slavename": "talos-linux64-ix-034", 08:14:47 INFO - "repo_path": "mozilla-central" 08:14:47 INFO - } 08:14:47 INFO - Finding installer, test and symbols from parent task. 08:14:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDRrEGtmQl-I97Pwl179xw'}, attempt #1 08:14:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDRrEGtmQl-I97Pwl179xw'}, attempt #1 08:14:48 INFO - Task dependencies: KcZaFrWRQQ6ypWymSEoK1w 08:14:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w'}, attempt #1 08:14:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2 08:14:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/test_packages.json 08:14:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.crashreporter-symbols.zip 08:14:48 INFO - Running post-action listener: _resource_record_post_action 08:14:48 INFO - [mozharness: 2017-07-16 15:14:48.899462Z] Finished read-buildbot-config step (success) 08:14:48 INFO - [mozharness: 2017-07-16 15:14:48.899681Z] Running download-and-extract step. 08:14:48 INFO - Running pre-action listener: _resource_record_pre_action 08:14:48 INFO - Running main action method: download_and_extract 08:14:48 INFO - mkdir: /builds/slave/test/build/tests 08:14:48 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')]} 08:14:48 INFO - trying https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.test_packages.json 08:14:48 INFO - Downloading https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:14:49 INFO - Downloaded 989 bytes. 08:14:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:14:49 INFO - Using the following test package requirements: 08:14:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:14:49 INFO - u'common': [u'target.common.tests.zip'], 08:14:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:14:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:14:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:14:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:14:49 INFO - u'mozbase': [u'target.common.tests.zip'], 08:14:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:14:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:14:49 INFO - u'web-platform': [u'target.common.tests.zip', 08:14:49 INFO - u'target.web-platform.tests.tar.gz'], 08:14:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:14:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:14:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.common.tests.zip 08:14:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:49 INFO - Fetch https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.common.tests.zip into memory 08:14:51 INFO - Content-Length response header: 72753072 08:14:51 INFO - Bytes received: 72753072 08:15:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:15:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.common.tests.zip 08:15:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:15:02 INFO - Fetch https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.common.tests.zip into memory 08:15:03 INFO - Content-Length response header: 72753072 08:15:03 INFO - Bytes received: 72753072 08:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.talos.tests.zip 08:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.talos.tests.zip into memory 08:15:16 INFO - Content-Length response header: 14495033 08:15:16 INFO - Bytes received: 14495033 08:15:16 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')]} 08:15:16 INFO - trying https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2 08:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:15:17 INFO - Downloaded 61922932 bytes. 08:15:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2 08:15:17 INFO - mkdir: /builds/slave/test/properties 08:15:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:15:17 INFO - Writing to file /builds/slave/test/properties/build_url 08:15:17 INFO - Contents: 08:15:17 INFO - build_url:https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2 08:15:17 INFO - Running post-action listener: _resource_record_post_action 08:15:17 INFO - Running post-action listener: set_extra_try_arguments 08:15:17 INFO - [mozharness: 2017-07-16 15:15:17.752057Z] Finished download-and-extract step (success) 08:15:17 INFO - [mozharness: 2017-07-16 15:15:17.752155Z] Running populate-webroot step. 08:15:17 INFO - Running pre-action listener: _resource_record_pre_action 08:15:17 INFO - Running main action method: populate_webroot 08:15:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:15:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:15:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:15:17 INFO - '--tppagecycles', 08:15:17 INFO - '7'], 08:15:17 INFO - 'tests': ['tsvgm']}}, 08:15:17 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:15:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:15:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:15:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:15:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['damp', 'tps']}, 08:15:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'tests': ['damp', 'tps']}, 08:15:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['dromaeo_dom']}, 08:15:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:15:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:15:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:15:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:15:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['a11yr', 08:15:17 INFO - 'ts_paint', 08:15:17 INFO - 'tpaint', 08:15:17 INFO - 'sessionrestore', 08:15:17 INFO - 'sessionrestore_no_auto_restore', 08:15:17 INFO - 'tabpaint']}, 08:15:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:15:17 INFO - 'ts_paint', 08:15:17 INFO - 'tpaint', 08:15:17 INFO - 'sessionrestore', 08:15:17 INFO - 'sessionrestore_many_windows', 08:15:17 INFO - 'sessionrestore_no_auto_restore', 08:15:17 INFO - 'tabpaint']}, 08:15:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:15:17 INFO - 'ts_paint', 08:15:17 INFO - 'tpaint', 08:15:17 INFO - 'sessionrestore', 08:15:17 INFO - 'sessionrestore_many_windows', 08:15:17 INFO - 'sessionrestore_no_auto_restore', 08:15:17 INFO - 'tabpaint']}, 08:15:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:15:17 INFO - 'ts_paint', 08:15:17 INFO - 'tpaint', 08:15:17 INFO - 'sessionrestore', 08:15:17 INFO - 'sessionrestore_many_windows', 08:15:17 INFO - 'sessionrestore_no_auto_restore', 08:15:17 INFO - 'tabpaint']}, 08:15:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['a11yr', 08:15:17 INFO - 'ts_paint', 08:15:17 INFO - 'tpaint', 08:15:17 INFO - 'sessionrestore', 08:15:17 INFO - 'sessionrestore_no_auto_restore', 08:15:17 INFO - 'tabpaint']}, 08:15:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['a11yr', 08:15:17 INFO - 'ts_paint', 08:15:17 INFO - 'tpaint', 08:15:17 INFO - 'sessionrestore', 08:15:17 INFO - 'sessionrestore_no_auto_restore', 08:15:17 INFO - 'tabpaint']}, 08:15:17 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:15:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:15:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:15:17 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:15:17 INFO - 'talos_options': ['--mitmproxy', 08:15:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:15:17 INFO - '--firstNonBlankPaint'], 08:15:17 INFO - 'tests': ['quantum_pageload_google', 08:15:17 INFO - 'quantum_pageload_youtube', 08:15:17 INFO - 'quantum_pageload_amazon', 08:15:17 INFO - 'quantum_pageload_facebook']}, 08:15:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['tsvgx', 08:15:17 INFO - 'tsvgr_opacity', 08:15:17 INFO - 'tart', 08:15:17 INFO - 'tscrollx', 08:15:17 INFO - 'cart', 08:15:17 INFO - 'tsvg_static']}, 08:15:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:15:17 INFO - 'tsvgr_opacity', 08:15:17 INFO - 'tart', 08:15:17 INFO - 'tscrollx', 08:15:17 INFO - 'cart', 08:15:17 INFO - 'tsvg_static']}, 08:15:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'talos_options': ['--disable-e10s'], 08:15:17 INFO - 'tests': ['tp5o']}, 08:15:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:15:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'talos_options': ['--disable-e10s', 08:15:17 INFO - '--xperf_path', 08:15:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:17 INFO - 'tests': ['tp5n']}, 08:15:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:15:17 INFO - 'talos_options': ['--xperf_path', 08:15:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:15:17 INFO - 'tests': ['tp5n']}}, 08:15:17 INFO - 'talos.zip': {'path': '', 08:15:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:15:17 INFO - Running post-action listener: _resource_record_post_action 08:15:17 INFO - [mozharness: 2017-07-16 15:15:17.767603Z] Finished populate-webroot step (success) 08:15:17 INFO - [mozharness: 2017-07-16 15:15:17.767693Z] Running create-virtualenv step. 08:15:17 INFO - Running pre-action listener: _resource_record_pre_action 08:15:17 INFO - Running main action method: create_virtualenv 08:15:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:15:17 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 08:15:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:15:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:15:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:15:17 INFO - Using real prefix '/usr' 08:15:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:15:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:15:20 INFO - Installing pip.................done. 08:15:20 INFO - Return code: 0 08:15:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:15:20 INFO - Reading from file tmpfile_stdout 08:15:20 INFO - Output received: 08:15:20 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) 08:15:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15: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')]} 08:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:15:20 INFO - Using env: {'DISPLAY': ':0', 08:15:20 INFO - 'HOME': '/home/cltbld', 08:15:20 INFO - 'LANG': 'en_US.UTF-8', 08:15:20 INFO - 'LANGUAGE': 'en_US:en', 08:15:20 INFO - 'LOGNAME': 'cltbld', 08:15:20 INFO - 'MAIL': '/var/mail/cltbld', 08:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:20 INFO - 'MOZ_NO_REMOTE': '1', 08:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:20 INFO - 'NO_EM_RESTART': '1', 08:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:20 INFO - 'PWD': '/builds/slave/test', 08:15:20 INFO - 'SHELL': '/bin/bash', 08:15:20 INFO - 'SHLVL': '1', 08:15:20 INFO - 'TERM': 'linux', 08:15:20 INFO - 'TMOUT': '86400', 08:15:20 INFO - 'USER': 'cltbld', 08:15:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:20 INFO - '_': '/tools/buildbot/bin/python'} 08:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:21 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 08:15:21 INFO - Cleaning up... 08:15:21 INFO - Return code: 0 08:15:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:15:21 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')]} 08:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:21 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')]} 08:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:21 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:21 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 08:15:21 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 08:15:21 INFO - Using env: {'DISPLAY': ':0', 08:15:21 INFO - 'HOME': '/home/cltbld', 08:15:21 INFO - 'LANG': 'en_US.UTF-8', 08:15:21 INFO - 'LANGUAGE': 'en_US:en', 08:15:21 INFO - 'LOGNAME': 'cltbld', 08:15:21 INFO - 'MAIL': '/var/mail/cltbld', 08:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:21 INFO - 'MOZ_NO_REMOTE': '1', 08:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:21 INFO - 'NO_EM_RESTART': '1', 08:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:21 INFO - 'PWD': '/builds/slave/test', 08:15:21 INFO - 'SHELL': '/bin/bash', 08:15:21 INFO - 'SHLVL': '1', 08:15:21 INFO - 'TERM': 'linux', 08:15:21 INFO - 'TMOUT': '86400', 08:15:21 INFO - 'USER': 'cltbld', 08:15:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:21 INFO - '_': '/tools/buildbot/bin/python'} 08:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:21 INFO - Downloading/unpacking psutil>=3.1.1 08:15: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 08:15: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 08:15: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 08:15: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 08:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:15:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:22 INFO - Installing collected packages: psutil 08:15:22 INFO - Running setup.py install for psutil 08:15:22 INFO - building 'psutil._psutil_linux' extension 08:15:22 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 08:15:23 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 08:15:23 INFO - building 'psutil._psutil_posix' extension 08:15:23 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 08:15:23 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 08:15:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:15:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:15:23 INFO - Successfully installed psutil 08:15:23 INFO - Cleaning up... 08:15:23 INFO - Return code: 0 08:15:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:15: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')]} 08:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15: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')]} 08:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:15:23 INFO - Using env: {'DISPLAY': ':0', 08:15:23 INFO - 'HOME': '/home/cltbld', 08:15:23 INFO - 'LANG': 'en_US.UTF-8', 08:15:23 INFO - 'LANGUAGE': 'en_US:en', 08:15:23 INFO - 'LOGNAME': 'cltbld', 08:15:23 INFO - 'MAIL': '/var/mail/cltbld', 08:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:23 INFO - 'MOZ_NO_REMOTE': '1', 08:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:23 INFO - 'NO_EM_RESTART': '1', 08:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:23 INFO - 'PWD': '/builds/slave/test', 08:15:23 INFO - 'SHELL': '/bin/bash', 08:15:23 INFO - 'SHLVL': '1', 08:15:23 INFO - 'TERM': 'linux', 08:15:23 INFO - 'TMOUT': '86400', 08:15:23 INFO - 'USER': 'cltbld', 08:15:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:23 INFO - '_': '/tools/buildbot/bin/python'} 08:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:15: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 08:15: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 08:15: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 08:15: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 08:15:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:15:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:15:25 INFO - Installing collected packages: mozsystemmonitor 08:15:25 INFO - Running setup.py install for mozsystemmonitor 08:15:25 INFO - Successfully installed mozsystemmonitor 08:15:25 INFO - Cleaning up... 08:15:25 INFO - Return code: 0 08:15:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:25 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:25 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 08:15:25 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 08:15:25 INFO - Using env: {'DISPLAY': ':0', 08:15:25 INFO - 'HOME': '/home/cltbld', 08:15:25 INFO - 'LANG': 'en_US.UTF-8', 08:15:25 INFO - 'LANGUAGE': 'en_US:en', 08:15:25 INFO - 'LOGNAME': 'cltbld', 08:15:25 INFO - 'MAIL': '/var/mail/cltbld', 08:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:25 INFO - 'MOZ_NO_REMOTE': '1', 08:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:25 INFO - 'NO_EM_RESTART': '1', 08:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:25 INFO - 'PWD': '/builds/slave/test', 08:15:25 INFO - 'SHELL': '/bin/bash', 08:15:25 INFO - 'SHLVL': '1', 08:15:25 INFO - 'TERM': 'linux', 08:15:25 INFO - 'TMOUT': '86400', 08:15:25 INFO - 'USER': 'cltbld', 08:15:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:25 INFO - '_': '/tools/buildbot/bin/python'} 08:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:15:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:15:26 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 08:15:26 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 08:15:26 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 08:15:26 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 08:15:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:15:26 INFO - warning: no files found matching '*.txt' 08:15:26 INFO - no previously-included directories found matching 'build' 08:15:26 INFO - no previously-included directories found matching 'dist' 08:15:26 INFO - no previously-included directories found matching '.git*' 08:15:26 INFO - Installing collected packages: jsonschema, functools32 08:15:26 INFO - Running setup.py install for functools32 08:15:27 INFO - warning: no files found matching '*.txt' 08:15:27 INFO - no previously-included directories found matching 'build' 08:15:27 INFO - no previously-included directories found matching 'dist' 08:15:27 INFO - no previously-included directories found matching '.git*' 08:15:27 INFO - Successfully installed jsonschema functools32 08:15:27 INFO - Cleaning up... 08:15:27 INFO - Return code: 0 08:15:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:15:27 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')]} 08:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:27 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')]} 08:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:27 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:27 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 08:15:27 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 08:15:27 INFO - Using env: {'DISPLAY': ':0', 08:15:27 INFO - 'HOME': '/home/cltbld', 08:15:27 INFO - 'LANG': 'en_US.UTF-8', 08:15:27 INFO - 'LANGUAGE': 'en_US:en', 08:15:27 INFO - 'LOGNAME': 'cltbld', 08:15:27 INFO - 'MAIL': '/var/mail/cltbld', 08:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:27 INFO - 'MOZ_NO_REMOTE': '1', 08:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:27 INFO - 'NO_EM_RESTART': '1', 08:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:27 INFO - 'PWD': '/builds/slave/test', 08:15:27 INFO - 'SHELL': '/bin/bash', 08:15:27 INFO - 'SHLVL': '1', 08:15:27 INFO - 'TERM': 'linux', 08:15:27 INFO - 'TMOUT': '86400', 08:15:27 INFO - 'USER': 'cltbld', 08:15:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:27 INFO - '_': '/tools/buildbot/bin/python'} 08:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:15:27 INFO - Cleaning up... 08:15:27 INFO - Return code: 0 08:15:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:15:27 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')]} 08:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:27 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')]} 08:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:27 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:27 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 08:15:27 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 08:15:27 INFO - Using env: {'DISPLAY': ':0', 08:15:27 INFO - 'HOME': '/home/cltbld', 08:15:27 INFO - 'LANG': 'en_US.UTF-8', 08:15:27 INFO - 'LANGUAGE': 'en_US:en', 08:15:27 INFO - 'LOGNAME': 'cltbld', 08:15:27 INFO - 'MAIL': '/var/mail/cltbld', 08:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:27 INFO - 'MOZ_NO_REMOTE': '1', 08:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:27 INFO - 'NO_EM_RESTART': '1', 08:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:27 INFO - 'PWD': '/builds/slave/test', 08:15:27 INFO - 'SHELL': '/bin/bash', 08:15:27 INFO - 'SHLVL': '1', 08:15:27 INFO - 'TERM': 'linux', 08:15:27 INFO - 'TMOUT': '86400', 08:15:27 INFO - 'USER': 'cltbld', 08:15:27 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:27 INFO - '_': '/tools/buildbot/bin/python'} 08:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:15:27 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 08:15:27 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 08:15:27 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 08:15:27 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 08:15:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:15:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:15:28 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 08:15:28 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 08:15:28 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 08:15:28 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 08:15:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:15:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:15:29 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 08:15:29 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 08:15:29 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 08:15:29 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 08:15:29 INFO - Downloading docopt-0.6.1.tar.gz 08:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:15:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:15:29 INFO - Running setup.py install for blobuploader 08:15:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:15:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:15:29 INFO - Running setup.py install for requests 08:15:29 INFO - Running setup.py install for docopt 08:15:29 INFO - Successfully installed blobuploader requests docopt 08:15:29 INFO - Cleaning up... 08:15:29 INFO - Return code: 0 08:15:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:29 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:29 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 08:15:29 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 08:15:29 INFO - Using env: {'DISPLAY': ':0', 08:15:29 INFO - 'HOME': '/home/cltbld', 08:15:29 INFO - 'LANG': 'en_US.UTF-8', 08:15:29 INFO - 'LANGUAGE': 'en_US:en', 08:15:29 INFO - 'LOGNAME': 'cltbld', 08:15:29 INFO - 'MAIL': '/var/mail/cltbld', 08:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:29 INFO - 'MOZ_NO_REMOTE': '1', 08:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:29 INFO - 'NO_EM_RESTART': '1', 08:15:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:29 INFO - 'PWD': '/builds/slave/test', 08:15:29 INFO - 'SHELL': '/bin/bash', 08:15:29 INFO - 'SHLVL': '1', 08:15:29 INFO - 'TERM': 'linux', 08:15:29 INFO - 'TMOUT': '86400', 08:15:29 INFO - 'USER': 'cltbld', 08:15:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:29 INFO - '_': '/tools/buildbot/bin/python'} 08:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:30 INFO - Running setup.py (path:/tmp/pip-4lSK5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:30 INFO - Running setup.py (path:/tmp/pip-GcbgEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:30 INFO - Running setup.py (path:/tmp/pip-tULjnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:30 INFO - Running setup.py (path:/tmp/pip-rtTTIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:30 INFO - Running setup.py (path:/tmp/pip-IkiK_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:30 INFO - Running setup.py (path:/tmp/pip-STb8Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:30 INFO - Running setup.py (path:/tmp/pip-MbSfuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:30 INFO - Running setup.py (path:/tmp/pip-epUCF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:30 INFO - Running setup.py (path:/tmp/pip-IMZ83Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:30 INFO - Running setup.py (path:/tmp/pip-Ypq17G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:30 INFO - Running setup.py (path:/tmp/pip-mzoXNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:30 INFO - Running setup.py (path:/tmp/pip-DuIDVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:30 INFO - Running setup.py (path:/tmp/pip-gRVX0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:31 INFO - Running setup.py (path:/tmp/pip-hf_I2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:31 INFO - Running setup.py (path:/tmp/pip-r51HSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:31 INFO - Running setup.py (path:/tmp/pip-bpHNpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:31 INFO - Running setup.py (path:/tmp/pip-z485qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:15:31 INFO - Running setup.py install for manifestparser 08:15:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:15:31 INFO - Running setup.py install for mozcrash 08:15:31 INFO - Running setup.py install for mozdebug 08:15:31 INFO - Running setup.py install for mozdevice 08:15:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:15:31 INFO - Running setup.py install for mozfile 08:15:31 INFO - Running setup.py install for mozhttpd 08:15:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:15:31 INFO - Running setup.py install for mozinfo 08:15:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Running setup.py install for mozInstall 08:15:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Running setup.py install for mozleak 08:15:32 INFO - Running setup.py install for mozlog 08:15:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Running setup.py install for moznetwork 08:15:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Running setup.py install for mozprocess 08:15:32 INFO - Running setup.py install for mozprofile 08:15:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Running setup.py install for mozrunner 08:15:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:15:32 INFO - Running setup.py install for mozscreenshot 08:15:32 INFO - Running setup.py install for moztest 08:15:32 INFO - Running setup.py install for mozversion 08:15:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:15:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:15:33 INFO - Cleaning up... 08:15:33 INFO - Return code: 0 08:15:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:33 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:33 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 08:15:33 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 08:15:33 INFO - Using env: {'DISPLAY': ':0', 08:15:33 INFO - 'HOME': '/home/cltbld', 08:15:33 INFO - 'LANG': 'en_US.UTF-8', 08:15:33 INFO - 'LANGUAGE': 'en_US:en', 08:15:33 INFO - 'LOGNAME': 'cltbld', 08:15:33 INFO - 'MAIL': '/var/mail/cltbld', 08:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:33 INFO - 'MOZ_NO_REMOTE': '1', 08:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:33 INFO - 'NO_EM_RESTART': '1', 08:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:33 INFO - 'PWD': '/builds/slave/test', 08:15:33 INFO - 'SHELL': '/bin/bash', 08:15:33 INFO - 'SHLVL': '1', 08:15:33 INFO - 'TERM': 'linux', 08:15:33 INFO - 'TMOUT': '86400', 08:15:33 INFO - 'USER': 'cltbld', 08:15:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:33 INFO - '_': '/tools/buildbot/bin/python'} 08:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:15:33 INFO - Running setup.py (path:/tmp/pip-iecV8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:15:33 INFO - Running setup.py (path:/tmp/pip-Z_RjfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:15:33 INFO - Running setup.py (path:/tmp/pip-N86cma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:15:33 INFO - Running setup.py (path:/tmp/pip-Z1egad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:15:33 INFO - Running setup.py (path:/tmp/pip-WiW4JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:15:33 INFO - Running setup.py (path:/tmp/pip-iDhew8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:15:33 INFO - Running setup.py (path:/tmp/pip-cLImmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:15:33 INFO - Running setup.py (path:/tmp/pip-H4oTmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:15:33 INFO - Running setup.py (path:/tmp/pip-ZThVWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:15:33 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)) 08:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:15:33 INFO - Running setup.py (path:/tmp/pip-kVCI4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:15:34 INFO - Running setup.py (path:/tmp/pip-F_bV5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:15:34 INFO - Running setup.py (path:/tmp/pip-3QXW4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:15:34 INFO - Running setup.py (path:/tmp/pip-H6uLFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:15:34 INFO - Running setup.py (path:/tmp/pip-X5IVDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:34 INFO - Running setup.py (path:/tmp/pip-H7zqG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:15:34 INFO - Running setup.py (path:/tmp/pip-dA6G0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:15:34 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)) 08:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:15:34 INFO - Running setup.py (path:/tmp/pip-XCxKNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:15:34 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)) 08:15:34 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)) 08:15:34 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)) 08:15:34 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)) 08:15:34 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)) 08:15:34 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)) 08:15:34 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)) 08:15:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:15:34 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 08:15:34 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 08:15:34 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 08:15:34 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 08:15:35 INFO - Downloading blessings-1.6.tar.gz 08:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:35 INFO - Installing collected packages: blessings 08:15:35 INFO - Running setup.py install for blessings 08:15:35 INFO - Successfully installed blessings 08:15:35 INFO - Cleaning up... 08:15:35 INFO - Return code: 0 08:15:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:36 INFO - Reading from file tmpfile_stdout 08:15:36 INFO - Current package versions: 08:15:36 INFO - argparse == 1.2.1 08:15:36 INFO - blessings == 1.6 08:15:36 INFO - blobuploader == 1.2.4 08:15:36 INFO - docopt == 0.6.1 08:15:36 INFO - functools32 == 3.2.3-2 08:15:36 INFO - jsonschema == 2.5.1 08:15:36 INFO - manifestparser == 1.1 08:15:36 INFO - mozInstall == 1.13 08:15:36 INFO - mozcrash == 1.0 08:15:36 INFO - mozdebug == 0.1 08:15:36 INFO - mozdevice == 0.51 08:15:36 INFO - mozfile == 1.2 08:15:36 INFO - mozhttpd == 0.7 08:15:36 INFO - mozinfo == 0.10 08:15:36 INFO - mozleak == 0.1 08:15:36 INFO - mozlog == 3.5 08:15:36 INFO - moznetwork == 0.27 08:15:36 INFO - mozprocess == 0.25 08:15:36 INFO - mozprofile == 0.28 08:15:36 INFO - mozrunner == 6.13 08:15:36 INFO - mozscreenshot == 0.1 08:15:36 INFO - mozsystemmonitor == 0.3 08:15:36 INFO - moztest == 0.8 08:15:36 INFO - mozversion == 1.4 08:15:36 INFO - psutil == 3.1.1 08:15:36 INFO - requests == 1.2.3 08:15:36 INFO - wsgiref == 0.1.2 08:15:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:36 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')]} 08:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:36 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')]} 08:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:36 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:36 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 08:15:36 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 08:15:36 INFO - Using env: {'DISPLAY': ':0', 08:15:36 INFO - 'HOME': '/home/cltbld', 08:15:36 INFO - 'LANG': 'en_US.UTF-8', 08:15:36 INFO - 'LANGUAGE': 'en_US:en', 08:15:36 INFO - 'LOGNAME': 'cltbld', 08:15:36 INFO - 'MAIL': '/var/mail/cltbld', 08:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:36 INFO - 'MOZ_NO_REMOTE': '1', 08:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:36 INFO - 'NO_EM_RESTART': '1', 08:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:36 INFO - 'PWD': '/builds/slave/test', 08:15:36 INFO - 'SHELL': '/bin/bash', 08:15:36 INFO - 'SHLVL': '1', 08:15:36 INFO - 'TERM': 'linux', 08:15:36 INFO - 'TMOUT': '86400', 08:15:36 INFO - 'USER': 'cltbld', 08:15:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:36 INFO - '_': '/tools/buildbot/bin/python'} 08:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 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)) 08:15:36 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:15:36 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 08:15:36 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 08:15:36 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 08:15:36 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 08:15:37 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:15:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:15:37 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 08:15:37 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 08:15:37 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 08:15:37 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 08:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:15:37 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)) 08:15:37 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)) 08:15:37 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)) 08:15:37 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)) 08:15:37 INFO - Installing collected packages: marionette-driver, simplejson 08:15:37 INFO - Running setup.py install for marionette-driver 08:15:37 INFO - Running setup.py install for simplejson 08:15:37 INFO - building 'simplejson._speedups' extension 08:15:37 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 08:15:38 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 08:15:38 INFO - Successfully installed marionette-driver simplejson 08:15:38 INFO - Cleaning up... 08:15:38 INFO - Return code: 0 08:15:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:38 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')]} 08:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:38 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')]} 08:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:38 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 0x13241f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1695b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', '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 08:15:38 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 08:15:38 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 08:15:38 INFO - Using env: {'DISPLAY': ':0', 08:15:38 INFO - 'HOME': '/home/cltbld', 08:15:38 INFO - 'LANG': 'en_US.UTF-8', 08:15:38 INFO - 'LANGUAGE': 'en_US:en', 08:15:38 INFO - 'LOGNAME': 'cltbld', 08:15:38 INFO - 'MAIL': '/var/mail/cltbld', 08:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:38 INFO - 'MOZ_NO_REMOTE': '1', 08:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:38 INFO - 'NO_EM_RESTART': '1', 08:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:38 INFO - 'PWD': '/builds/slave/test', 08:15:38 INFO - 'SHELL': '/bin/bash', 08:15:38 INFO - 'SHLVL': '1', 08:15:38 INFO - 'TERM': 'linux', 08:15:38 INFO - 'TMOUT': '86400', 08:15:38 INFO - 'USER': 'cltbld', 08:15:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:38 INFO - '_': '/tools/buildbot/bin/python'} 08:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:39 INFO - Cleaning up... 08:15:39 INFO - Return code: 0 08:15:39 INFO - Running post-action listener: _resource_record_post_action 08:15:39 INFO - Running post-action listener: _start_resource_monitoring 08:15:39 INFO - Starting resource monitoring. 08:15:39 INFO - [mozharness: 2017-07-16 15:15:39.163967Z] Finished create-virtualenv step (success) 08:15:39 INFO - [mozharness: 2017-07-16 15:15:39.164917Z] Running install step. 08:15:39 INFO - Running pre-action listener: _resource_record_pre_action 08:15:39 INFO - Running main action method: install 08:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:39 INFO - Reading from file tmpfile_stdout 08:15:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:39 INFO - Reading from file tmpfile_stdout 08:15:39 INFO - Output received: 08:15:39 INFO - Usage: mozinstall [options] installer 08:15:39 INFO - Options: 08:15:39 INFO - -h, --help show this help message and exit 08:15:39 INFO - -d DEST, --destination=DEST 08:15:39 INFO - Directory to install application into. [default: 08:15:39 INFO - "/builds/slave/test"] 08:15:39 INFO - --app=APP Application being installed. [default: firefox] 08:15:39 INFO - mkdir: /builds/slave/test/build/application 08:15:39 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'] 08:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:15:57 INFO - Reading from file tmpfile_stdout 08:15:57 INFO - Output received: 08:15:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:57 INFO - Running post-action listener: _resource_record_post_action 08:15:57 INFO - [mozharness: 2017-07-16 15:15:57.393792Z] Finished install step (success) 08:15:57 INFO - [mozharness: 2017-07-16 15:15:57.393902Z] Running setup-mitmproxy step. 08:15:57 INFO - Running pre-action listener: _resource_record_pre_action 08:15:57 INFO - Running main action method: setup_mitmproxy 08:15:57 INFO - Skipping: mitmproxy is not required 08:15:57 INFO - Running post-action listener: _resource_record_post_action 08:15:57 INFO - [mozharness: 2017-07-16 15:15:57.394393Z] Finished setup-mitmproxy step (success) 08:15:57 INFO - [mozharness: 2017-07-16 15:15:57.394486Z] Running run-tests step. 08:15:57 INFO - Running pre-action listener: _resource_record_pre_action 08:15:57 INFO - Running pre-action listener: _set_gcov_prefix 08:15:57 INFO - Running main action method: run_tests 08:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:57 INFO - Python 2.7.3 08:15:57 INFO - Return code: 0 08:15:57 INFO - grabbing minidump binary from tooltool 08:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:57 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 0x1692d00>, '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 0x1693c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1694090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:57 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 08:15:57 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 08:15:57 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 08:15:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:57 INFO - Return code: 0 08:15:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:57 INFO - ENV: RUST_BACKTRACE is now 1 08:15:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:57 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/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:15:57 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/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 08:15:57 INFO - Using env: {'DISPLAY': ':0', 08:15:57 INFO - 'HOME': '/home/cltbld', 08:15:57 INFO - 'LANG': 'en_US.UTF-8', 08:15:57 INFO - 'LANGUAGE': 'en_US:en', 08:15:57 INFO - 'LOGNAME': 'cltbld', 08:15:57 INFO - 'MAIL': '/var/mail/cltbld', 08:15:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:57 INFO - 'MOZ_NO_REMOTE': '1', 08:15:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:57 INFO - 'NO_EM_RESTART': '1', 08:15:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:57 INFO - 'PWD': '/builds/slave/test', 08:15:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:57 INFO - 'RUST_BACKTRACE': '1', 08:15:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:15:57 INFO - 'SHELL': '/bin/bash', 08:15:57 INFO - 'SHLVL': '1', 08:15:57 INFO - 'TERM': 'linux', 08:15:57 INFO - 'TMOUT': '86400', 08:15:57 INFO - 'USER': 'cltbld', 08:15:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430', 08:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:57 INFO - '_': '/tools/buildbot/bin/python'} 08:15:57 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/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 08:15:58 INFO - mozversion application_buildid: 20170716143035 08:15:58 INFO - mozversion application_changeset: bc3f73d54feeaf0e97b30496574357f05b2d5307 08:15:58 INFO - mozversion application_display_name: Nightly 08:15:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:58 INFO - mozversion application_name: Firefox 08:15:58 INFO - mozversion application_remotingname: firefox 08:15:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:15:58 INFO - mozversion application_vendor: Mozilla 08:15:58 INFO - mozversion application_version: 56.0a1 08:15:58 INFO - mozversion platform_buildid: 20170716143035 08:15:58 INFO - mozversion platform_changeset: bc3f73d54feeaf0e97b30496574357f05b2d5307 08:15:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:15:58 INFO - mozversion platform_version: 56.0a1 08:15:58 INFO - using testdate: 1500218158 08:15:58 INFO - actual date: 1500218158 08:15:58 INFO - starting webserver on 'localhost:51158' 08:15:58 INFO - SUITE-START | Running 2 tests 08:15:58 INFO - TEST-START | dromaeo_css 08:15:58 INFO - Initialising browser for dromaeo_css test... 08:15:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51158/getInfo.html -profile /tmp/tmpj0IU0y/profile 08:15:58 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox http://localhost:51158/getInfo.html) 08:16:05 INFO - TEST-INFO | 3333: exit 0 08:16:05 INFO - Browser initialized. 08:16:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:05 INFO - TEST-INFO | started process 3555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj0IU0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:17 INFO - PID 3555 | RSS: Main: 173207552 08:16:17 INFO - PID 3555 | 08:19:15 INFO - PID 3555 | Cycle 1(1): loaded http://localhost:51158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51158/tests/dromaeo/cssquery-ext.html) 08:19:16 INFO - PID 3555 | RSS: Main: 178192384 08:19:16 INFO - PID 3555 | 08:22:18 INFO - PID 3555 | Cycle 1(1): loaded http://localhost:51158/tests/dromaeo/cssquery-ext.html (next: http://localhost:51158/tests/dromaeo/cssquery-jquery.html) 08:22:19 INFO - PID 3555 | RSS: Main: 176754688 08:22:19 INFO - PID 3555 | 08:25:20 INFO - PID 3555 | Cycle 1(1): loaded http://localhost:51158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51158/tests/dromaeo/cssquery-mootools.html) 08:25:21 INFO - PID 3555 | RSS: Main: 178909184 08:25:21 INFO - PID 3555 | 08:28:23 INFO - PID 3555 | Cycle 1(1): loaded http://localhost:51158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51158/tests/dromaeo/cssquery-prototype.html) 08:28:23 INFO - PID 3555 | RSS: Main: 177463296 08:28:23 INFO - PID 3555 | 08:31:27 INFO - PID 3555 | Cycle 1(1): loaded http://localhost:51158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51158/tests/dromaeo/cssquery-yui.html) 08:31:27 INFO - PID 3555 | RSS: Main: 177098752 08:31:27 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | Cycle 1(1): loaded http://localhost:51158/tests/dromaeo/cssquery-yui.html (next: http://localhost:51158/tests/dromaeo/cssquery-dojo.html) 08:34:29 INFO - PID 3555 | RSS: Main: 180117504 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | __start_tp_report 08:34:29 INFO - PID 3555 | _x_x_mozilla_page_load 08:34:29 INFO - PID 3555 | _x_x_mozilla_page_load_details 08:34:29 INFO - PID 3555 | |i|pagename|runs| 08:34:29 INFO - PID 3555 | |0;dojo.html;3097.8296193709366;3115.314630781228;3160.051984404678;3165.3985742708883;3174.682531746824;5918.082697181938;5954.047352423613;5958.970205148974;5988.101784732287;6043.909341359883;5995.190649262348;6020.819375418733;6024.48791852693;6024.578279520435;6034.306054803699;5532.806351777678;5543.891221755644;5549.722513874311;5554.472325129126;5561.5272701820395;5515.917261241085;5545.3622833374275;5545.77816887324;5555.2222688823595;5565.471280228372;5536.501714845663;5540.722963851791;5542.75057622408;5557.416471270519;5561.388247292794;5559.138333558305;5564.554835613182;5568.888622227532;5576.163575463693;5591.776328946838;5497.065498865202;5521.696306703129;5542.334919809608;5547.750351234205;5653.038983372837;6003.039513677791;6025.126356678301;6070.180525629072;6109.4501494865235;6134.754609815602;6450.225972883284;6456.289808121103;6501;6515.120458738057;6551.475881929434;6349.36506349366;6382.744690212386;6441.935580644227;6443.29123796382;6471.352864713538;6055.697215139226;6057.848553786146;6059.333473317932;6064.363241859585;6087.452129308339;6604.702788374487;6643.70103345341;6648.83377915556;6664.566803157779;6714.630695311805;6279.403456671609;6320.873582528324;6347.301796802348;6383.329750376237;6432.6462044588;6445;6450.80647580564;6506.446952009038;6527.314631963671;6553.475721942234;6275.780347687901;6376.458001069961;6387.616742995342;6437.678116094176;6451.645159516272;5912.733926973297;6427.164468619049;6466.967665161644;6496.512761542903;6502.967485162544;5184.662996905189;5243.737813109329;5254.028004819121;5257.027449921777;5259.737013149327;4387.188370151468;4475;4475.641948644101;4482.798274077674;4519.344695019269;5520.834374968757;5530.6128570999645;5559.110542313291;5571.275734154534;5573.69344686038;6489.253735820346;6502.414782669583;6513.967430162914;6515;6553.868922621521;5446.183072539151;5505.03661859173;5507.421720719347;5532.3637781655625;5551.056320425457;5699.202111704365;5729.856753581111;5731.942680573225;5734.111212761945;5752.165935939265;5319.255304257407;6266.467350275278;6266.686665666698;6272.996320588684;6399.296077431479;6500.122483464766;6515.804525864231;6606.900896486461;6624.039514270404;6628.138342015507;6283.59156654816;6293.150424692608;6302.810915672537;6380.585261957958;6413.935860641333;6334.809955701337;6354.872902542016;6451.870962580816;6503.057056726842;6512.739490420519;6600.702968366339;6610.438112760469;6645.368689974444;6645.933540664531;6648.1025061616065;6340;6342.270638876588;6384.6169229846355;6401.839954001187;6431.260405053479;6301.054841773771;6324;6378.394052564999;6438.356164383524;6438.517111216771;5887.793927212527;6035.1249068885645;6037.969810150921;6236.563440559117;6337.176167098248;6285.874282514233;6288.371162883675;6300.306966233619;6306.432421082125;6333.936660633519;5189.247559103985;6082.148499210202;6144.938550614436;6169.81490555284;6214.782482613267 08:34:29 INFO - PID 3555 | |1;ext.html;810.6473683947484;839.3830534557103;862.1206369503107;883.1168831168835;888.7289376740093;39185.21629567411;39485;39571.604283957226;39985.4002189967;40060.39909401358;36134.8193259034;36326.45510317347;36661.08347291319;36694;36724;6697.899531507019;6778.389944904958;6817.454603631722;6824.4199243064395;6829;6759.256481787;6808.6255255960905;6833.897491537631;6844.589324640513;6858.794236172897;6733.360330768569;6772.8306792330095;6834.2482326944;6845;6849.2465828758795;6749.662516874137;6766.695498702546;6802.829929251809;6809.3190680932;6815.931840681579;6150.354212807681;6202.162708034402;6204.9689751551405;6211.19254496917;6216.906746398808;32668.673313267038;32703.691852326116;32752.6724732752;32759.6724032759;32944.505832412535;3330.467125259947;3365.5793025871767;3386.6444023377685;3391.270876761508;3396.2528243786574;26006.34984125393;28439.85780071107;29240.41519169626;30801.537976930365;30893;4743.454502732196;4791.808327666924;4855.757212139379;4867.318575399447;4928.605711543068;180375;181297;183167;183918;184873.99999999866;47237.52762472331;47855;47926.760366197945;47988;48226.517734822206;50088;50159;50219;50345.748271259145;50358;15653.37386504527;15757.44848930282;15795;15906.363745450284;15993.920030399773;13296.069275150647;13313.933430332787;13315.40080696371;13315.866841331463;13320.067595268238;14035.298235088205;14089.295535223198;14101.647458813406;14110.294485275901;14198.290085495684;5638.35158956717;5807.88384232313;5809.348296200827;5817.632856278771;5822.126680997884;1006.4011912911806;1007.2395341517108;1011.4487604255551;1036.3937096798306;1054.3305001324215;22221.22225722092;22268.220612278492;22275.77724222737;22985.425364366023;23387.88306058493;1096.5613754498265;1102.8841971593029;1114.5987444519967;1131.6378758797107;1137.3119262846024;11780.293182409083;11800.542416144706;11980.101492387932;12000.759984800256;12366.62900112998;228095;230095;230350;230575;231373;50702.239466408035;50737.23894141591;50753.746231268604;50901.745491272304;51344.229836552484;1419.5883193873867;1435.850619936217;1473.8599833015846;1479.8224213094281;1496.8128983877016;21665.494345420637;22003.818492981394;22168.00487956092;22790.430239244153;23096.076156953535;35158.64841351554;35318;35418.8229058853;35526.111847204025;35665;185691;187477;188026;188093.05953470146;188551;33176.834115830236;34958;35470.822645886605;37015.25969480649;37365.626343736214;44457;45699.771501142284;45738.54261457476;45991.77004114958;46365;30702;32753;32827.67172328246;32881.50677739788;32913.177170570925;31798.52302215515;32502.512462313556;32529.837350813094;32568.67431325751;32801.50797737988;35874.4618830723;36448.81775591105;36472.63527364693;36522.8173859129;37374.252514949;31480;32370.676293236767;32478.188045299055;33004.17489562684;33156.66843331536;22583;23770.217233707197;23966.52066958686;24119.03523859026;24273 08:34:29 INFO - PID 3555 | |2;jquery.html;562.4403718300289;568.3293713418165;570.60913274407;587.1017343464498;601.8705978214683;21216.681749773747;22097;22352.441188970282;22397.104115835387;22841.08635654572;24770.87614561929;26660.600090998603;26691.06581269656;26886.865565672146;26970.730292697066;6564.5076619253505;6617.305182955793;6653.168353955755;6714.56355336904;6718.563293385939;3960.3069462843887;6480.546361754679;6609.834754131137;6626.039224312472;6642.468602511787;5165.948340516603;6561.409473147416;6587.538872278942;6590.242122155942;6598.67006649668;6529.902051469232;6583.275839657634;6585.506087043467;6620.966895165518;6628.43658289046;6063.878722425571;6103.633781973052;6109.175261339707;6118.265808103011;6134.69326533676;28575;29851.10446686603;30358.54462183069;30560.69439305601;31045;1898.6392585408728;1953.7557805274341;1953.9413817585496;1955.4622478818296;1958.128632758423;18605.62788744231;19127.80872191274;19279.4216173515;19309.710354344697;19368.225270989144;2243.1588154442084;2272.8068114210314;2301.6547517872286;2307.0541078157876;2367.763223677636;133715.33142334226;135907.96138057936;137327.31336343355;139039;139386;14189.92905035489;14672.853271467362;14736;14929.626759331104;15813.130277834829;23721.88139059328;23837;23850.88074559616;23869.04523819028;23893.163739269043;9915.603375865028;9919.462483315097;10022.599096036078;10022.849657255147;10078.143357814668;9009.324300677345;9108.726738197865;9139.588718507683;9152.940588367564;9267.212286955684;7734.7679569613;9003.864942025875;9288.11762882525;9357.812843743088;9489.762755931019;2693.676758788958;2721.700612932576;2757.931051723723;2837.4750671125908;2895.5222388306115;934.9205317548085;938.1228551304553;951.1487218939011;971.7446554043896;989.7970915962211;19514.70727939082;19741;19900.402987910387;20253.29113481021;23309.53380932372;1001.1890368801148;1042.6246551241547;1049.9105982199292;1064.7763969566322;1072.5495291977388;11153.776924461465;11436.542538298541;11535.480903359368;11695.707607309716;11695.824562631567;452196.8110887374;456926.9892388676;458084;467226;494217;109322;112084;114782;115770.42114789372;115798;1253.3607859991287;1297.4939773488347;1306.9934650326877;1307.9607611771662;1315.335755443495;16862.24119914582;17873.463796086136;17892.642147157243;18702.345417910306;18962.43112706621;55762.88474230574;55929.720351397984;56792;57035.429645703014;57685.711571441876;69147;69822.30177698362;70191.64904175447;70333;70918.6454067747;14087.506937257147;14817.110973341634;15200.619984500476;15206.847931520542;15241.6189595261;23600.17399391013;23749.406264842826;23915.804209789094;23943.401414964766;24138.63792043156;18447.446576602724;18481;18576.25694972186;18649;18772;16102.758458622895;16334.346626134822;16930.492085237463;16990.57523561921;17397.217125229647;19420.611587767882;19627.70558441596;19640.312589059315;19691.803081968996;19718.704219437008;14886.25568721538;15004.549863504113;15024.924875375553;21528.246511372028;22503.09987600543;19783.109760060543;19882.701759473908;20081.598368032264;20113.195472181535;20153.093110810343 08:34:29 INFO - PID 3555 | |3;mootools.html;1308.6335825968729;1358.7893876449148;1362.6933939863538;1363.7477066742654;1372.3207012528794;13233.867661323384;13801.102928309665;13875.098118622282;13903.791443128335;14002.78995815061;13899.791503127435;14162.079464834778;14179.220142892136;14184.716305673906;14220.928895355535;2648.4570663014083;2705.6347393101973;2720.2519307190482;2722.7005029446846;2724.4687285979244;2593.23499567628;2657.070025491072;2657.428652839639;2661.1484325016004;2661.707212206665;2632.3419145213697;2642.1677171690953;2665.6667916510437;2666.4667066586762;2669.359353755104;2572.241188849294;2602.1022747152297;2602.1673064619235;2604.6744156980376;2606.4005278785794;2454.63180522923;2478.1574264749893;2482.8510289382516;2486.9378265543323;2498.5252801967567;13207.471701131943;13541.932290338584;13542.187468751808;13542.661433464144;13550.796738048937;7224.67488962998;7564.092308922909;7586.8482630347635;7597.240275972414;7597.696092156307;5080.415752188472;5095.108356037678;5204.739763011834;5260.710660913648;5272.156454967225;1817.500187448449;1836.7887692915351;1853.7682789651294;1862.5995410986568;1905.2950408349;20733.377998660064;21205.78794212038;22188.112475500962;22409.21567745121;22431.55136897253;5718.342390625048;6386.680665966683;6598.670066496656;6641.734330626818;6645.036469711865;15605.921970390076;15652.4521641742;15664.92167539155;15684.294206760494;15690.293936772872;6975.79072627822;7525.2098529654695;7529.548227106282;7530.058742657168;7541.7360392386;6787.524873258923;6927.341902519353;7010.649467526603;7011.1586609607175;7056.1179852518435;4979.45226025137;5137.255098010843;5148.2277658350795;5155.200943853709;5176.637635365489;1478.7116512280002;1502.1738044075714;1527.8624923756693;1528.3657282227973;1534.232883558221;860.3418384935529;866.3762091294258;887.4675194883148;899.1682693508478;911.9133682300171;7358.264173582599;7445.10658720957;7888.290053895063;8324.66701331952;8526.87209691855;969.4231932000448;975.6341371985505;998.5356809083811;1018.3889666200221;1031.293563908725;5039.319691841628;5057.848264552069;5080.252614762517;5093.643444958891;5298.655587386885;17127.486175414757;17738.467845964642;17759.644807103785;18108.637827243383;18410.81589184118;17750.822491774918;18497.982610956526;18506.259749610133;18511.53721156982;18548.721769173473;10355.94822025885;10445.895541044492;10498.580056797642;10528.684139475828;10532.315399499008;7121;7913.44605877583;7919.16848730875;7947.801304967422;7959.880601791094;15853.682926341178;16351.100689462193;16382.75425868589;16746.1626918656;16750.497485075466;15790.289436975594;16196.190190490664;16600;16709.331626734795;16923.15384230759;9858.654947076819;10068.496575171359;10198;10201.795964080826;10208.744781380525;12149.57476488354;12388.62834114978;12704.936475317565;13239.3380330985;13279.402426891007;10703.036726694634;10754.677359679223;10958.342499450058;10972.122230221403;11158.163137764537;9720.513974301399;10104.09063184317;10174.491275436347;10210.387376757419;10226.846597301195;9157.084291570789;9292.535373231176;9301.488418137067;9310.674126405544;9382.906170938204;6952.687129079102;7059.435245180476;7069.293070692889;7115.430765538848;7150.821229469097;7275.163356214103;7372.852542949004;7412.703491860265;7457.515261507984;7520.059992500937 08:34:29 INFO - PID 3555 | |4;prototype.html;493.4454980529712;493.6364880451993;522.4227228912055;524.5384062025418;526.5839986410735;5934.317553481351;5992.670403127831;6011.879762404755;6020.729067191976;6044.395560443953;5774.5091667208335;5946.762129514825;5987.982043052681;5999.370066143058;6031.909521357183;4897.730624815634;4919.877003074916;4924.679895806779;4927.581155601778;4939.209726443752;4853.563179313861;4857.125717370872;4860.222364421693;4861.100696371165;4871.902561948759;4803.2795080738;4811.278308253755;4855.514448555152;4874.53691899269;4895;4664;4831.9275210871865;4834.468208497063;4840.322354870321;4870.537298956593;4311.771145223596;4353.434053573047;4356.368326592658;4356.8257269709175;4384.517703052662;5771.163181338682;5779.219805326269;5787.942120578782;5871.765129394819;5880.353161152269;5478.726063696799;5481.205225242357;5501.394846566875;5532.972335138339;5535.501804837584;6078.908816367758;6274.403931626488;6325.652089135096;6329.303776584572;6347.460465860408;4722.598579120779;4746.596539294164;4784.952150478485;4791.233402655558;4815.157347464215;6640.302768209317;6647.66761661915;6652.966735166342;6726.495512836508;6770.086038384854;4912.926306105412;4930;4931.013797240495;4936.716453721986;4957.355543779286;4905.583025442806;4944.802207911644;4990.126727822617;4990.3762029746285;4994.975025124923;5459.153831156177;5459.225751630656;5467.125259958388;5504.559635229172;5533.253010843565;6352.491800656029;6364.64994425311;6372.904406433907;6375.585586936927;6375.939549016405;1699.7195462748755;1728.8271172882612;1732.6707925494115;1746.6943284925087;1746.7117925542398;1119.4290911635126;1211.2187638972814;1229.9877001230052;1233.2292317301687;1237;5319.946800532022;5467.589930755209;5477.411550650347;5546.55627549795;5558.305211848519;6385.733064762036;6587.80236592903;6600.73597056122;6603;6642.96678516614;5451.836444906659;5527.186241493357;5532.2531458253425;5552.805651802168;5615.2700148981185;3440.6559344065895;3463.740219483549;3467.6705712957228;3469.6356882527475;3470.392681280766;6273.529485288622;6279.937200627935;6316.968415157987;6372.617642941438;6376.489880809524;6688.331166883273;6695.564788288746;6742.0224067509935;6774.153230846145;6796.592204467748;6291.528135389955;6328.208973878265;6336.968315158487;6372.107904893319;6418.839529011719;6551.508636852351;6569.9343006571235;6603.20761508622;6622.271550129578;6625.900611490928;6487.448566871869;6521.576097553644;6556.18047744032;6563.212414510289;6610.768623098168;6312.43188113072;6315.242170939517;6388.68056597159;6393.392627700361;6394.584352017104;4878.170710979071;4885.218365061573;4887.120318342732;4902.14212512816;4912.361393018885;6507.349265073644;6549.148610680581;6557.83577428346;6565.704543295658;6571.080048793268;6203.7828675996125;6317.842053948688;6389.744410223539;6390.233172019387;6399.968000159969;6337.4016653171975;6369.394907483782;6370.29926708071;6374.936250637435;6396.744130234924;6247.625142491465;6268.088233088952;6281.183446151971;6310.6213627182515;6319.399657032574;6353.777617783356;6360.363963603602;6376;6388.520860935356;6418.807435776934;5829.737661805144;5831.912521312099;5969.791057312973;6087.878242435215;6207.875842483035 08:34:29 INFO - PID 3555 | |5;yui.html;920.9907900920992;931.3387494878635;939.3800091939313;945.6501094594996;957.6169532187126;17490.47528574143;18192.545186370346;18447.72328415075;18473.445796626107;18497.907510462446;18998.52503687405;19878.105485253163;20511.589768204663;20585.588288234263;20733;1010.3382284603597;1054.8417737339385;1055.4247934875473;1055.6780182044474;1055.7360659835042;1049.7008352619466;1063.3354153653966;1064.084886997182;1066.3495267886622;1070.7911957168355;1013.6923368854169;1109.1902910875067;1120.675004248767;1121.1871393239917;1121.2935850414228;1042.8644276244077;1086.3536195963388;1089.6730980705756;1092.5684354679897;1095.4741723972459;786.2805532937356;786.6224212378033;793.3851265269404;797.9002624671916;800.087899794235;18093.276268949227;18179.27282908682;18619.813801861943;18882.433526994213;18894.716579251322;19859.50351241216;20187.293444729363;20232.69650955237;20615.79384206169;20741;15143.697126057417;15744.685106297924;15823.20883955809;15826.604334891605;15852.841471585252;3506.4389697648508;3524.6475352464804;3525.2420729543273;3537.8584856605703;3564.144605294711;106138.46930765297;106295;109167;110049;111841.44079279715;15138.772918406232;15520.689586208213;15532.844671553139;15536.844631553766;15698.136602486973;26327.47345053088;27972.16083517498;27981.44037119246;27988.16035518938;28235.717642823718;7628.389728821681;7772.961135194401;7868.370530357558;7870.252326029018;7871.33093687043;4063.9796801015805;4088.856890008895;4097.733647312915;4175.97912010438;4181.728187667792;4931.211006238985;5040.647154699209;5044.218146187347;5048.066107770001;5083.822066227664;905.2712566384124;941.1811723800338;963.802420503795;984.699666601679;991.8710567626307;589.7909285963757;663.890458074422;680.8161796314968;680.9829754256084;701.5895701014862;10619.734506637242;11104.833427498594;11391.943040284912;11505;11527.060931012826;648.3646026893576;683.5112894280613;689.7310049080862;695.7530076822655;708.6810935079131;5003.7998480061115;5072.188449848007;5117.795288188431;5213.452587478336;5249.47505249472;95510.52244738732;98030;98290.5085474568;104847.95152048382;106711.46644266728;80110.59944700239;82270.58864705639;89548;89737.55131224303;90495;75374.24625753672;76416.23583764091;79521;79915.60042199751;82129.17870821335;11722.413879306172;12158.270503769802;12656.557020504239;12713.364331783188;12740.044496662973;32873.34253314872;35156.824215878754;35211.29577408489;35306.82346588251;35651.57393704223;42453.5754642462;43588.56411435845;44151.33772993472;44713.32930005987;46333;17092.316307347566;17176.65646687084;17177.055261960213;17317.653646927243;17449.738253926454;17176.22706978164;18102.90948545249;18133;18157.54606134857;18540.907295463436;15889.443869464514;16910.32358705638;16945.745813812555;18171.273149073888;18334.449966501026;18651.720224196375;18855.15151818144;19072.61854762925;19106.808931910502;19626.50933726611;16762.245698943334;17528.91235543814;18022.909885451012;18115.54711132232;18315.54211144732;13724.588262352145;13809.79285310701;14195.858041419866;14381.209033503257;14496.927515362355;13619.319034048456;14464.421423142956;14492.710145797237;14576.927115364355;14837.258137092886 08:34:29 INFO - PID 3555 | __end_tp_report 08:34:29 INFO - PID 3555 | __start_cc_report 08:34:29 INFO - PID 3555 | _x_x_mozilla_cycle_collect,380 08:34:29 INFO - PID 3555 | __end_cc_report 08:34:29 INFO - PID 3555 | __startTimestamp1500219269647__endTimestamp 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | ------- Summary: start ------- 08:34:29 INFO - PID 3555 | Number of tests: 6 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | [#0] dojo.html Cycles:165 Average:5951.92 Median:6144.94 stddev:701.85 (11.4%) stddev-sans-first:667.34 08:34:29 INFO - PID 3555 | Values: 3097.8 3115.3 3160.1 3165.4 3174.7 5918.1 5954.0 5959.0 5988.1 6043.9 5995.2 6020.8 6024.5 6024.6 6034.3 5532.8 5543.9 5549.7 5554.5 5561.5 5515.9 5545.4 5545.8 5555.2 5565.5 5536.5 5540.7 5542.8 5557.4 5561.4 5559.1 5564.6 5568.9 5576.2 5591.8 5497.1 5521.7 5542.3 5547.8 5653.0 6003.0 6025.1 6070.2 6109.5 6134.8 6450.2 6456.3 6501.0 6515.1 6551.5 6349.4 6382.7 6441.9 6443.3 6471.4 6055.7 6057.8 6059.3 6064.4 6087.5 6604.7 6643.7 6648.8 6664.6 6714.6 6279.4 6320.9 6347.3 6383.3 6432.6 6445.0 6450.8 6506.4 6527.3 6553.5 6275.8 6376.5 6387.6 6437.7 6451.6 5912.7 6427.2 6467.0 6496.5 6503.0 5184.7 5243.7 5254.0 5257.0 5259.7 4387.2 4475.0 4475.6 4482.8 4519.3 5520.8 5530.6 5559.1 5571.3 5573.7 6489.3 6502.4 6514.0 6515.0 6553.9 5446.2 5505.0 5507.4 5532.4 5551.1 5699.2 5729.9 5731.9 5734.1 5752.2 5319.3 6266.5 6266.7 6273.0 6399.3 6500.1 6515.8 6606.9 6624.0 6628.1 6283.6 6293.2 6302.8 6380.6 6413.9 6334.8 6354.9 6451.9 6503.1 6512.7 6600.7 6610.4 6645.4 6645.9 6648.1 6340.0 6342.3 6384.6 6401.8 6431.3 6301.1 6324.0 6378.4 6438.4 6438.5 5887.8 6035.1 6038.0 6236.6 6337.2 6285.9 6288.4 6300.3 6306.4 6333.9 5189.2 6082.1 6144.9 6169.8 6214.8 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | [#1] ext.html Cycles:180 Average:36492.15 Median:18253.65 stddev:52202.16 (286.0%) stddev-sans-first:52279.85 08:34:29 INFO - PID 3555 | Values: 810.6 839.4 862.1 883.1 888.7 39185.2 39485.0 39571.6 39985.4 40060.4 36134.8 36326.5 36661.1 36694.0 36724.0 6697.9 6778.4 6817.5 6824.4 6829.0 6759.3 6808.6 6833.9 6844.6 6858.8 6733.4 6772.8 6834.2 6845.0 6849.2 6749.7 6766.7 6802.8 6809.3 6815.9 6150.4 6202.2 6205.0 6211.2 6216.9 32668.7 32703.7 32752.7 32759.7 32944.5 3330.5 3365.6 3386.6 3391.3 3396.3 26006.3 28439.9 29240.4 30801.5 30893.0 4743.5 4791.8 4855.8 4867.3 4928.6 180375.0 181297.0 183167.0 183918.0 184874.0 47237.5 47855.0 47926.8 47988.0 48226.5 50088.0 50159.0 50219.0 50345.7 50358.0 15653.4 15757.4 15795.0 15906.4 15993.9 13296.1 13313.9 13315.4 13315.9 13320.1 14035.3 14089.3 14101.6 14110.3 14198.3 5638.4 5807.9 5809.3 5817.6 5822.1 1006.4 1007.2 1011.4 1036.4 1054.3 22221.2 22268.2 22275.8 22985.4 23387.9 1096.6 1102.9 1114.6 1131.6 1137.3 11780.3 11800.5 11980.1 12000.8 12366.6 228095.0 230095.0 230350.0 230575.0 231373.0 50702.2 50737.2 50753.7 50901.7 51344.2 1419.6 1435.9 1473.9 1479.8 1496.8 21665.5 22003.8 22168.0 22790.4 23096.1 35158.6 35318.0 35418.8 35526.1 35665.0 185691.0 187477.0 188026.0 188093.1 188551.0 33176.8 34958.0 35470.8 37015.3 37365.6 44457.0 45699.8 45738.5 45991.8 46365.0 30702.0 32753.0 32827.7 32881.5 32913.2 31798.5 32502.5 32529.8 32568.7 32801.5 35874.5 36448.8 36472.6 36522.8 37374.3 31480.0 32370.7 32478.2 33004.2 33156.7 22583.0 23770.2 23966.5 24119.0 24273.0 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | [#2] jquery.html Cycles:180 Average:34220.21 Median:12808.29 stddev:78737.09 (614.7%) stddev-sans-first:78917.41 08:34:29 INFO - PID 3555 | Values: 562.4 568.3 570.6 587.1 601.9 21216.7 22097.0 22352.4 22397.1 22841.1 24770.9 26660.6 26691.1 26886.9 26970.7 6564.5 6617.3 6653.2 6714.6 6718.6 3960.3 6480.5 6609.8 6626.0 6642.5 5165.9 6561.4 6587.5 6590.2 6598.7 6529.9 6583.3 6585.5 6621.0 6628.4 6063.9 6103.6 6109.2 6118.3 6134.7 28575.0 29851.1 30358.5 30560.7 31045.0 1898.6 1953.8 1953.9 1955.5 1958.1 18605.6 19127.8 19279.4 19309.7 19368.2 2243.2 2272.8 2301.7 2307.1 2367.8 133715.3 135908.0 137327.3 139039.0 139386.0 14189.9 14672.9 14736.0 14929.6 15813.1 23721.9 23837.0 23850.9 23869.0 23893.2 9915.6 9919.5 10022.6 10022.8 10078.1 9009.3 9108.7 9139.6 9152.9 9267.2 7734.8 9003.9 9288.1 9357.8 9489.8 2693.7 2721.7 2757.9 2837.5 2895.5 934.9 938.1 951.1 971.7 989.8 19514.7 19741.0 19900.4 20253.3 23309.5 1001.2 1042.6 1049.9 1064.8 1072.5 11153.8 11436.5 11535.5 11695.7 11695.8 452196.8 456927.0 458084.0 467226.0 494217.0 109322.0 112084.0 114782.0 115770.4 115798.0 1253.4 1297.5 1307.0 1308.0 1315.3 16862.2 17873.5 17892.6 18702.3 18962.4 55762.9 55929.7 56792.0 57035.4 57685.7 69147.0 69822.3 70191.6 70333.0 70918.6 14087.5 14817.1 15200.6 15206.8 15241.6 23600.2 23749.4 23915.8 23943.4 24138.6 18447.4 18481.0 18576.3 18649.0 18772.0 16102.8 16334.3 16930.5 16990.6 17397.2 19420.6 19627.7 19640.3 19691.8 19718.7 14886.3 15004.5 15024.9 21528.2 22503.1 19783.1 19882.7 20081.6 20113.2 20153.1 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | [#3] mootools.html Cycles:180 Average:8473.55 Median:2582.74 stddev:5633.19 (218.1%) stddev-sans-first:5623.27 08:34:29 INFO - PID 3555 | Values: 1308.6 1358.8 1362.7 1363.7 1372.3 13233.9 13801.1 13875.1 13903.8 14002.8 13899.8 14162.1 14179.2 14184.7 14220.9 2648.5 2705.6 2720.3 2722.7 2724.5 2593.2 2657.1 2657.4 2661.1 2661.7 2632.3 2642.2 2665.7 2666.5 2669.4 2572.2 2602.1 2602.2 2604.7 2606.4 2454.6 2478.2 2482.9 2486.9 2498.5 13207.5 13541.9 13542.2 13542.7 13550.8 7224.7 7564.1 7586.8 7597.2 7597.7 5080.4 5095.1 5204.7 5260.7 5272.2 1817.5 1836.8 1853.8 1862.6 1905.3 20733.4 21205.8 22188.1 22409.2 22431.6 5718.3 6386.7 6598.7 6641.7 6645.0 15605.9 15652.5 15664.9 15684.3 15690.3 6975.8 7525.2 7529.5 7530.1 7541.7 6787.5 6927.3 7010.6 7011.2 7056.1 4979.5 5137.3 5148.2 5155.2 5176.6 1478.7 1502.2 1527.9 1528.4 1534.2 860.3 866.4 887.5 899.2 911.9 7358.3 7445.1 7888.3 8324.7 8526.9 969.4 975.6 998.5 1018.4 1031.3 5039.3 5057.8 5080.3 5093.6 5298.7 17127.5 17738.5 17759.6 18108.6 18410.8 17750.8 18498.0 18506.3 18511.5 18548.7 10355.9 10445.9 10498.6 10528.7 10532.3 7121.0 7913.4 7919.2 7947.8 7959.9 15853.7 16351.1 16382.8 16746.2 16750.5 15790.3 16196.2 16600.0 16709.3 16923.2 9858.7 10068.5 10198.0 10201.8 10208.7 12149.6 12388.6 12704.9 13239.3 13279.4 10703.0 10754.7 10958.3 10972.1 11158.2 9720.5 10104.1 10174.5 10210.4 10226.8 9157.1 9292.5 9301.5 9310.7 9382.9 6952.7 7059.4 7069.3 7115.4 7150.8 7275.2 7372.9 7412.7 7457.5 7520.1 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | [#4] prototype.html Cycles:180 Average:5354.22 Median:5851.84 stddev:1495.65 (25.6%) stddev-sans-first:1454.67 08:34:29 INFO - PID 3555 | Values: 493.4 493.6 522.4 524.5 526.6 5934.3 5992.7 6011.9 6020.7 6044.4 5774.5 5946.8 5988.0 5999.4 6031.9 4897.7 4919.9 4924.7 4927.6 4939.2 4853.6 4857.1 4860.2 4861.1 4871.9 4803.3 4811.3 4855.5 4874.5 4895.0 4664.0 4831.9 4834.5 4840.3 4870.5 4311.8 4353.4 4356.4 4356.8 4384.5 5771.2 5779.2 5787.9 5871.8 5880.4 5478.7 5481.2 5501.4 5533.0 5535.5 6078.9 6274.4 6325.7 6329.3 6347.5 4722.6 4746.6 4785.0 4791.2 4815.2 6640.3 6647.7 6653.0 6726.5 6770.1 4912.9 4930.0 4931.0 4936.7 4957.4 4905.6 4944.8 4990.1 4990.4 4995.0 5459.2 5459.2 5467.1 5504.6 5533.3 6352.5 6364.6 6372.9 6375.6 6375.9 1699.7 1728.8 1732.7 1746.7 1746.7 1119.4 1211.2 1230.0 1233.2 1237.0 5319.9 5467.6 5477.4 5546.6 5558.3 6385.7 6587.8 6600.7 6603.0 6643.0 5451.8 5527.2 5532.3 5552.8 5615.3 3440.7 3463.7 3467.7 3469.6 3470.4 6273.5 6279.9 6317.0 6372.6 6376.5 6688.3 6695.6 6742.0 6774.2 6796.6 6291.5 6328.2 6337.0 6372.1 6418.8 6551.5 6569.9 6603.2 6622.3 6625.9 6487.4 6521.6 6556.2 6563.2 6610.8 6312.4 6315.2 6388.7 6393.4 6394.6 4878.2 4885.2 4887.1 4902.1 4912.4 6507.3 6549.1 6557.8 6565.7 6571.1 6203.8 6317.8 6389.7 6390.2 6400.0 6337.4 6369.4 6370.3 6374.9 6396.7 6247.6 6268.1 6281.2 6310.6 6319.4 6353.8 6360.4 6376.0 6388.5 6418.8 5829.7 5831.9 5969.8 6087.9 6207.9 08:34:29 INFO - PID 3555 | 08:34:29 INFO - PID 3555 | [#5] yui.html Cycles:180 Average:21252.00 Median:19089.71 stddev:27846.23 (145.9%) stddev-sans-first:27882.50 08:34:29 INFO - PID 3555 | Values: 921.0 931.3 939.4 945.7 957.6 17490.5 18192.5 18447.7 18473.4 18497.9 18998.5 19878.1 20511.6 20585.6 20733.0 1010.3 1054.8 1055.4 1055.7 1055.7 1049.7 1063.3 1064.1 1066.3 1070.8 1013.7 1109.2 1120.7 1121.2 1121.3 1042.9 1086.4 1089.7 1092.6 1095.5 786.3 786.6 793.4 797.9 800.1 18093.3 18179.3 18619.8 18882.4 18894.7 19859.5 20187.3 20232.7 20615.8 20741.0 15143.7 15744.7 15823.2 15826.6 15852.8 3506.4 3524.6 3525.2 3537.9 3564.1 106138.5 106295.0 109167.0 110049.0 111841.4 15138.8 15520.7 15532.8 15536.8 15698.1 26327.5 27972.2 27981.4 27988.2 28235.7 7628.4 7773.0 7868.4 7870.3 7871.3 4064.0 4088.9 4097.7 4176.0 4181.7 4931.2 5040.6 5044.2 5048.1 5083.8 905.3 941.2 963.8 984.7 991.9 589.8 663.9 680.8 681.0 701.6 10619.7 11104.8 11391.9 11505.0 11527.1 648.4 683.5 689.7 695.8 708.7 5003.8 5072.2 5117.8 5213.5 5249.5 95510.5 98030.0 98290.5 104848.0 106711.5 80110.6 82270.6 89548.0 89737.6 90495.0 75374.2 76416.2 79521.0 79915.6 82129.2 11722.4 12158.3 12656.6 12713.4 12740.0 32873.3 35156.8 35211.3 35306.8 35651.6 42453.6 43588.6 44151.3 44713.3 46333.0 17092.3 17176.7 17177.1 17317.7 17449.7 17176.2 18102.9 18133.0 18157.5 18540.9 15889.4 16910.3 16945.7 18171.3 18334.4 18651.7 18855.2 19072.6 19106.8 19626.5 16762.2 17528.9 18022.9 18115.5 18315.5 13724.6 13809.8 14195.9 14381.2 14496.9 13619.3 14464.4 14492.7 14576.9 14837.3 08:34:29 INFO - PID 3555 | -------- Summary: end -------- 08:34:29 INFO - PID 3555 | 08:34:30 INFO - TEST-INFO | 3555: exit 0 08:34:30 INFO - TEST-OK | dromaeo_css | took 1112017ms 08:34:30 INFO - TEST-START | kraken 08:34:30 INFO - Initialising browser for kraken test... 08:34:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51158/getInfo.html -profile /tmp/tmpJZHgj8/profile 08:34:30 INFO - TEST-INFO | started process 3971 (/builds/slave/test/build/application/firefox/firefox http://localhost:51158/getInfo.html) 08:34:36 INFO - TEST-INFO | 3971: exit 0 08:34:36 INFO - Browser initialized. 08:34:36 INFO - Running cycle 1/1 for kraken test... 08:34:36 INFO - TEST-INFO | started process 4195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJZHgj8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:48 INFO - PID 4195 | RSS: Main: 169406464 08:34:48 INFO - PID 4195 | 08:34:50 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51158/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:51 INFO - PID 4195 | RSS: Main: 176250880 08:34:51 INFO - PID 4195 | 08:34:54 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51158/tests/kraken/driver.html?testName=audio-dft) 08:34:54 INFO - PID 4195 | RSS: Main: 176553984 08:34:54 INFO - PID 4195 | 08:34:57 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51158/tests/kraken/driver.html?testName=audio-fft) 08:34:58 INFO - PID 4195 | RSS: Main: 170938368 08:34:58 INFO - PID 4195 | 08:35:00 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51158/tests/kraken/driver.html?testName=audio-oscillator) 08:35:01 INFO - PID 4195 | RSS: Main: 171966464 08:35:01 INFO - PID 4195 | 08:35:03 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:03 INFO - PID 4195 | RSS: Main: 171786240 08:35:03 INFO - PID 4195 | 08:35:06 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51158/tests/kraken/driver.html?testName=imaging-darkroom) 08:35:07 INFO - PID 4195 | RSS: Main: 175169536 08:35:07 INFO - PID 4195 | 08:35:10 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51158/tests/kraken/driver.html?testName=imaging-desaturate) 08:35:11 INFO - PID 4195 | RSS: Main: 176459776 08:35:11 INFO - PID 4195 | 08:35:14 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51158/tests/kraken/driver.html?testName=json-parse-financial) 08:35:14 INFO - PID 4195 | RSS: Main: 175386624 08:35:14 INFO - PID 4195 | 08:35:16 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:35:17 INFO - PID 4195 | RSS: Main: 174850048 08:35:17 INFO - PID 4195 | 08:35:18 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:35:19 INFO - PID 4195 | RSS: Main: 175116288 08:35:19 INFO - PID 4195 | 08:35:21 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:35:22 INFO - PID 4195 | RSS: Main: 175443968 08:35:22 INFO - PID 4195 | 08:35:24 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:25 INFO - PID 4195 | RSS: Main: 174759936 08:35:25 INFO - PID 4195 | 08:35:28 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:29 INFO - PID 4195 | RSS: Main: 175034368 08:35:29 INFO - PID 4195 | 08:35:30 INFO - PID 4195 | Cycle 1(1): loaded http://localhost:51158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51158/tests/kraken/driver.html?testName=ai-astar) 08:35:31 INFO - PID 4195 | RSS: Main: 176386048 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | __start_tp_report 08:35:31 INFO - PID 4195 | _x_x_mozilla_page_load 08:35:31 INFO - PID 4195 | _x_x_mozilla_page_load_details 08:35:31 INFO - PID 4195 | |i|pagename|runs| 08:35:31 INFO - PID 4195 | |0;ai-astar;101;108;110;107;106;109;111;109;109;111 08:35:31 INFO - PID 4195 | |1;audio-beat-detection;151;121;156;186;122;146;144;122;185;133 08:35:31 INFO - PID 4195 | |2;audio-dft;165;161;161;163;163;182;163;165;167;170 08:35:31 INFO - PID 4195 | |3;audio-fft;73;75;75;162;76;74;76;78;97;76 08:35:31 INFO - PID 4195 | |4;audio-oscillator;83;82;134;81;81;81;127;81;81;129 08:35:31 INFO - PID 4195 | |5;imaging-gaussian-blur;113;114;113;113;115;114;114;114;113;113 08:35:31 INFO - PID 4195 | |6;imaging-darkroom;149;149;149;150;149;151;150;148;149;149 08:35:31 INFO - PID 4195 | |7;imaging-desaturate;96;94;94;94;94;94;94;95;95;95 08:35:31 INFO - PID 4195 | |8;json-parse-financial;55;58;55;57;55;53;55;54;55;55 08:35:31 INFO - PID 4195 | |9;json-stringify-tinderbox;55;55;54;54;55;55;53;54;54;55 08:35:31 INFO - PID 4195 | |10;stanford-crypto-aes;80;76;78;78;77;79;77;78;78;76 08:35:31 INFO - PID 4195 | |11;stanford-crypto-ccm;141;125;130;131;127;127;127;126;124;145 08:35:31 INFO - PID 4195 | |12;stanford-crypto-pbkdf2;184;196;196;183;191;195;195;184;185;181 08:35:31 INFO - PID 4195 | |13;stanford-crypto-sha256-iterative;70;71;72;70;71;70;70;73;70;70 08:35:31 INFO - PID 4195 | __end_tp_report 08:35:31 INFO - PID 4195 | __start_cc_report 08:35:31 INFO - PID 4195 | _x_x_mozilla_cycle_collect,960 08:35:31 INFO - PID 4195 | __end_cc_report 08:35:31 INFO - PID 4195 | __startTimestamp1500219331232__endTimestamp 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | ------- Summary: start ------- 08:35:31 INFO - PID 4195 | Number of tests: 14 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:2.96 (2.7%) stddev-sans-first:1.69 08:35:31 INFO - PID 4195 | Values: 101.0 108.0 110.0 107.0 106.0 109.0 111.0 109.0 109.0 111.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:148.50 stddev:24.02 (16.2%) stddev-sans-first:25.42 08:35:31 INFO - PID 4195 | Values: 151.0 121.0 156.0 186.0 122.0 146.0 144.0 122.0 185.0 133.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:6.25 (3.8%) stddev-sans-first:6.62 08:35:31 INFO - PID 4195 | Values: 165.0 161.0 161.0 163.0 163.0 182.0 163.0 165.0 167.0 170.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#3] audio-fft Cycles:10 Average:86.20 Median:76.00 stddev:27.52 (36.2%) stddev-sans-first:28.77 08:35:31 INFO - PID 4195 | Values: 73.0 75.0 75.0 162.0 76.0 74.0 76.0 78.0 97.0 76.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:81.00 stddev:23.53 (29.1%) stddev-sans-first:24.49 08:35:31 INFO - PID 4195 | Values: 83.0 82.0 134.0 81.0 81.0 81.0 127.0 81.0 81.0 129.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 08:35:31 INFO - PID 4195 | Values: 113.0 114.0 113.0 113.0 115.0 114.0 114.0 114.0 113.0 113.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:35:31 INFO - PID 4195 | Values: 149.0 149.0 149.0 150.0 149.0 151.0 150.0 148.0 149.0 149.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 08:35:31 INFO - PID 4195 | Values: 96.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 08:35:31 INFO - PID 4195 | Values: 55.0 58.0 55.0 57.0 55.0 53.0 55.0 54.0 55.0 55.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 08:35:31 INFO - PID 4195 | Values: 55.0 55.0 54.0 54.0 55.0 55.0 53.0 54.0 54.0 55.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:1.25 (1.6%) stddev-sans-first:1.01 08:35:31 INFO - PID 4195 | Values: 80.0 76.0 78.0 78.0 77.0 79.0 77.0 78.0 78.0 76.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:128.50 stddev:7.07 (5.5%) stddev-sans-first:6.35 08:35:31 INFO - PID 4195 | Values: 141.0 125.0 130.0 131.0 127.0 127.0 127.0 126.0 124.0 145.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.00 Median:193.00 stddev:6.15 (3.2%) stddev-sans-first:6.25 08:35:31 INFO - PID 4195 | Values: 184.0 196.0 196.0 183.0 191.0 195.0 195.0 184.0 185.0 181.0 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:1.06 (1.5%) stddev-sans-first:1.09 08:35:31 INFO - PID 4195 | Values: 70.0 71.0 72.0 70.0 71.0 70.0 70.0 73.0 70.0 70.0 08:35:31 INFO - PID 4195 | -------- Summary: end -------- 08:35:31 INFO - PID 4195 | 08:35:31 INFO - PID 4195 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:35:31 INFO - TEST-INFO | 4195: exit 0 08:35:31 INFO - TEST-OK | kraken | took 61789ms 08:35:31 INFO - SUITE-END | took 1173s 08:35:32 INFO - Completed test suite (00:19:34) 08:35:32 INFO - javascript benchmark 08:35:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8254.68116295804, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.8296193709366, 3115.314630781228, 3160.051984404678, 3165.3985742708883, 3174.682531746824, 5918.082697181938, 5954.047352423613, 5958.970205148974, 5988.101784732287, 6043.909341359883, 5995.190649262348, 6020.819375418733, 6024.48791852693, 6024.578279520435, 6034.306054803699, 5532.806351777678, 5543.891221755644, 5549.722513874311, 5554.472325129126, 5561.5272701820395, 5515.917261241085, 5545.3622833374275, 5545.77816887324, 5555.2222688823595, 5565.471280228372, 5536.501714845663, 5540.722963851791, 5542.75057622408, 5557.416471270519, 5561.388247292794, 5559.138333558305, 5564.554835613182, 5568.888622227532, 5576.163575463693, 5591.776328946838, 5497.065498865202, 5521.696306703129, 5542.334919809608, 5547.750351234205, 5653.038983372837, 6003.039513677791, 6025.126356678301, 6070.180525629072, 6109.4501494865235, 6134.754609815602, 6450.225972883284, 6456.289808121103, 6501.0, 6515.120458738057, 6551.475881929434, 6349.36506349366, 6382.744690212386, 6441.935580644227, 6443.29123796382, 6471.352864713538, 6055.697215139226, 6057.848553786146, 6059.333473317932, 6064.363241859585, 6087.452129308339, 6604.702788374487, 6643.70103345341, 6648.83377915556, 6664.566803157779, 6714.630695311805, 6279.403456671609, 6320.873582528324, 6347.301796802348, 6383.329750376237, 6432.6462044588, 6445.0, 6450.80647580564, 6506.446952009038, 6527.314631963671, 6553.475721942234, 6275.780347687901, 6376.458001069961, 6387.616742995342, 6437.678116094176, 6451.645159516272, 5912.733926973297, 6427.164468619049, 6466.967665161644, 6496.512761542903, 6502.967485162544, 5184.662996905189, 5243.737813109329, 5254.028004819121, 5257.027449921777, 5259.737013149327, 4387.188370151468, 4475.0, 4475.641948644101, 4482.798274077674, 4519.344695019269, 5520.834374968757, 5530.6128570999645, 5559.110542313291, 5571.275734154534, 5573.69344686038, 6489.253735820346, 6502.414782669583, 6513.967430162914, 6515.0, 6553.868922621521, 5446.183072539151, 5505.03661859173, 5507.421720719347, 5532.3637781655625, 5551.056320425457, 5699.202111704365, 5729.856753581111, 5731.942680573225, 5734.111212761945, 5752.165935939265, 5319.255304257407, 6266.467350275278, 6266.686665666698, 6272.996320588684, 6399.296077431479, 6500.122483464766, 6515.804525864231, 6606.900896486461, 6624.039514270404, 6628.138342015507, 6283.59156654816, 6293.150424692608, 6302.810915672537, 6380.585261957958, 6413.935860641333, 6334.809955701337, 6354.872902542016, 6451.870962580816, 6503.057056726842, 6512.739490420519, 6600.702968366339, 6610.438112760469, 6645.368689974444, 6645.933540664531, 6648.1025061616065, 6340.0, 6342.270638876588, 6384.6169229846355, 6401.839954001187, 6431.260405053479, 6301.054841773771, 6324.0, 6378.394052564999, 6438.356164383524, 6438.517111216771, 5887.793927212527, 6035.1249068885645, 6037.969810150921, 6236.563440559117, 6337.176167098248, 6285.874282514233, 6288.371162883675, 6300.306966233619, 6306.432421082125, 6333.936660633519, 5189.247559103985, 6082.148499210202, 6144.938550614436, 6169.81490555284, 6214.782482613267], "value": 5901.288084363721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.6473683947484, 839.3830534557103, 862.1206369503107, 883.1168831168835, 888.7289376740093, 39185.21629567411, 39485.0, 39571.604283957226, 39985.4002189967, 40060.39909401358, 36134.8193259034, 36326.45510317347, 36661.08347291319, 36694.0, 36724.0, 6697.899531507019, 6778.389944904958, 6817.454603631722, 6824.4199243064395, 6829.0, 6759.256481787, 6808.6255255960905, 6833.897491537631, 6844.589324640513, 6858.794236172897, 6733.360330768569, 6772.8306792330095, 6834.2482326944, 6845.0, 6849.2465828758795, 6749.662516874137, 6766.695498702546, 6802.829929251809, 6809.3190680932, 6815.931840681579, 6150.354212807681, 6202.162708034402, 6204.9689751551405, 6211.19254496917, 6216.906746398808, 32668.673313267038, 32703.691852326116, 32752.6724732752, 32759.6724032759, 32944.505832412535, 3330.467125259947, 3365.5793025871767, 3386.6444023377685, 3391.270876761508, 3396.2528243786574, 26006.34984125393, 28439.85780071107, 29240.41519169626, 30801.537976930365, 30893.0, 4743.454502732196, 4791.808327666924, 4855.757212139379, 4867.318575399447, 4928.605711543068, 180375.0, 181297.0, 183167.0, 183918.0, 184873.99999999866, 47237.52762472331, 47855.0, 47926.760366197945, 47988.0, 48226.517734822206, 50088.0, 50159.0, 50219.0, 50345.748271259145, 50358.0, 15653.37386504527, 15757.44848930282, 15795.0, 15906.363745450284, 15993.920030399773, 13296.069275150647, 13313.933430332787, 13315.40080696371, 13315.866841331463, 13320.067595268238, 14035.298235088205, 14089.295535223198, 14101.647458813406, 14110.294485275901, 14198.290085495684, 5638.35158956717, 5807.88384232313, 5809.348296200827, 5817.632856278771, 5822.126680997884, 1006.4011912911806, 1007.2395341517108, 1011.4487604255551, 1036.3937096798306, 1054.3305001324215, 22221.22225722092, 22268.220612278492, 22275.77724222737, 22985.425364366023, 23387.88306058493, 1096.5613754498265, 1102.8841971593029, 1114.5987444519967, 1131.6378758797107, 1137.3119262846024, 11780.293182409083, 11800.542416144706, 11980.101492387932, 12000.759984800256, 12366.62900112998, 228095.0, 230095.0, 230350.0, 230575.0, 231373.0, 50702.239466408035, 50737.23894141591, 50753.746231268604, 50901.745491272304, 51344.229836552484, 1419.5883193873867, 1435.850619936217, 1473.8599833015846, 1479.8224213094281, 1496.8128983877016, 21665.494345420637, 22003.818492981394, 22168.00487956092, 22790.430239244153, 23096.076156953535, 35158.64841351554, 35318.0, 35418.8229058853, 35526.111847204025, 35665.0, 185691.0, 187477.0, 188026.0, 188093.05953470146, 188551.0, 33176.834115830236, 34958.0, 35470.822645886605, 37015.25969480649, 37365.626343736214, 44457.0, 45699.771501142284, 45738.54261457476, 45991.77004114958, 46365.0, 30702.0, 32753.0, 32827.67172328246, 32881.50677739788, 32913.177170570925, 31798.52302215515, 32502.512462313556, 32529.837350813094, 32568.67431325751, 32801.50797737988, 35874.4618830723, 36448.81775591105, 36472.63527364693, 36522.8173859129, 37374.252514949, 31480.0, 32370.676293236767, 32478.188045299055, 33004.17489562684, 33156.66843331536, 22583.0, 23770.217233707197, 23966.52066958686, 24119.03523859026, 24273.0], "value": 16538.40674829441, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.4403718300289, 568.3293713418165, 570.60913274407, 587.1017343464498, 601.8705978214683, 21216.681749773747, 22097.0, 22352.441188970282, 22397.104115835387, 22841.08635654572, 24770.87614561929, 26660.600090998603, 26691.06581269656, 26886.865565672146, 26970.730292697066, 6564.5076619253505, 6617.305182955793, 6653.168353955755, 6714.56355336904, 6718.563293385939, 3960.3069462843887, 6480.546361754679, 6609.834754131137, 6626.039224312472, 6642.468602511787, 5165.948340516603, 6561.409473147416, 6587.538872278942, 6590.242122155942, 6598.67006649668, 6529.902051469232, 6583.275839657634, 6585.506087043467, 6620.966895165518, 6628.43658289046, 6063.878722425571, 6103.633781973052, 6109.175261339707, 6118.265808103011, 6134.69326533676, 28575.0, 29851.10446686603, 30358.54462183069, 30560.69439305601, 31045.0, 1898.6392585408728, 1953.7557805274341, 1953.9413817585496, 1955.4622478818296, 1958.128632758423, 18605.62788744231, 19127.80872191274, 19279.4216173515, 19309.710354344697, 19368.225270989144, 2243.1588154442084, 2272.8068114210314, 2301.6547517872286, 2307.0541078157876, 2367.763223677636, 133715.33142334226, 135907.96138057936, 137327.31336343355, 139039.0, 139386.0, 14189.92905035489, 14672.853271467362, 14736.0, 14929.626759331104, 15813.130277834829, 23721.88139059328, 23837.0, 23850.88074559616, 23869.04523819028, 23893.163739269043, 9915.603375865028, 9919.462483315097, 10022.599096036078, 10022.849657255147, 10078.143357814668, 9009.324300677345, 9108.726738197865, 9139.588718507683, 9152.940588367564, 9267.212286955684, 7734.7679569613, 9003.864942025875, 9288.11762882525, 9357.812843743088, 9489.762755931019, 2693.676758788958, 2721.700612932576, 2757.931051723723, 2837.4750671125908, 2895.5222388306115, 934.9205317548085, 938.1228551304553, 951.1487218939011, 971.7446554043896, 989.7970915962211, 19514.70727939082, 19741.0, 19900.402987910387, 20253.29113481021, 23309.53380932372, 1001.1890368801148, 1042.6246551241547, 1049.9105982199292, 1064.7763969566322, 1072.5495291977388, 11153.776924461465, 11436.542538298541, 11535.480903359368, 11695.707607309716, 11695.824562631567, 452196.8110887374, 456926.9892388676, 458084.0, 467226.0, 494217.0, 109322.0, 112084.0, 114782.0, 115770.42114789372, 115798.0, 1253.3607859991287, 1297.4939773488347, 1306.9934650326877, 1307.9607611771662, 1315.335755443495, 16862.24119914582, 17873.463796086136, 17892.642147157243, 18702.345417910306, 18962.43112706621, 55762.88474230574, 55929.720351397984, 56792.0, 57035.429645703014, 57685.711571441876, 69147.0, 69822.30177698362, 70191.64904175447, 70333.0, 70918.6454067747, 14087.506937257147, 14817.110973341634, 15200.619984500476, 15206.847931520542, 15241.6189595261, 23600.17399391013, 23749.406264842826, 23915.804209789094, 23943.401414964766, 24138.63792043156, 18447.446576602724, 18481.0, 18576.25694972186, 18649.0, 18772.0, 16102.758458622895, 16334.346626134822, 16930.492085237463, 16990.57523561921, 17397.217125229647, 19420.611587767882, 19627.70558441596, 19640.312589059315, 19691.803081968996, 19718.704219437008, 14886.25568721538, 15004.549863504113, 15024.924875375553, 21528.246511372028, 22503.09987600543, 19783.109760060543, 19882.701759473908, 20081.598368032264, 20113.195472181535, 20153.093110810343], "value": 12076.440598574078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.6335825968729, 1358.7893876449148, 1362.6933939863538, 1363.7477066742654, 1372.3207012528794, 13233.867661323384, 13801.102928309665, 13875.098118622282, 13903.791443128335, 14002.78995815061, 13899.791503127435, 14162.079464834778, 14179.220142892136, 14184.716305673906, 14220.928895355535, 2648.4570663014083, 2705.6347393101973, 2720.2519307190482, 2722.7005029446846, 2724.4687285979244, 2593.23499567628, 2657.070025491072, 2657.428652839639, 2661.1484325016004, 2661.707212206665, 2632.3419145213697, 2642.1677171690953, 2665.6667916510437, 2666.4667066586762, 2669.359353755104, 2572.241188849294, 2602.1022747152297, 2602.1673064619235, 2604.6744156980376, 2606.4005278785794, 2454.63180522923, 2478.1574264749893, 2482.8510289382516, 2486.9378265543323, 2498.5252801967567, 13207.471701131943, 13541.932290338584, 13542.187468751808, 13542.661433464144, 13550.796738048937, 7224.67488962998, 7564.092308922909, 7586.8482630347635, 7597.240275972414, 7597.696092156307, 5080.415752188472, 5095.108356037678, 5204.739763011834, 5260.710660913648, 5272.156454967225, 1817.500187448449, 1836.7887692915351, 1853.7682789651294, 1862.5995410986568, 1905.2950408349, 20733.377998660064, 21205.78794212038, 22188.112475500962, 22409.21567745121, 22431.55136897253, 5718.342390625048, 6386.680665966683, 6598.670066496656, 6641.734330626818, 6645.036469711865, 15605.921970390076, 15652.4521641742, 15664.92167539155, 15684.294206760494, 15690.293936772872, 6975.79072627822, 7525.2098529654695, 7529.548227106282, 7530.058742657168, 7541.7360392386, 6787.524873258923, 6927.341902519353, 7010.649467526603, 7011.1586609607175, 7056.1179852518435, 4979.45226025137, 5137.255098010843, 5148.2277658350795, 5155.200943853709, 5176.637635365489, 1478.7116512280002, 1502.1738044075714, 1527.8624923756693, 1528.3657282227973, 1534.232883558221, 860.3418384935529, 866.3762091294258, 887.4675194883148, 899.1682693508478, 911.9133682300171, 7358.264173582599, 7445.10658720957, 7888.290053895063, 8324.66701331952, 8526.87209691855, 969.4231932000448, 975.6341371985505, 998.5356809083811, 1018.3889666200221, 1031.293563908725, 5039.319691841628, 5057.848264552069, 5080.252614762517, 5093.643444958891, 5298.655587386885, 17127.486175414757, 17738.467845964642, 17759.644807103785, 18108.637827243383, 18410.81589184118, 17750.822491774918, 18497.982610956526, 18506.259749610133, 18511.53721156982, 18548.721769173473, 10355.94822025885, 10445.895541044492, 10498.580056797642, 10528.684139475828, 10532.315399499008, 7121.0, 7913.44605877583, 7919.16848730875, 7947.801304967422, 7959.880601791094, 15853.682926341178, 16351.100689462193, 16382.75425868589, 16746.1626918656, 16750.497485075466, 15790.289436975594, 16196.190190490664, 16600.0, 16709.331626734795, 16923.15384230759, 9858.654947076819, 10068.496575171359, 10198.0, 10201.795964080826, 10208.744781380525, 12149.57476488354, 12388.62834114978, 12704.936475317565, 13239.3380330985, 13279.402426891007, 10703.036726694634, 10754.677359679223, 10958.342499450058, 10972.122230221403, 11158.163137764537, 9720.513974301399, 10104.09063184317, 10174.491275436347, 10210.387376757419, 10226.846597301195, 9157.084291570789, 9292.535373231176, 9301.488418137067, 9310.674126405544, 9382.906170938204, 6952.687129079102, 7059.435245180476, 7069.293070692889, 7115.430765538848, 7150.821229469097, 7275.163356214103, 7372.852542949004, 7412.703491860265, 7457.515261507984, 7520.059992500937], "value": 6264.661336556305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.4454980529712, 493.6364880451993, 522.4227228912055, 524.5384062025418, 526.5839986410735, 5934.317553481351, 5992.670403127831, 6011.879762404755, 6020.729067191976, 6044.395560443953, 5774.5091667208335, 5946.762129514825, 5987.982043052681, 5999.370066143058, 6031.909521357183, 4897.730624815634, 4919.877003074916, 4924.679895806779, 4927.581155601778, 4939.209726443752, 4853.563179313861, 4857.125717370872, 4860.222364421693, 4861.100696371165, 4871.902561948759, 4803.2795080738, 4811.278308253755, 4855.514448555152, 4874.53691899269, 4895.0, 4664.0, 4831.9275210871865, 4834.468208497063, 4840.322354870321, 4870.537298956593, 4311.771145223596, 4353.434053573047, 4356.368326592658, 4356.8257269709175, 4384.517703052662, 5771.163181338682, 5779.219805326269, 5787.942120578782, 5871.765129394819, 5880.353161152269, 5478.726063696799, 5481.205225242357, 5501.394846566875, 5532.972335138339, 5535.501804837584, 6078.908816367758, 6274.403931626488, 6325.652089135096, 6329.303776584572, 6347.460465860408, 4722.598579120779, 4746.596539294164, 4784.952150478485, 4791.233402655558, 4815.157347464215, 6640.302768209317, 6647.66761661915, 6652.966735166342, 6726.495512836508, 6770.086038384854, 4912.926306105412, 4930.0, 4931.013797240495, 4936.716453721986, 4957.355543779286, 4905.583025442806, 4944.802207911644, 4990.126727822617, 4990.3762029746285, 4994.975025124923, 5459.153831156177, 5459.225751630656, 5467.125259958388, 5504.559635229172, 5533.253010843565, 6352.491800656029, 6364.64994425311, 6372.904406433907, 6375.585586936927, 6375.939549016405, 1699.7195462748755, 1728.8271172882612, 1732.6707925494115, 1746.6943284925087, 1746.7117925542398, 1119.4290911635126, 1211.2187638972814, 1229.9877001230052, 1233.2292317301687, 1237.0, 5319.946800532022, 5467.589930755209, 5477.411550650347, 5546.55627549795, 5558.305211848519, 6385.733064762036, 6587.80236592903, 6600.73597056122, 6603.0, 6642.96678516614, 5451.836444906659, 5527.186241493357, 5532.2531458253425, 5552.805651802168, 5615.2700148981185, 3440.6559344065895, 3463.740219483549, 3467.6705712957228, 3469.6356882527475, 3470.392681280766, 6273.529485288622, 6279.937200627935, 6316.968415157987, 6372.617642941438, 6376.489880809524, 6688.331166883273, 6695.564788288746, 6742.0224067509935, 6774.153230846145, 6796.592204467748, 6291.528135389955, 6328.208973878265, 6336.968315158487, 6372.107904893319, 6418.839529011719, 6551.508636852351, 6569.9343006571235, 6603.20761508622, 6622.271550129578, 6625.900611490928, 6487.448566871869, 6521.576097553644, 6556.18047744032, 6563.212414510289, 6610.768623098168, 6312.43188113072, 6315.242170939517, 6388.68056597159, 6393.392627700361, 6394.584352017104, 4878.170710979071, 4885.218365061573, 4887.120318342732, 4902.14212512816, 4912.361393018885, 6507.349265073644, 6549.148610680581, 6557.83577428346, 6565.704543295658, 6571.080048793268, 6203.7828675996125, 6317.842053948688, 6389.744410223539, 6390.233172019387, 6399.968000159969, 6337.4016653171975, 6369.394907483782, 6370.29926708071, 6374.936250637435, 6396.744130234924, 6247.625142491465, 6268.088233088952, 6281.183446151971, 6310.6213627182515, 6319.399657032574, 6353.777617783356, 6360.363963603602, 6376.0, 6388.520860935356, 6418.807435776934, 5829.737661805144, 5831.912521312099, 5969.791057312973, 6087.878242435215, 6207.875842483035], "value": 4919.224830069792, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [920.9907900920992, 931.3387494878635, 939.3800091939313, 945.6501094594996, 957.6169532187126, 17490.47528574143, 18192.545186370346, 18447.72328415075, 18473.445796626107, 18497.907510462446, 18998.52503687405, 19878.105485253163, 20511.589768204663, 20585.588288234263, 20733.0, 1010.3382284603597, 1054.8417737339385, 1055.4247934875473, 1055.6780182044474, 1055.7360659835042, 1049.7008352619466, 1063.3354153653966, 1064.084886997182, 1066.3495267886622, 1070.7911957168355, 1013.6923368854169, 1109.1902910875067, 1120.675004248767, 1121.1871393239917, 1121.2935850414228, 1042.8644276244077, 1086.3536195963388, 1089.6730980705756, 1092.5684354679897, 1095.4741723972459, 786.2805532937356, 786.6224212378033, 793.3851265269404, 797.9002624671916, 800.087899794235, 18093.276268949227, 18179.27282908682, 18619.813801861943, 18882.433526994213, 18894.716579251322, 19859.50351241216, 20187.293444729363, 20232.69650955237, 20615.79384206169, 20741.0, 15143.697126057417, 15744.685106297924, 15823.20883955809, 15826.604334891605, 15852.841471585252, 3506.4389697648508, 3524.6475352464804, 3525.2420729543273, 3537.8584856605703, 3564.144605294711, 106138.46930765297, 106295.0, 109167.0, 110049.0, 111841.44079279715, 15138.772918406232, 15520.689586208213, 15532.844671553139, 15536.844631553766, 15698.136602486973, 26327.47345053088, 27972.16083517498, 27981.44037119246, 27988.16035518938, 28235.717642823718, 7628.389728821681, 7772.961135194401, 7868.370530357558, 7870.252326029018, 7871.33093687043, 4063.9796801015805, 4088.856890008895, 4097.733647312915, 4175.97912010438, 4181.728187667792, 4931.211006238985, 5040.647154699209, 5044.218146187347, 5048.066107770001, 5083.822066227664, 905.2712566384124, 941.1811723800338, 963.802420503795, 984.699666601679, 991.8710567626307, 589.7909285963757, 663.890458074422, 680.8161796314968, 680.9829754256084, 701.5895701014862, 10619.734506637242, 11104.833427498594, 11391.943040284912, 11505.0, 11527.060931012826, 648.3646026893576, 683.5112894280613, 689.7310049080862, 695.7530076822655, 708.6810935079131, 5003.7998480061115, 5072.188449848007, 5117.795288188431, 5213.452587478336, 5249.47505249472, 95510.52244738732, 98030.0, 98290.5085474568, 104847.95152048382, 106711.46644266728, 80110.59944700239, 82270.58864705639, 89548.0, 89737.55131224303, 90495.0, 75374.24625753672, 76416.23583764091, 79521.0, 79915.60042199751, 82129.17870821335, 11722.413879306172, 12158.270503769802, 12656.557020504239, 12713.364331783188, 12740.044496662973, 32873.34253314872, 35156.824215878754, 35211.29577408489, 35306.82346588251, 35651.57393704223, 42453.5754642462, 43588.56411435845, 44151.33772993472, 44713.32930005987, 46333.0, 17092.316307347566, 17176.65646687084, 17177.055261960213, 17317.653646927243, 17449.738253926454, 17176.22706978164, 18102.90948545249, 18133.0, 18157.54606134857, 18540.907295463436, 15889.443869464514, 16910.32358705638, 16945.745813812555, 18171.273149073888, 18334.449966501026, 18651.720224196375, 18855.15151818144, 19072.61854762925, 19106.808931910502, 19626.50933726611, 16762.245698943334, 17528.91235543814, 18022.909885451012, 18115.54711132232, 18315.54211144732, 13724.588262352145, 13809.79285310701, 14195.858041419866, 14381.209033503257, 14496.927515362355, 13619.319034048456, 14464.421423142956, 14492.710145797237, 14576.927115364355, 14837.258137092886], "value": 8709.646020647637, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 110.0, 107.0, 106.0, 109.0, 111.0, 109.0, 109.0, 111.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 156.0, 186.0, 122.0, 146.0, 144.0, 122.0, 185.0, 133.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 161.0, 163.0, 163.0, 182.0, 163.0, 165.0, 167.0, 170.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 162.0, 76.0, 74.0, 76.0, 78.0, 97.0, 76.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 134.0, 81.0, 81.0, 81.0, 127.0, 81.0, 81.0, 129.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 149.0, 151.0, 150.0, 148.0, 149.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 55.0, 57.0, 55.0, 53.0, 55.0, 54.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 53.0, 54.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 78.0, 78.0, 77.0, 79.0, 77.0, 78.0, 78.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 125.0, 130.0, 131.0, 127.0, 127.0, 127.0, 126.0, 124.0, 145.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 196.0, 196.0, 183.0, 191.0, 195.0, 195.0, 184.0, 185.0, 181.0], "value": 189.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 72.0, 70.0, 71.0, 70.0, 70.0, 73.0, 70.0, 70.0], "value": 70.7, "unit": "score"}]}]} 08:35:32 INFO - Return code: 0 08:35:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:32 INFO - # TBPL SUCCESS # 08:35:32 INFO - Running post-action listener: _package_coverage_data 08:35:32 INFO - Running post-action listener: _resource_record_post_action 08:35:32 INFO - [mozharness: 2017-07-16 15:35:32.525193Z] Finished run-tests step (success) 08:35:32 INFO - Running post-run listener: _resource_record_post_run 08:35:32 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 6004736; Write bytes: 444215296; Read time: 2204; Write time: 399568 08:35:32 INFO - TinderboxPrint: CPU usage
13.1% 08:35:32 INFO - TinderboxPrint: I/O read bytes / time
6,004,736 / 2,204 08:35:32 INFO - TinderboxPrint: I/O write bytes / time
444,215,296 / 399,568 08:35:32 INFO - TinderboxPrint: CPU idle
8,265.5 (86.9%) 08:35:32 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 08:35:32 INFO - TinderboxPrint: Swap in / out
0 / 0 08:35:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 166617088; Read time: 64; Write time: 148396 08:35:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:35:32 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 3813376; Write bytes: 203427840; Read time: 1728; Write time: 147628 08:35:33 INFO - Running post-run listener: _upload_blobber_files 08:35:33 INFO - Blob upload gear active. 08:35:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:33 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 08:35:33 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'] 08:35:33 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 08:35:33 INFO - Traceback (most recent call last): 08:35:33 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:35:33 INFO - main() 08:35:33 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:35:33 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:35:33 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:35:33 INFO - return set(response.json().get('whitelist', [])) 08:35:33 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:35:33 INFO - return json.loads(self.text or self.content, **kwargs) 08:35:33 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:35:33 INFO - return _default_decoder.decode(s) 08:35:33 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:35:33 INFO - obj, end = self.raw_decode(s) 08:35:33 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:35:33 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:35:33 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:35:33 ERROR - Return code: 1 08:35:33 INFO - Setting buildbot property blobber_files to {} 08:35:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:33 INFO - Contents: 08:35:33 INFO - blobber_files:{} 08:35:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:33 INFO - Copying logs to upload dir... 08:35:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.562045 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-16 08:35:33.885284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:35:33.888393) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/KcZaFrWRQQ6ypWymSEoK1w/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:35:33.941588) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:35:33.941881) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1500217039.550278-924407430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:35:33.990487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:35:33.990753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:35:33.991042) ========= ========= Total master_lag: 0.32 =========