builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1500218259.59 results: success (0) revision: c1185e615e55949151f20c66d55b0e7e62034adb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.590708) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.591072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.591337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.637699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.637956) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 08:17:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-07-16 08:17:39 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179596 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.848202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.848475) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.046777 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:39.904135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 08:17:39.904417) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c1185e615e55949151f20c66d55b0e7e62034adb --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 c1185e615e55949151f20c66d55b0e7e62034adb --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=769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 08:17:40,076 truncating revision to first 12 chars 2017-07-16 08:17:40,076 Setting DEBUG logging. 2017-07-16 08:17:40,076 attempt 1/10 2017-07-16 08:17:40,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c1185e615e55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 08:17:40,922 unpacking tar archive at: mozilla-central-c1185e615e55/testing/mozharness/ program finished with exit code 0 elapsedTime=1.156875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 08:17:41.079354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:41.079672) ========= script_repo_revision: c1185e615e55949151f20c66d55b0e7e62034adb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:41.080064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:41.080417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:17:41.099749) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-16 08:17:41.100016) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:17:41 INFO - MultiFileLogger online at 20170716 08:17:41 in /builds/slave/test 08:17:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:17:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:17:41 INFO - {'append_to_log': False, 08:17:41 INFO - 'base_work_dir': '/builds/slave/test', 08:17:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:17:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:17:41 INFO - 'branch': 'Firefox-Non-PGO', 08:17:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:17:41 INFO - 'code_coverage': False, 08:17:41 INFO - 'config_files': ('talos/linux_config.py',), 08:17:41 INFO - 'default_actions': ('clobber', 08:17:41 INFO - 'read-buildbot-config', 08:17:41 INFO - 'download-and-extract', 08:17:41 INFO - 'populate-webroot', 08:17:41 INFO - 'create-virtualenv', 08:17:41 INFO - 'install', 08:17:41 INFO - 'setup-mitmproxy', 08:17:41 INFO - 'run-tests'), 08:17:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:17:41 INFO - 'disable_ccov_upload': False, 08:17:41 INFO - 'download_minidump_stackwalk': True, 08:17:41 INFO - 'download_symbols': 'ondemand', 08:17:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:17:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:17:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:17:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:17:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:17:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:17:41 INFO - 'gecko_profile': False, 08:17:41 INFO - 'gecko_profile_interval': 0, 08:17:41 INFO - 'installer_path': 'installer.exe', 08:17:41 INFO - 'log_level': 'info', 08:17:41 INFO - 'log_name': 'talos', 08:17:41 INFO - 'log_to_console': True, 08:17:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:17:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:17:41 INFO - 'opt_config_files': (), 08:17:41 INFO - 'pip_index': False, 08:17:41 INFO - 'suite': 'dromaeojs-e10s', 08:17:41 INFO - 'system_bits': '32', 08:17:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:17:41 INFO - 'title': 'talos-linux64-ix-063', 08:17:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:17:41 INFO - 'use_talos_json': True, 08:17:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:17:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:17:41 INFO - 'work_dir': 'build'} 08:17:41 INFO - [mozharness: 2017-07-16 15:17:41.506726Z] Running clobber step. 08:17:41 INFO - Running pre-action listener: _resource_record_pre_action 08:17:41 INFO - Running main action method: clobber 08:17:41 INFO - rmtree: /builds/slave/test/build 08:17:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:17:47 INFO - Running post-action listener: _resource_record_post_action 08:17:47 INFO - [mozharness: 2017-07-16 15:17:47.078643Z] Finished clobber step (success) 08:17:47 INFO - [mozharness: 2017-07-16 15:17:47.078778Z] Running read-buildbot-config step. 08:17:47 INFO - Running pre-action listener: _resource_record_pre_action 08:17:47 INFO - Running main action method: read_buildbot_config 08:17:47 INFO - Using buildbot properties: 08:17:47 INFO - { 08:17:47 INFO - "project": "", 08:17:47 INFO - "product": "firefox", 08:17:47 INFO - "who": "archaeopteryx@coole-files.de", 08:17:47 INFO - "installer_path": "public/build/target.tar.bz2", 08:17:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:17:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:17:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:17:47 INFO - "stage_platform": "linux64", 08:17:47 INFO - "basedir": "/builds/slave/test", 08:17:47 INFO - "buildnumber": 962, 08:17:47 INFO - "platform": "ubuntu64_hw", 08:17:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:17:47 INFO - "slavebuilddir": "test", 08:17:47 INFO - "taskId": "G_vYRtcvT6OLuQ59-oqYtA", 08:17:47 INFO - "branch": "mozilla-central", 08:17:47 INFO - "script_repo_revision": "production", 08:17:47 INFO - "revision": "c1185e615e55949151f20c66d55b0e7e62034adb", 08:17:47 INFO - "slavename": "talos-linux64-ix-063", 08:17:47 INFO - "repo_path": "mozilla-central" 08:17:47 INFO - } 08:17:47 INFO - Finding installer, test and symbols from parent task. 08:17:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G_vYRtcvT6OLuQ59-oqYtA'}, attempt #1 08:17:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G_vYRtcvT6OLuQ59-oqYtA'}, attempt #1 08:17:47 INFO - Task dependencies: K-F0aVy-RdC_0SkTW0u8gw 08:17:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw'}, attempt #1 08:17:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2 08:17:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/test_packages.json 08:17:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.crashreporter-symbols.zip 08:17:48 INFO - Running post-action listener: _resource_record_post_action 08:17:48 INFO - [mozharness: 2017-07-16 15:17:48.460811Z] Finished read-buildbot-config step (success) 08:17:48 INFO - [mozharness: 2017-07-16 15:17:48.461031Z] Running download-and-extract step. 08:17:48 INFO - Running pre-action listener: _resource_record_pre_action 08:17:48 INFO - Running main action method: download_and_extract 08:17:48 INFO - mkdir: /builds/slave/test/build/tests 08:17: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:17:48 INFO - trying https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.test_packages.json 08:17:48 INFO - Downloading https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:17:49 INFO - Downloaded 989 bytes. 08:17:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:17:49 INFO - Using the following test package requirements: 08:17:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:17:49 INFO - u'common': [u'target.common.tests.zip'], 08:17:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:17:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:17:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:17:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:17:49 INFO - u'mozbase': [u'target.common.tests.zip'], 08:17:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:17:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:17:49 INFO - u'web-platform': [u'target.common.tests.zip', 08:17:49 INFO - u'target.web-platform.tests.tar.gz'], 08:17:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:17:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:17:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.common.tests.zip 08:17:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:17:49 INFO - Fetch https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.common.tests.zip into memory 08:17:50 INFO - Content-Length response header: 72753036 08:17:50 INFO - Bytes received: 72753036 08:18:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:18:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.common.tests.zip 08:18:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:01 INFO - Fetch https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.common.tests.zip into memory 08:18:02 INFO - Content-Length response header: 72753036 08:18:02 INFO - Bytes received: 72753036 08:18:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.talos.tests.zip 08:18:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:18:14 INFO - Fetch https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.talos.tests.zip into memory 08:18:15 INFO - Content-Length response header: 14495033 08:18:15 INFO - Bytes received: 14495033 08:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:15 INFO - trying https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2 08:18:15 INFO - Downloading https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:18:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:18:16 INFO - Downloaded 61838614 bytes. 08:18:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2 08:18:16 INFO - mkdir: /builds/slave/test/properties 08:18:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:16 INFO - Contents: 08:18:16 INFO - build_url:https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2 08:18:16 INFO - Running post-action listener: _resource_record_post_action 08:18:16 INFO - Running post-action listener: set_extra_try_arguments 08:18:16 INFO - [mozharness: 2017-07-16 15:18:16.523456Z] Finished download-and-extract step (success) 08:18:16 INFO - [mozharness: 2017-07-16 15:18:16.523553Z] Running populate-webroot step. 08:18:16 INFO - Running pre-action listener: _resource_record_pre_action 08:18:16 INFO - Running main action method: populate_webroot 08:18:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:16 INFO - '--tppagecycles', 08:18:16 INFO - '7'], 08:18:16 INFO - 'tests': ['tsvgm']}}, 08:18:16 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['damp', 'tps']}, 08:18:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'tests': ['damp', 'tps']}, 08:18:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['dromaeo_dom']}, 08:18:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:18:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:18:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:18:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['a11yr', 08:18:16 INFO - 'ts_paint', 08:18:16 INFO - 'tpaint', 08:18:16 INFO - 'sessionrestore', 08:18:16 INFO - 'sessionrestore_no_auto_restore', 08:18:16 INFO - 'tabpaint']}, 08:18:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:16 INFO - 'ts_paint', 08:18:16 INFO - 'tpaint', 08:18:16 INFO - 'sessionrestore', 08:18:16 INFO - 'sessionrestore_many_windows', 08:18:16 INFO - 'sessionrestore_no_auto_restore', 08:18:16 INFO - 'tabpaint']}, 08:18:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:16 INFO - 'ts_paint', 08:18:16 INFO - 'tpaint', 08:18:16 INFO - 'sessionrestore', 08:18:16 INFO - 'sessionrestore_many_windows', 08:18:16 INFO - 'sessionrestore_no_auto_restore', 08:18:16 INFO - 'tabpaint']}, 08:18:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:16 INFO - 'ts_paint', 08:18:16 INFO - 'tpaint', 08:18:16 INFO - 'sessionrestore', 08:18:16 INFO - 'sessionrestore_many_windows', 08:18:16 INFO - 'sessionrestore_no_auto_restore', 08:18:16 INFO - 'tabpaint']}, 08:18:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['a11yr', 08:18:16 INFO - 'ts_paint', 08:18:16 INFO - 'tpaint', 08:18:16 INFO - 'sessionrestore', 08:18:16 INFO - 'sessionrestore_no_auto_restore', 08:18:16 INFO - 'tabpaint']}, 08:18:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['a11yr', 08:18:16 INFO - 'ts_paint', 08:18:16 INFO - 'tpaint', 08:18:16 INFO - 'sessionrestore', 08:18:16 INFO - 'sessionrestore_no_auto_restore', 08:18:16 INFO - 'tabpaint']}, 08:18:16 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:18:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:18:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:18:16 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:18:16 INFO - 'talos_options': ['--mitmproxy', 08:18:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:18:16 INFO - '--firstNonBlankPaint'], 08:18:16 INFO - 'tests': ['quantum_pageload_google', 08:18:16 INFO - 'quantum_pageload_youtube', 08:18:16 INFO - 'quantum_pageload_amazon', 08:18:16 INFO - 'quantum_pageload_facebook']}, 08:18:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['tsvgx', 08:18:16 INFO - 'tsvgr_opacity', 08:18:16 INFO - 'tart', 08:18:16 INFO - 'tscrollx', 08:18:16 INFO - 'cart', 08:18:16 INFO - 'tsvg_static']}, 08:18:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:16 INFO - 'tsvgr_opacity', 08:18:16 INFO - 'tart', 08:18:16 INFO - 'tscrollx', 08:18:16 INFO - 'cart', 08:18:16 INFO - 'tsvg_static']}, 08:18:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'talos_options': ['--disable-e10s'], 08:18:16 INFO - 'tests': ['tp5o']}, 08:18:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:18:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'talos_options': ['--disable-e10s', 08:18:16 INFO - '--xperf_path', 08:18:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:16 INFO - 'tests': ['tp5n']}, 08:18:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:18:16 INFO - 'talos_options': ['--xperf_path', 08:18:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:16 INFO - 'tests': ['tp5n']}}, 08:18:16 INFO - 'talos.zip': {'path': '', 08:18:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:16 INFO - Running post-action listener: _resource_record_post_action 08:18:16 INFO - [mozharness: 2017-07-16 15:18:16.538880Z] Finished populate-webroot step (success) 08:18:16 INFO - [mozharness: 2017-07-16 15:18:16.538971Z] Running create-virtualenv step. 08:18:16 INFO - Running pre-action listener: _resource_record_pre_action 08:18:16 INFO - Running main action method: create_virtualenv 08:18:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:16 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:18:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:18:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:16 INFO - Using real prefix '/usr' 08:18:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:19 INFO - Installing pip.................done. 08:18:19 INFO - Return code: 0 08:18:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:18:19 INFO - Reading from file tmpfile_stdout 08:18:19 INFO - Output received: 08:18:19 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:18:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:18:19 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:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:19 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:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:19 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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:19 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:18:19 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:18:19 INFO - Using env: {'DISPLAY': ':0', 08:18:19 INFO - 'HOME': '/home/cltbld', 08:18:19 INFO - 'LANG': 'en_US.UTF-8', 08:18:19 INFO - 'LANGUAGE': 'en_US:en', 08:18:19 INFO - 'LOGNAME': 'cltbld', 08:18:19 INFO - 'MAIL': '/var/mail/cltbld', 08:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:19 INFO - 'MOZ_NO_REMOTE': '1', 08:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:19 INFO - 'NO_EM_RESTART': '1', 08:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:19 INFO - 'PWD': '/builds/slave/test', 08:18:19 INFO - 'SHELL': '/bin/bash', 08:18:19 INFO - 'SHLVL': '1', 08:18:19 INFO - 'TERM': 'linux', 08:18:19 INFO - 'TMOUT': '86400', 08:18:19 INFO - 'USER': 'cltbld', 08:18:19 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:19 INFO - '_': '/tools/buildbot/bin/python'} 08:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:19 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:18:19 INFO - Cleaning up... 08:18:19 INFO - Return code: 0 08:18:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:18:19 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:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:19 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:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:19 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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:19 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:18:19 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:18:19 INFO - Using env: {'DISPLAY': ':0', 08:18:19 INFO - 'HOME': '/home/cltbld', 08:18:19 INFO - 'LANG': 'en_US.UTF-8', 08:18:19 INFO - 'LANGUAGE': 'en_US:en', 08:18:19 INFO - 'LOGNAME': 'cltbld', 08:18:19 INFO - 'MAIL': '/var/mail/cltbld', 08:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:19 INFO - 'MOZ_NO_REMOTE': '1', 08:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:19 INFO - 'NO_EM_RESTART': '1', 08:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:19 INFO - 'PWD': '/builds/slave/test', 08:18:19 INFO - 'SHELL': '/bin/bash', 08:18:19 INFO - 'SHLVL': '1', 08:18:19 INFO - 'TERM': 'linux', 08:18:19 INFO - 'TMOUT': '86400', 08:18:19 INFO - 'USER': 'cltbld', 08:18:19 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:19 INFO - '_': '/tools/buildbot/bin/python'} 08:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:20 INFO - Downloading/unpacking psutil>=3.1.1 08:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:21 INFO - Installing collected packages: psutil 08:18:21 INFO - Running setup.py install for psutil 08:18:21 INFO - building 'psutil._psutil_linux' extension 08:18:21 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:18:22 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:18:22 INFO - building 'psutil._psutil_posix' extension 08:18:22 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:18:22 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:18:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:22 INFO - Successfully installed psutil 08:18:22 INFO - Cleaning up... 08:18:22 INFO - Return code: 0 08:18:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:18:22 INFO - Using env: {'DISPLAY': ':0', 08:18:22 INFO - 'HOME': '/home/cltbld', 08:18:22 INFO - 'LANG': 'en_US.UTF-8', 08:18:22 INFO - 'LANGUAGE': 'en_US:en', 08:18:22 INFO - 'LOGNAME': 'cltbld', 08:18:22 INFO - 'MAIL': '/var/mail/cltbld', 08:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:22 INFO - 'MOZ_NO_REMOTE': '1', 08:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:22 INFO - 'NO_EM_RESTART': '1', 08:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:22 INFO - 'PWD': '/builds/slave/test', 08:18:22 INFO - 'SHELL': '/bin/bash', 08:18:22 INFO - 'SHLVL': '1', 08:18:22 INFO - 'TERM': 'linux', 08:18:22 INFO - 'TMOUT': '86400', 08:18:22 INFO - 'USER': 'cltbld', 08:18:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:22 INFO - '_': '/tools/buildbot/bin/python'} 08:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:18:23 INFO - Installing collected packages: mozsystemmonitor 08:18:23 INFO - Running setup.py install for mozsystemmonitor 08:18:24 INFO - Successfully installed mozsystemmonitor 08:18:24 INFO - Cleaning up... 08:18:24 INFO - Return code: 0 08:18:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:18:24 INFO - Using env: {'DISPLAY': ':0', 08:18:24 INFO - 'HOME': '/home/cltbld', 08:18:24 INFO - 'LANG': 'en_US.UTF-8', 08:18:24 INFO - 'LANGUAGE': 'en_US:en', 08:18:24 INFO - 'LOGNAME': 'cltbld', 08:18:24 INFO - 'MAIL': '/var/mail/cltbld', 08:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:24 INFO - 'MOZ_NO_REMOTE': '1', 08:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:24 INFO - 'NO_EM_RESTART': '1', 08:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:24 INFO - 'PWD': '/builds/slave/test', 08:18:24 INFO - 'SHELL': '/bin/bash', 08:18:24 INFO - 'SHLVL': '1', 08:18:24 INFO - 'TERM': 'linux', 08:18:24 INFO - 'TMOUT': '86400', 08:18:24 INFO - 'USER': 'cltbld', 08:18:24 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:24 INFO - '_': '/tools/buildbot/bin/python'} 08:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:18: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:18: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:18: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:18: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:18:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:18:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:18: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:18: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:18: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:18: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:18:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:18:25 INFO - warning: no files found matching '*.txt' 08:18:25 INFO - no previously-included directories found matching 'build' 08:18:25 INFO - no previously-included directories found matching 'dist' 08:18:25 INFO - no previously-included directories found matching '.git*' 08:18:25 INFO - Installing collected packages: jsonschema, functools32 08:18:25 INFO - Running setup.py install for functools32 08:18:25 INFO - warning: no files found matching '*.txt' 08:18:25 INFO - no previously-included directories found matching 'build' 08:18:25 INFO - no previously-included directories found matching 'dist' 08:18:25 INFO - no previously-included directories found matching '.git*' 08:18:25 INFO - Successfully installed jsonschema functools32 08:18:25 INFO - Cleaning up... 08:18:25 INFO - Return code: 0 08:18:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:18: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:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18: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:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18: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', '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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:18: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 functools32==3.2.3-2 08:18:25 INFO - Using env: {'DISPLAY': ':0', 08:18:25 INFO - 'HOME': '/home/cltbld', 08:18:25 INFO - 'LANG': 'en_US.UTF-8', 08:18:25 INFO - 'LANGUAGE': 'en_US:en', 08:18:25 INFO - 'LOGNAME': 'cltbld', 08:18:25 INFO - 'MAIL': '/var/mail/cltbld', 08:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:25 INFO - 'MOZ_NO_REMOTE': '1', 08:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:25 INFO - 'NO_EM_RESTART': '1', 08:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:25 INFO - 'PWD': '/builds/slave/test', 08:18:25 INFO - 'SHELL': '/bin/bash', 08:18:25 INFO - 'SHLVL': '1', 08:18:25 INFO - 'TERM': 'linux', 08:18:25 INFO - 'TMOUT': '86400', 08:18:25 INFO - 'USER': 'cltbld', 08:18:25 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:25 INFO - '_': '/tools/buildbot/bin/python'} 08:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:18:25 INFO - Cleaning up... 08:18:25 INFO - Return code: 0 08:18:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:18: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:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18: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:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:18:26 INFO - Using env: {'DISPLAY': ':0', 08:18:26 INFO - 'HOME': '/home/cltbld', 08:18:26 INFO - 'LANG': 'en_US.UTF-8', 08:18:26 INFO - 'LANGUAGE': 'en_US:en', 08:18:26 INFO - 'LOGNAME': 'cltbld', 08:18:26 INFO - 'MAIL': '/var/mail/cltbld', 08:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:26 INFO - 'MOZ_NO_REMOTE': '1', 08:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:26 INFO - 'NO_EM_RESTART': '1', 08:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:26 INFO - 'PWD': '/builds/slave/test', 08:18:26 INFO - 'SHELL': '/bin/bash', 08:18:26 INFO - 'SHLVL': '1', 08:18:26 INFO - 'TERM': 'linux', 08:18:26 INFO - 'TMOUT': '86400', 08:18:26 INFO - 'USER': 'cltbld', 08:18:26 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:26 INFO - '_': '/tools/buildbot/bin/python'} 08:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:18: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:18: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:18: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:18: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:18:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:18:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:18: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:18: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:18: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:18: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:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:18:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:18: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:18: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:18: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:18: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:18:27 INFO - Downloading docopt-0.6.1.tar.gz 08:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:18:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:18:27 INFO - Running setup.py install for blobuploader 08:18:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:18:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:18:27 INFO - Running setup.py install for requests 08:18:28 INFO - Running setup.py install for docopt 08:18:28 INFO - Successfully installed blobuploader requests docopt 08:18:28 INFO - Cleaning up... 08:18:28 INFO - Return code: 0 08:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:28 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:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:28 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:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:28 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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:28 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:18:28 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:18:28 INFO - Using env: {'DISPLAY': ':0', 08:18:28 INFO - 'HOME': '/home/cltbld', 08:18:28 INFO - 'LANG': 'en_US.UTF-8', 08:18:28 INFO - 'LANGUAGE': 'en_US:en', 08:18:28 INFO - 'LOGNAME': 'cltbld', 08:18:28 INFO - 'MAIL': '/var/mail/cltbld', 08:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:28 INFO - 'MOZ_NO_REMOTE': '1', 08:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:28 INFO - 'NO_EM_RESTART': '1', 08:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:28 INFO - 'PWD': '/builds/slave/test', 08:18:28 INFO - 'SHELL': '/bin/bash', 08:18:28 INFO - 'SHLVL': '1', 08:18:28 INFO - 'TERM': 'linux', 08:18:28 INFO - 'TMOUT': '86400', 08:18:28 INFO - 'USER': 'cltbld', 08:18:28 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:28 INFO - '_': '/tools/buildbot/bin/python'} 08:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:28 INFO - Running setup.py (path:/tmp/pip-PNB1NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:28 INFO - Running setup.py (path:/tmp/pip-kTkdo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:28 INFO - Running setup.py (path:/tmp/pip-Czc6G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:28 INFO - Running setup.py (path:/tmp/pip-clLXIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:29 INFO - Running setup.py (path:/tmp/pip-TAyovp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:29 INFO - Running setup.py (path:/tmp/pip-IW9w63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:29 INFO - Running setup.py (path:/tmp/pip-wLwXoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:29 INFO - Running setup.py (path:/tmp/pip-vG7Rvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:29 INFO - Running setup.py (path:/tmp/pip-PsI073-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:29 INFO - Running setup.py (path:/tmp/pip-mTnWfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:29 INFO - Running setup.py (path:/tmp/pip-SlyJOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:29 INFO - Running setup.py (path:/tmp/pip-bCxSiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:29 INFO - Running setup.py (path:/tmp/pip-yWFSfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:29 INFO - Running setup.py (path:/tmp/pip-qqRdzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:29 INFO - Running setup.py (path:/tmp/pip-x5J_4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:29 INFO - Running setup.py (path:/tmp/pip-BPrSOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:29 INFO - Running setup.py (path:/tmp/pip-TLXR8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:18:29 INFO - Running setup.py install for manifestparser 08:18:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Running setup.py install for mozcrash 08:18:30 INFO - Running setup.py install for mozdebug 08:18:30 INFO - Running setup.py install for mozdevice 08:18:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Running setup.py install for mozfile 08:18:30 INFO - Running setup.py install for mozhttpd 08:18:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Running setup.py install for mozinfo 08:18:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Running setup.py install for mozInstall 08:18:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Running setup.py install for mozleak 08:18:30 INFO - Running setup.py install for mozlog 08:18:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:18:30 INFO - Running setup.py install for moznetwork 08:18:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:18:31 INFO - Running setup.py install for mozprocess 08:18:31 INFO - Running setup.py install for mozprofile 08:18:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:18:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:18:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:18:31 INFO - Running setup.py install for mozrunner 08:18:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:18:31 INFO - Running setup.py install for mozscreenshot 08:18:31 INFO - Running setup.py install for moztest 08:18:31 INFO - Running setup.py install for mozversion 08:18:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:18:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:18:31 INFO - Cleaning up... 08:18:31 INFO - Return code: 0 08:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:31 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:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:31 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:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:31 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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:31 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:18:31 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:18:31 INFO - Using env: {'DISPLAY': ':0', 08:18:31 INFO - 'HOME': '/home/cltbld', 08:18:31 INFO - 'LANG': 'en_US.UTF-8', 08:18:31 INFO - 'LANGUAGE': 'en_US:en', 08:18:31 INFO - 'LOGNAME': 'cltbld', 08:18:31 INFO - 'MAIL': '/var/mail/cltbld', 08:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:31 INFO - 'MOZ_NO_REMOTE': '1', 08:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:31 INFO - 'NO_EM_RESTART': '1', 08:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:31 INFO - 'PWD': '/builds/slave/test', 08:18:31 INFO - 'SHELL': '/bin/bash', 08:18:31 INFO - 'SHLVL': '1', 08:18:31 INFO - 'TERM': 'linux', 08:18:31 INFO - 'TMOUT': '86400', 08:18:31 INFO - 'USER': 'cltbld', 08:18:31 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:31 INFO - '_': '/tools/buildbot/bin/python'} 08:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:31 INFO - Running setup.py (path:/tmp/pip-VbZcZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:31 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:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:31 INFO - Running setup.py (path:/tmp/pip-mk741W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:32 INFO - Running setup.py (path:/tmp/pip-obiiX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:32 INFO - Running setup.py (path:/tmp/pip-POp4n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:32 INFO - Running setup.py (path:/tmp/pip-Prl_g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:32 INFO - Running setup.py (path:/tmp/pip-wpdr3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:32 INFO - Running setup.py (path:/tmp/pip-A4zT_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:32 INFO - Running setup.py (path:/tmp/pip-Yw_DpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:32 INFO - Running setup.py (path:/tmp/pip-lg1cA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:32 INFO - Running setup.py (path:/tmp/pip-Rjasi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:32 INFO - Running setup.py (path:/tmp/pip-smHKvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:32 INFO - Running setup.py (path:/tmp/pip-tih0kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:32 INFO - Running setup.py (path:/tmp/pip-osbnn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:32 INFO - Running setup.py (path:/tmp/pip-rFSoXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:32 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:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:32 INFO - Running setup.py (path:/tmp/pip-U3qGZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:33 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:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:33 INFO - Running setup.py (path:/tmp/pip-BnhIc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:33 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:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:33 INFO - Running setup.py (path:/tmp/pip-Lem0TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 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:18:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:34 INFO - Downloading blessings-1.6.tar.gz 08:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:18:34 INFO - Installing collected packages: blessings 08:18:34 INFO - Running setup.py install for blessings 08:18:34 INFO - Successfully installed blessings 08:18:34 INFO - Cleaning up... 08:18:34 INFO - Return code: 0 08:18:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:34 INFO - Reading from file tmpfile_stdout 08:18:34 INFO - Current package versions: 08:18:34 INFO - argparse == 1.2.1 08:18:34 INFO - blessings == 1.6 08:18:34 INFO - blobuploader == 1.2.4 08:18:34 INFO - docopt == 0.6.1 08:18:34 INFO - functools32 == 3.2.3-2 08:18:34 INFO - jsonschema == 2.5.1 08:18:34 INFO - manifestparser == 1.1 08:18:34 INFO - mozInstall == 1.13 08:18:34 INFO - mozcrash == 1.0 08:18:34 INFO - mozdebug == 0.1 08:18:34 INFO - mozdevice == 0.51 08:18:34 INFO - mozfile == 1.2 08:18:34 INFO - mozhttpd == 0.7 08:18:34 INFO - mozinfo == 0.10 08:18:34 INFO - mozleak == 0.1 08:18:34 INFO - mozlog == 3.5 08:18:34 INFO - moznetwork == 0.27 08:18:34 INFO - mozprocess == 0.25 08:18:34 INFO - mozprofile == 0.28 08:18:34 INFO - mozrunner == 6.13 08:18:34 INFO - mozscreenshot == 0.1 08:18:34 INFO - mozsystemmonitor == 0.3 08:18:34 INFO - moztest == 0.8 08:18:34 INFO - mozversion == 1.4 08:18:34 INFO - psutil == 3.1.1 08:18:34 INFO - requests == 1.2.3 08:18:34 INFO - wsgiref == 0.1.2 08:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:34 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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:34 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:18:34 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:18:34 INFO - Using env: {'DISPLAY': ':0', 08:18:34 INFO - 'HOME': '/home/cltbld', 08:18:34 INFO - 'LANG': 'en_US.UTF-8', 08:18:34 INFO - 'LANGUAGE': 'en_US:en', 08:18:34 INFO - 'LOGNAME': 'cltbld', 08:18:34 INFO - 'MAIL': '/var/mail/cltbld', 08:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:34 INFO - 'MOZ_NO_REMOTE': '1', 08:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:34 INFO - 'NO_EM_RESTART': '1', 08:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:34 INFO - 'PWD': '/builds/slave/test', 08:18:34 INFO - 'SHELL': '/bin/bash', 08:18:34 INFO - 'SHLVL': '1', 08:18:34 INFO - 'TERM': 'linux', 08:18:34 INFO - 'TMOUT': '86400', 08:18:34 INFO - 'USER': 'cltbld', 08:18:34 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:34 INFO - '_': '/tools/buildbot/bin/python'} 08:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:34 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:18:34 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:18:34 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:18:34 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:18:34 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:18:34 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:18:34 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:18:34 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:18:34 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:18:34 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:18: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:18: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:18: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:18: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:18:36 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:18:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:18: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:18: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:18: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:18: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:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:18:36 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:18:36 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:18:36 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:18:36 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:18:36 INFO - Installing collected packages: marionette-driver, simplejson 08:18:36 INFO - Running setup.py install for marionette-driver 08:18:36 INFO - Running setup.py install for simplejson 08:18:36 INFO - building 'simplejson._speedups' extension 08:18:36 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:18:37 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:18:37 INFO - Successfully installed marionette-driver simplejson 08:18:37 INFO - Cleaning up... 08:18:37 INFO - Return code: 0 08:18:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18:37 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:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:37 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:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:37 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 0x225c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cdb90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', '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:18:37 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:18:37 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:18:37 INFO - Using env: {'DISPLAY': ':0', 08:18:37 INFO - 'HOME': '/home/cltbld', 08:18:37 INFO - 'LANG': 'en_US.UTF-8', 08:18:37 INFO - 'LANGUAGE': 'en_US:en', 08:18:37 INFO - 'LOGNAME': 'cltbld', 08:18:37 INFO - 'MAIL': '/var/mail/cltbld', 08:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:37 INFO - 'MOZ_NO_REMOTE': '1', 08:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:37 INFO - 'NO_EM_RESTART': '1', 08:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:37 INFO - 'PWD': '/builds/slave/test', 08:18:37 INFO - 'SHELL': '/bin/bash', 08:18:37 INFO - 'SHLVL': '1', 08:18:37 INFO - 'TERM': 'linux', 08:18:37 INFO - 'TMOUT': '86400', 08:18:37 INFO - 'USER': 'cltbld', 08:18:37 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:37 INFO - '_': '/tools/buildbot/bin/python'} 08:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:18:37 INFO - Cleaning up... 08:18:37 INFO - Return code: 0 08:18:37 INFO - Running post-action listener: _resource_record_post_action 08:18:37 INFO - Running post-action listener: _start_resource_monitoring 08:18:37 INFO - Starting resource monitoring. 08:18:37 INFO - [mozharness: 2017-07-16 15:18:37.853092Z] Finished create-virtualenv step (success) 08:18:37 INFO - [mozharness: 2017-07-16 15:18:37.853609Z] Running install step. 08:18:37 INFO - Running pre-action listener: _resource_record_pre_action 08:18:37 INFO - Running main action method: install 08:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:38 INFO - Reading from file tmpfile_stdout 08:18:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:18:38 INFO - Reading from file tmpfile_stdout 08:18:38 INFO - Output received: 08:18:38 INFO - Usage: mozinstall [options] installer 08:18:38 INFO - Options: 08:18:38 INFO - -h, --help show this help message and exit 08:18:38 INFO - -d DEST, --destination=DEST 08:18:38 INFO - Directory to install application into. [default: 08:18:38 INFO - "/builds/slave/test"] 08:18:38 INFO - --app=APP Application being installed. [default: firefox] 08:18:38 INFO - mkdir: /builds/slave/test/build/application 08:18:38 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:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:18:56 INFO - Reading from file tmpfile_stdout 08:18:56 INFO - Output received: 08:18:56 INFO - /builds/slave/test/build/application/firefox/firefox 08:18:56 INFO - Running post-action listener: _resource_record_post_action 08:18:56 INFO - [mozharness: 2017-07-16 15:18:56.090572Z] Finished install step (success) 08:18:56 INFO - [mozharness: 2017-07-16 15:18:56.090915Z] Running setup-mitmproxy step. 08:18:56 INFO - Running pre-action listener: _resource_record_pre_action 08:18:56 INFO - Running main action method: setup_mitmproxy 08:18:56 INFO - Skipping: mitmproxy is not required 08:18:56 INFO - Running post-action listener: _resource_record_post_action 08:18:56 INFO - [mozharness: 2017-07-16 15:18:56.092598Z] Finished setup-mitmproxy step (success) 08:18:56 INFO - [mozharness: 2017-07-16 15:18:56.092908Z] Running run-tests step. 08:18:56 INFO - Running pre-action listener: _resource_record_pre_action 08:18:56 INFO - Running pre-action listener: _set_gcov_prefix 08:18:56 INFO - Running main action method: run_tests 08:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:18:56 INFO - Python 2.7.3 08:18:56 INFO - Return code: 0 08:18:56 INFO - grabbing minidump binary from tooltool 08:18:56 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:18:56 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 0x25cad10>, '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 0x25cbc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25cc0c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:18:56 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:18:56 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:18:56 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:18:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:18:56 INFO - Return code: 0 08:18:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:18:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:18:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:18:56 INFO - ENV: RUST_BACKTRACE is now 1 08:18:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:18:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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:18:56 INFO - Using env: {'DISPLAY': ':0', 08:18:56 INFO - 'HOME': '/home/cltbld', 08:18:56 INFO - 'LANG': 'en_US.UTF-8', 08:18:56 INFO - 'LANGUAGE': 'en_US:en', 08:18:56 INFO - 'LOGNAME': 'cltbld', 08:18:56 INFO - 'MAIL': '/var/mail/cltbld', 08:18:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:56 INFO - 'MOZ_NO_REMOTE': '1', 08:18:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:56 INFO - 'NO_EM_RESTART': '1', 08:18:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:56 INFO - 'PWD': '/builds/slave/test', 08:18:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:56 INFO - 'RUST_BACKTRACE': '1', 08:18:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:18:56 INFO - 'SHELL': '/bin/bash', 08:18:56 INFO - 'SHLVL': '1', 08:18:56 INFO - 'TERM': 'linux', 08:18:56 INFO - 'TMOUT': '86400', 08:18:56 INFO - 'USER': 'cltbld', 08:18:56 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235', 08:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:56 INFO - '_': '/tools/buildbot/bin/python'} 08:18:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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:18:56 INFO - mozversion application_buildid: 20170716143154 08:18:56 INFO - mozversion application_changeset: c1185e615e55949151f20c66d55b0e7e62034adb 08:18:56 INFO - mozversion application_display_name: Nightly 08:18:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:18:56 INFO - mozversion application_name: Firefox 08:18:56 INFO - mozversion application_remotingname: firefox 08:18:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:18:56 INFO - mozversion application_vendor: Mozilla 08:18:56 INFO - mozversion application_version: 56.0a1 08:18:56 INFO - mozversion platform_buildid: 20170716143154 08:18:56 INFO - mozversion platform_changeset: c1185e615e55949151f20c66d55b0e7e62034adb 08:18:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:18:56 INFO - mozversion platform_version: 56.0a1 08:18:56 INFO - using testdate: 1500218336 08:18:56 INFO - actual date: 1500218336 08:18:56 INFO - starting webserver on 'localhost:38464' 08:18:56 INFO - SUITE-START | Running 2 tests 08:18:56 INFO - TEST-START | dromaeo_css 08:18:56 INFO - Initialising browser for dromaeo_css test... 08:18:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38464/getInfo.html -profile /tmp/tmpcb3mpA/profile 08:18:56 INFO - TEST-INFO | started process 3477 (/builds/slave/test/build/application/firefox/firefox http://localhost:38464/getInfo.html) 08:19:04 INFO - TEST-INFO | 3477: exit 0 08:19:04 INFO - Browser initialized. 08:19:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:04 INFO - TEST-INFO | started process 3685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb3mpA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:16 INFO - PID 3685 | RSS: Main: 167174144 08:19:16 INFO - PID 3685 | 08:22:14 INFO - PID 3685 | Cycle 1(1): loaded http://localhost:38464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38464/tests/dromaeo/cssquery-ext.html) 08:22:15 INFO - PID 3685 | RSS: Main: 175157248 08:22:15 INFO - PID 3685 | 08:25:17 INFO - PID 3685 | Cycle 1(1): loaded http://localhost:38464/tests/dromaeo/cssquery-ext.html (next: http://localhost:38464/tests/dromaeo/cssquery-jquery.html) 08:25:18 INFO - PID 3685 | RSS: Main: 173027328 08:25:18 INFO - PID 3685 | 08:28:19 INFO - PID 3685 | Cycle 1(1): loaded http://localhost:38464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38464/tests/dromaeo/cssquery-mootools.html) 08:28:20 INFO - PID 3685 | RSS: Main: 175333376 08:28:20 INFO - PID 3685 | 08:31:21 INFO - PID 3685 | Cycle 1(1): loaded http://localhost:38464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38464/tests/dromaeo/cssquery-prototype.html) 08:31:22 INFO - PID 3685 | RSS: Main: 174555136 08:31:22 INFO - PID 3685 | 08:34:25 INFO - PID 3685 | Cycle 1(1): loaded http://localhost:38464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38464/tests/dromaeo/cssquery-yui.html) 08:34:26 INFO - PID 3685 | RSS: Main: 174043136 08:34:26 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | Cycle 1(1): loaded http://localhost:38464/tests/dromaeo/cssquery-yui.html (next: http://localhost:38464/tests/dromaeo/cssquery-dojo.html) 08:37:28 INFO - PID 3685 | RSS: Main: 176762880 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | __start_tp_report 08:37:28 INFO - PID 3685 | _x_x_mozilla_page_load 08:37:28 INFO - PID 3685 | _x_x_mozilla_page_load_details 08:37:28 INFO - PID 3685 | |i|pagename|runs| 08:37:28 INFO - PID 3685 | |0;dojo.html;3009.623797025372;3054.847257637118;3067.279189390493;3069.508878579428;3082.9691703082963;5874.030784920488;5886.587938844283;5910.852228694284;5911.733971971266;5962.940370596293;5936.673482958436;5944.405559444053;5950.821475355736;5962.403759624035;5970.253718285215;5422.078246698071;5427.3215848019;5442.401335853053;5449.373322067973;5457.672539647634;5465.371482279549;5478.863028424302;5494.5054945054935;5499.807506737265;5510.228568000483;5472.945270547283;5476.014317422862;5476.7535460904355;5478.726063696819;5480.013597552439;5475.972620136914;5476.342838859323;5482.725863706799;5485.725713714299;5489.807856725015;5378.327709036371;5436.809711660112;5465.398806131322;5518.530924871391;5602.215689803431;5954.5534084943365;6013.128096426038;6018.759249630009;6037.818865434044;6078.574499785017;6271.749130034793;6410.1987251593555;6449.3873082057125;6489.059086432441;6516.902246466307;6469.061986012002;6480.57876238043;6521.673916304213;6556.672166391661;6563.048357988113;6072.180255665517;6109.541784366146;6112.419320164578;6114.571979961404;6130.356312587203;6646.90029649546;6651.16860392451;6717.66411679419;6730.831729206809;6731.225909020427;6298.789230524183;6327.525435592257;6401.103845461639;6432.71052802625;6440.4847612190915;6205;6303.36966303366;6471.223453185554;6497.675116244169;6517.608943463408;6277.52918531112;6302.527310451735;6355.237371515448;6368.936310636835;6395.16862807832;6385.584936979174;6395.456386207225;6461.224653041665;6476.384743449365;6480.546361754727;5085.542301192911;5176.275321454999;5182.170852663556;5232.869178270574;5235.712035837989;4446.510883802779;4473.239549276631;4473.507914129443;4481;4489.820407183742;5564.387917329091;5571.913476871971;5577.024020796425;5578.693171875586;5581.995240856685;6386.904196437057;6455.870882582322;6463.515236357292;6465.515086368541;6465.676716164267;5502.422245664147;5549.112142057332;5581.162825576196;5585.162225666101;5586.804461843816;5666.15007748841;5678.119891416837;5680.204771332017;5682.6306290091015;5690.7439165237665;5273.419923808378;6202.125397461129;6267.780627678009;6283.120363149163;6383.489320854321;6513.967430162819;6518.1200537927725;6523.739050437929;6593.044008618627;6598.571092879043;6208;6235.906461403173;6284.905726414016;6316.557840951273;6363.745450181941;6163.722632481638;6228.844278893064;6248.281447633581;6257.906131408124;6448.871022579616;5449.9562664001;6308.053791931064;6333.556651034568;6523.478121750343;6615.338466153346;6281.183446151971;6294.653794041372;6313.905291420724;6374.426301632875;6389.8722025560155;6297.96851015742;6300.779472718433;6330.303666596763;6355.459785918064;6365.840853978502;6081;6124.112003759341;6141.785037523665;6145.293291271561;6279.686015699288;6215.533834962486;6248.4688801452385;6278.497720182466;6306.684665766785;6313.463355614824;5219.530242278061;6013.037913933749;6038.698065096815;6082;6158.599691020069 08:37:28 INFO - PID 3685 | |1;ext.html;813.4265342933229;855.5593869157383;889.5552223888056;893.3121496447733;1174.131142954214;29077.41845163098;29597.40805183898;39709.205815883666;40485.59514404855;40892;40530;40639.59360406395;40815;40910.7954460228;41127.38308925361;7397.445191610637;7587.658555364994;7639.847203055935;7649.655765490566;7652.349550288232;7372.447066470009;7464.440166987471;7473.4021278297605;7487.438442116836;7522.962385188066;7310.561366318038;7489.513181643176;7564.773056808304;7600.353969912564;7607.733729319475;7500.137484189334;7552.924470755277;7554.093508778982;7573.6213189340315;7589.468737188399;7436.962815185943;7471.514351567131;7499;7523.510971786816;7524.134724506697;37133.07167320811;37628.43557346642;37638.059048524;37800.43299350512;37935.24129517394;3460.2560449503476;3498.860045598173;3502.404591219499;3508;3544.379733546619;30119;30352.392952141054;30356.241093972607;30428.69571304281;30490.39019219603;4820.373351464323;4839.516048395132;4847.660663753539;4879.975600122012;4931.260310953386;212900;217973;219655;222219;222417;48935.26597101046;49046.26430603544;49253;49302.26046609304;49317.50682493129;50096.49903500918;50131.74934125306;50300.49699503031;50589;50716.49283507118;16171.595710107342;16321.755173672404;16352.427665031666;16531.66936661284;16534.421295254608;13599.048066635438;13633.454661813616;13657.795133073012;13669;13670.726585468434;14142.505012324726;14221.502247421291;14344.282785860665;14384;14461;5636.239107720406;5794.420557944256;5795.9420405796245;5801.82594522165;5983.491403230687;978.188103873783;997.9950100249453;1006.7382480555109;1018.0277834667875;1025.179856115105;22168.1132754688;22226.666600001012;22282.331530054125;22589.548209035725;28544.71455285462;1098.785736781336;1101.944902754859;1111.155521803419;1116.3971455414148;1125.0774365020604;12170.81743773844;12429;12449.128561000824;12466.81299780504;12479.688007799696;223760;226845;226975;227434;227919;44094.11811763811;52086;52572.73713631407;52651.47348526466;52673.7366313166;1331.2079312808862;1339.8995075369387;1351.959441216765;1463.0928824129107;1488.6278430392185;26243.343916402242;26590.601140982515;27225.59161612617;27285.72714272832;27576;36325.45511817378;36520.63479365279;36535.45196822103;36694.44958325574;36754.63245367619;136990;137964.31017844848;138768.30615846856;139044;139552;32390.83804580962;32624.510632340058;32871;32901;32904.696671232785;38198.61801382062;40185.39721904232;40761.59238407697;41284.1743165129;41592.1681566373;29245.415091698473;30694.693053069182;30697;31056.378872422876;31159.376812464077;29879;30249.848750756104;31028.68971310258;33168.668313317525;34010.65989340075;36685.26629467449;36989.815050924575;37288.067798304175;37372.81313593415;37925.431118533794;31572;32216.872409465555;32220.355592887543;32496.35007299888;33413.49879751854;23531.17640882561;23947.042118315072;24374.146904858244;24393.51212975766;24719.50560988806 08:37:28 INFO - PID 3685 | |2;jquery.html;551.2062629813068;562.1623780566954;564.5793883556751;578.4129108954411;593.1636392686312;21509;22092.8895355523;22230.888845555768;22269.66595501069;22322.776772232293;23940.281791546236;24924.12765553206;26323.210303690874;26415.735842641567;26484.337891552674;6380.585261957969;6457.225132984025;6486.448651864597;6493.090967264587;6509.869802603945;6355.205599300088;6366.299707032223;6377.107204991305;6395.328490508499;6429.38920802523;3853.8651147209853;5924.496417804492;6396.5202609804455;6404.103425520431;6465.579737317059;6426.260979987291;6427.550071494998;6450.516211284125;6454.612723236621;6455.677216139221;5987.221661184061;5994.040953447471;6005.579609427342;6012.75948962041;6041.728122234466;28137.859310703316;29918.102456926328;30253.24366890823;30318.242043949078;30343.69656303453;1907.4849790556611;1975.9012049397472;1981.3758666020158;1985.2753744883157;1991.0343483410534;17709.20308586117;18356.90821545897;18378.1729822157;18382.632347353112;18415.44753657379;2246.4047027537717;2286.0512887151813;2286.371247906822;2358.516504116652;2368.265837590335;133056;136675;136745;137143;137724.31137844248;13703.45186192541;14900.478483253035;15151.696966060617;15152.242387880562;15184.772228416583;23809.52380952371;23855.642165367186;23868.761312387;23883.28350149498;23889.641655375184;10420;10530.15758739299;10569.894301057046;10608.257421980386;10840.891591084146;9863;9905.158061564847;9950.35322704022;9964.10323070927;10057.748556286151;9046.366754327266;9235.676751313671;9379.859302110473;9495.90504094964;9546.331756777097;2517.5971844504793;2673.8395696258285;2717.9864100679765;2750.944981100407;2830.6315484573292;923.1184219070772;953.7472569769017;967.9836172019352;969.970900872975;974.9567962280292;19407.611847762964;19576.902115489615;20097.095630696655;20381.796182038288;22974.77025229726;1016.7508960304773;1033.1476531861244;1041.073444634276;1050.7163065972145;1059.1791361694595;12994.805077923838;13943.372548235353;14044.227567483682;14187.290635468391;14340;502157;503390;504658;520483;524237;119059.40470297592;119311;122938;123689;123910.38044809719;1262.3688155922039;1272.8981681465461;1296.7212049409422;1311.9934400327936;1312.0422091872795;19792.604147916674;20652.07065682018;20781.688274676195;20790.480237994172;21249.36251912445;55108.72445637907;57384;57872.71063644655;57927.4207257922;57978.130328045954;70926.64536677283;70938.29061709317;72659;72831.63584182045;73179.63410182916;14162.079464834753;14517.274136293354;14683.853161468676;14966.476173333882;14969;22875.428114297276;22954.54090918206;23152;23152.4211894704;23259.651105233097;17695.64608707793;17737.29050837952;17757.911210443865;17900.820991790435;18243.179056942736;15228.77156842626;15590.532284031497;15738.370465181264;15896.205189740698;17238.310467581156;19828.405147845588;20406.877621730946;20432;20545.178192872118;20566.897165514078;20909.477263068544;21301.6804747932;21618.783812161677;22196.667049994587;22311.665325019814;17113.401030963858;17213.74179387285;17236.74144887853;17356.21897014612;17412.39056633012 08:37:28 INFO - PID 3685 | |3;mootools.html;1317.1965101288215;1375.2711063136528;1390.1659004597243;1392.7771556550954;1393.5053056165061;13189.8021529677;14020.158790472578;14095.577132686023;14120.29398530072;14160.221187834677;13572.93213533931;14032.92983535081;14061.578152655411;14068.929655351709;14069.92965035176;2536.822422430431;2576.943453184195;2584.883680234394;2597.2727636261875;2607.634931109646;2527.9620805687928;2613.59489279162;2614.5293847107514;2614.6208799724027;2623.0950322138833;2515.962260566093;2546.898124075035;2561.346856551586;2578.2909699832603;2580.0711743772226;2427.2960841355984;2471.7281099079087;2476.4304210031614;2482.056818409002;2492.8628925409093;2320.6286994081033;2326.325365643961;2356.587597170488;2378.500514891875;2383.713954325492;13277.933610331984;13572.728545429134;13575.185488870698;13593.932030339785;13634.386452609657;7223.349898509106;7532.54804711719;7534.208908064629;7535.1334596521;7545.7358992435;4666.510016448292;4888.608911287089;4928.063667903087;4974.1543937530705;4996.600271978233;1819.2359209132064;1850.8622540965207;1877.896795501833;1899.591587808614;1904.3239649924217;20889.5822083559;20978.475538111517;21193.894030529904;21234;21583.244586439556;5549.667019978814;5702.6293290935955;6166.4758495527485;6406.103145559626;6416.262129855127;15005.24973751308;15160.393584256726;15162.393504259926;15231.47685231468;15287.770683439758;7096.396806271525;7241.710331586783;7268;7290.088738907637;7330.560166390033;6508.479321654257;6612.173478315211;6635.071090047397;6657.267700552935;6742;4716.481187069419;4757.595604373667;4980.975095124501;4996.950640365491;5042.168042272984;1419.5031738891305;1445.4724025730532;1449.8405175430694;1461.4738694070127;1462.21771352326;860.870869369587;865.7489328094782;891.4784850862188;894.5661354243186;909.3634455880909;7991.561518926649;8100.554469504234;8172;8298.958505207556;8328.250457458858;960.8943016268205;974.3179774158118;991.9305648604673;1009.3893194617298;1020.3826684855555;4789.592884604778;4837.129316722953;5118.078745825713;5136.666116702402;5148.433672296044;17795.46613601594;18737.437876863714;18789.812101878808;18809.435716928514;18915.527111822314;16985;19251.711224331648;19325.13036913342;19361;19372.612547748966;10560.260781745357;10797.29817561856;10803.945980270206;10827.133829293638;10872.61945831892;7514.009550945898;8300.418970671995;8348.165183481604;8372.623231954454;8391.370647201362;15820.60448488797;16305.103219323051;16347.59131021734;16617.83382166163;16681.165941703108;15424.383024678888;15758.448454304043;15928.283227255033;17001.914990425463;17134.742978855076;10610.8408373876;11521.481533331187;11528.423578820857;11533.480993355151;11563.88436115628;12823.93588032054;13010.154339967872;13016.739665206833;13068.934655326662;13109.213447193199;9769;9941.403515789076;10019.699409017741;10412.68761937143;10592.046715795615;9895.604175832887;10261.794764104527;10374.118199953089;10480.371177729361;10764.40795756241;8778.956105219433;8829.69096081634;8851.557422128997;8862.379633425857;8883.067277935983;6482.675866206765;6718.193816742022;6792.9470932005615;6870.936864356192;6879.415249703831;6771.153605799275;6872.553284036521;6914.792556223321;6937;7032.894506582303 08:37:28 INFO - PID 3685 | |4;prototype.html;475.4176134235564;493.57799081785083;512.8282025521451;519.5505887407392;520.7346148858273;6160.106784516248;6179.938200617992;6198.2252218472695;6199.969000155004;6217.253929528457;5702.230198923144;5912.201852749878;6058.545609079315;6095.634261944276;6133.355997620252;5078.136716758141;5110.156824124015;5138.9743051284695;5147.1764517677175;5156.96860627875;5007.624428167884;5065.1005872797705;5070.2141168119;5092.275632536594;5112.182050871861;5069.74651267437;5101.846944591668;5113.386393632769;5129.871753206181;5153.330067091291;4891.706497610155;5034.697918124888;5043.773030213649;5087.669301495391;5118.976204759045;4671.178240486213;4706.788194531255;4758.3100450434495;4763.452202996665;4781.139394908915;5966.164736936832;5997.280326360821;6026;6030.457258846681;6059;5908.852278693024;5922.3781502942;5925.20009798676;6003.759849606011;6010.519158467312;6435.806925792187;6471.7734879279;6511.93488065118;6551.672416379162;6618.30507796684;5250.5274525292525;5258.474152584749;5281.07581173297;5286.550643195333;5306.752913065427;6849.7945061648725;6861.519693621449;6875.759348422831;6878.89937609985;6914.154986563316;5425.810096646598;5451.836444906659;5477.616566840283;5495.917561236584;5515.751791169407;5526.447355264522;5536.252605898233;5579.888402231933;5597.328320601554;5609.887802244014;5866.208061911588;5894.351621321737;5925.377835327228;5928;6012.158297838306;6476.870462590722;6540.149780528501;6549.410553050248;6581.86836263272;6607.041978913031;1904.4762690260013;1936.244864502845;1942.3978566644385;1947.2989723699457;1953.746013018327;1328.9269090200132;1415.4762737787084;1425.6435891027243;1449.289847974506;1449.811524501808;5493.7802487900035;5565.972170139124;5647.661140331511;5667.914981275284;5714.114312281603;6495.805125846232;6527.902081468782;6535.248446428722;6629.834254143685;6690.2306234782645;5645.2096706461125;5658.377578466366;5675.836453527017;5707.914381284284;5724.398938111522;3498.003069125338;3507.7898125146785;3534.416821224469;3535.7171426285836;3539.486774417695;6445.51658625605;6453.419192272718;6468.191476065492;6542.901856472156;6580.012188908071;6770.763023294259;6778.3221677831825;6797.830054248683;6833.214180369222;6898.689558969859;6438.806835794933;6447.194100737408;6454.6449945252525;6471.708773105222;6528.21661400635;6629.801105966829;6708.161479815023;6742.595444273359;6756;6767.323267673391;6572.375624315682;6591.439727623206;6624.701888415129;6632.535722499379;6681.732730690718;6342.746290148342;6390.488760899024;6406.526498905185;6441.581297215666;6466.06242094903;5336.493033161843;5367.919481207707;5383.461653834742;5434.510894019557;5434.891302174014;6602.1747281589805;6709.429698475489;6710.496712746662;6720.193576770819;6729.2934241903895;6452.935470645233;6491.545591808528;6492.837679058061;6541.574797638138;6543.672816359258;6430;6501.1548498694865;6516.609003459807;6527.2167339919515;6552.082708420729;6339.175907132043;6358.427741503287;6368.458681011981;6435.646039467687;6469.482441404771;6356.523260755369;6419.133416988647;6420.165378500765;6434.661858069891;6448.645324507197;5905.970470147622;6165.951788195927;6173.796109758554;6265.561410701207;6274.686265686789 08:37:28 INFO - PID 3685 | |5;yui.html;901.1214066285372;901.2249465459707;920.4431319051976;920.8020275640736;921.1341339141211;17508.56228594286;18138.637227255447;18282.360117395892;18313.267469301212;18356.17397217125;17460.650786984254;18091.366802161927;18723.157457914393;18798.53003674909;18856.717149242773;1005.7586179316966;1032.4785983078573;1035.337384074193;1036.3056751976194;1037.2169012395668;1032.8554002439664;1047.4396198034053;1050.1756121444666;1054.910332621728;1057.7249915022112;1109.1348747976551;1111.4442778610694;1111.8443417921496;1115.24720813451;1117.9385133817636;1035.5961175141701;1082.2802836113974;1083.4203701019956;1086.6685660873432;1092.9453527323642;785.4933567848763;791.3629528229773;796.1799346672937;797.2784629909941;798.2855344466669;17267.136643167792;17378.739318910226;17452.127393630268;17476.47570572872;18028.819711802975;19783.703244451346;20299.188032478683;20436.38690839277;20530;20586.5882682347;15612.375504979787;16050.1172435516;16051;16064;16100.516984490485;3489.1974845785358;3542.096765324826;3554.680078792921;3556.8577256909693;3564.536610240678;104487.47756261246;105233.94766052318;109406.45296773466;109961.45019274933;110029;15603.765943510856;15992.200389980455;16107.436239731553;16174.676506469805;16264.83735162657;25371.87314063418;29103;29344.559831602543;29400.558991614715;29762;8527.18991695788;8854.778630534289;8873.423227490193;8892.421992570462;8902.777430564158;3845.0771814764257;4097.774622395737;4122.9381559276635;4215.662746980234;4223.282042052859;4849.466558678542;5002.449730529639;5012.223105418666;5029.5221953914315;5044.4198917125;994.3089552760762;1006.0744115413837;1011.7470632341915;1019.1642852860731;1021.0198209718604;582.1849410824794;647.1683886206202;667.5260564998808;681.0669382945397;710.5701050864257;11821.88178118225;11903.523859045541;12536.81194782079;12681.429335679917;12795.424205910756;663.5222639699409;668.9531732778756;687.669918439152;694.5832500499761;705.7776800307989;4986.401631804134;5105.004524117836;5112.284280200774;5150.356205474316;5315.016721906382;95839;96249;98431.50784246033;100365.49817250867;101370;84357.57821210855;87264.56367718248;87372.56313718518;89051.55474222587;90321.09678903258;73986;77639.61180194176;77777.61111194408;78066.21933780704;80767.59616201882;10750.247482676137;10908.890911090788;11048.226624136234;11204.887951120385;12396.81404778911;34304.142396440286;35245.29509409849;36345;36665;37455.438168426954;63699;65209;66340.33659663534;66388;66678;17906.462806115836;18442.907785460986;18545;18784.53038674044;18804.15381307817;19961.301354452524;20182.192712291344;20184.79815201829;20713.887006100427;21648.567028659025;18605.348812791486;18690.719639205694;18796.906015470384;19182.712259315842;19262.518437038627;18245.817541824414;18672.626547468702;18809.90595047016;18928.14823332926;19393.61212775765;17310.913445433194;17765.555861103578;18132.818671813115;18306.450806475827;18916;13125;13422.798658020332;13501.189928604315;13844.653883652989;14015.50945716895;13318;13384.19694818314;13431.932840335736;13925.582232533041;14115.858841411866 08:37:28 INFO - PID 3685 | __end_tp_report 08:37:28 INFO - PID 3685 | __start_cc_report 08:37:28 INFO - PID 3685 | _x_x_mozilla_cycle_collect,374 08:37:28 INFO - PID 3685 | __end_cc_report 08:37:28 INFO - PID 3685 | __startTimestamp1500219448410__endTimestamp 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | ------- Summary: start ------- 08:37:28 INFO - PID 3685 | Number of tests: 6 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | [#0] dojo.html Cycles:165 Average:5907.68 Median:6130.36 stddev:706.86 (11.5%) stddev-sans-first:671.48 08:37:28 INFO - PID 3685 | Values: 3009.6 3054.8 3067.3 3069.5 3083.0 5874.0 5886.6 5910.9 5911.7 5962.9 5936.7 5944.4 5950.8 5962.4 5970.3 5422.1 5427.3 5442.4 5449.4 5457.7 5465.4 5478.9 5494.5 5499.8 5510.2 5472.9 5476.0 5476.8 5478.7 5480.0 5476.0 5476.3 5482.7 5485.7 5489.8 5378.3 5436.8 5465.4 5518.5 5602.2 5954.6 6013.1 6018.8 6037.8 6078.6 6271.7 6410.2 6449.4 6489.1 6516.9 6469.1 6480.6 6521.7 6556.7 6563.0 6072.2 6109.5 6112.4 6114.6 6130.4 6646.9 6651.2 6717.7 6730.8 6731.2 6298.8 6327.5 6401.1 6432.7 6440.5 6205.0 6303.4 6471.2 6497.7 6517.6 6277.5 6302.5 6355.2 6368.9 6395.2 6385.6 6395.5 6461.2 6476.4 6480.5 5085.5 5176.3 5182.2 5232.9 5235.7 4446.5 4473.2 4473.5 4481.0 4489.8 5564.4 5571.9 5577.0 5578.7 5582.0 6386.9 6455.9 6463.5 6465.5 6465.7 5502.4 5549.1 5581.2 5585.2 5586.8 5666.2 5678.1 5680.2 5682.6 5690.7 5273.4 6202.1 6267.8 6283.1 6383.5 6514.0 6518.1 6523.7 6593.0 6598.6 6208.0 6235.9 6284.9 6316.6 6363.7 6163.7 6228.8 6248.3 6257.9 6448.9 5450.0 6308.1 6333.6 6523.5 6615.3 6281.2 6294.7 6313.9 6374.4 6389.9 6298.0 6300.8 6330.3 6355.5 6365.8 6081.0 6124.1 6141.8 6145.3 6279.7 6215.5 6248.5 6278.5 6306.7 6313.5 5219.5 6013.0 6038.7 6082.0 6158.6 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | [#1] ext.html Cycles:180 Average:36345.68 Median:18735.46 stddev:51591.02 (275.4%) stddev-sans-first:51666.76 08:37:28 INFO - PID 3685 | Values: 813.4 855.6 889.6 893.3 1174.1 29077.4 29597.4 39709.2 40485.6 40892.0 40530.0 40639.6 40815.0 40910.8 41127.4 7397.4 7587.7 7639.8 7649.7 7652.3 7372.4 7464.4 7473.4 7487.4 7523.0 7310.6 7489.5 7564.8 7600.4 7607.7 7500.1 7552.9 7554.1 7573.6 7589.5 7437.0 7471.5 7499.0 7523.5 7524.1 37133.1 37628.4 37638.1 37800.4 37935.2 3460.3 3498.9 3502.4 3508.0 3544.4 30119.0 30352.4 30356.2 30428.7 30490.4 4820.4 4839.5 4847.7 4880.0 4931.3 212900.0 217973.0 219655.0 222219.0 222417.0 48935.3 49046.3 49253.0 49302.3 49317.5 50096.5 50131.7 50300.5 50589.0 50716.5 16171.6 16321.8 16352.4 16531.7 16534.4 13599.0 13633.5 13657.8 13669.0 13670.7 14142.5 14221.5 14344.3 14384.0 14461.0 5636.2 5794.4 5795.9 5801.8 5983.5 978.2 998.0 1006.7 1018.0 1025.2 22168.1 22226.7 22282.3 22589.5 28544.7 1098.8 1101.9 1111.2 1116.4 1125.1 12170.8 12429.0 12449.1 12466.8 12479.7 223760.0 226845.0 226975.0 227434.0 227919.0 44094.1 52086.0 52572.7 52651.5 52673.7 1331.2 1339.9 1352.0 1463.1 1488.6 26243.3 26590.6 27225.6 27285.7 27576.0 36325.5 36520.6 36535.5 36694.4 36754.6 136990.0 137964.3 138768.3 139044.0 139552.0 32390.8 32624.5 32871.0 32901.0 32904.7 38198.6 40185.4 40761.6 41284.2 41592.2 29245.4 30694.7 30697.0 31056.4 31159.4 29879.0 30249.8 31028.7 33168.7 34010.7 36685.3 36989.8 37288.1 37372.8 37925.4 31572.0 32216.9 32220.4 32496.4 33413.5 23531.2 23947.0 24374.1 24393.5 24719.5 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | [#2] jquery.html Cycles:180 Average:35847.95 Median:2266.23 stddev:85879.18 (3789.5%) stddev-sans-first:86079.20 08:37:28 INFO - PID 3685 | Values: 551.2 562.2 564.6 578.4 593.2 21509.0 22092.9 22230.9 22269.7 22322.8 23940.3 24924.1 26323.2 26415.7 26484.3 6380.6 6457.2 6486.4 6493.1 6509.9 6355.2 6366.3 6377.1 6395.3 6429.4 3853.9 5924.5 6396.5 6404.1 6465.6 6426.3 6427.6 6450.5 6454.6 6455.7 5987.2 5994.0 6005.6 6012.8 6041.7 28137.9 29918.1 30253.2 30318.2 30343.7 1907.5 1975.9 1981.4 1985.3 1991.0 17709.2 18356.9 18378.2 18382.6 18415.4 2246.4 2286.1 2286.4 2358.5 2368.3 133056.0 136675.0 136745.0 137143.0 137724.3 13703.5 14900.5 15151.7 15152.2 15184.8 23809.5 23855.6 23868.8 23883.3 23889.6 10420.0 10530.2 10569.9 10608.3 10840.9 9863.0 9905.2 9950.4 9964.1 10057.7 9046.4 9235.7 9379.9 9495.9 9546.3 2517.6 2673.8 2718.0 2750.9 2830.6 923.1 953.7 968.0 970.0 975.0 19407.6 19576.9 20097.1 20381.8 22974.8 1016.8 1033.1 1041.1 1050.7 1059.2 12994.8 13943.4 14044.2 14187.3 14340.0 502157.0 503390.0 504658.0 520483.0 524237.0 119059.4 119311.0 122938.0 123689.0 123910.4 1262.4 1272.9 1296.7 1312.0 1312.0 19792.6 20652.1 20781.7 20790.5 21249.4 55108.7 57384.0 57872.7 57927.4 57978.1 70926.6 70938.3 72659.0 72831.6 73179.6 14162.1 14517.3 14683.9 14966.5 14969.0 22875.4 22954.5 23152.0 23152.4 23259.7 17695.6 17737.3 17757.9 17900.8 18243.2 15228.8 15590.5 15738.4 15896.2 17238.3 19828.4 20406.9 20432.0 20545.2 20566.9 20909.5 21301.7 21618.8 22196.7 22311.7 17113.4 17213.7 17236.7 17356.2 17412.4 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | [#3] mootools.html Cycles:180 Average:8434.43 Median:2474.08 stddev:5686.21 (229.8%) stddev-sans-first:5677.01 08:37:28 INFO - PID 3685 | Values: 1317.2 1375.3 1390.2 1392.8 1393.5 13189.8 14020.2 14095.6 14120.3 14160.2 13572.9 14032.9 14061.6 14068.9 14069.9 2536.8 2576.9 2584.9 2597.3 2607.6 2528.0 2613.6 2614.5 2614.6 2623.1 2516.0 2546.9 2561.3 2578.3 2580.1 2427.3 2471.7 2476.4 2482.1 2492.9 2320.6 2326.3 2356.6 2378.5 2383.7 13277.9 13572.7 13575.2 13593.9 13634.4 7223.3 7532.5 7534.2 7535.1 7545.7 4666.5 4888.6 4928.1 4974.2 4996.6 1819.2 1850.9 1877.9 1899.6 1904.3 20889.6 20978.5 21193.9 21234.0 21583.2 5549.7 5702.6 6166.5 6406.1 6416.3 15005.2 15160.4 15162.4 15231.5 15287.8 7096.4 7241.7 7268.0 7290.1 7330.6 6508.5 6612.2 6635.1 6657.3 6742.0 4716.5 4757.6 4981.0 4997.0 5042.2 1419.5 1445.5 1449.8 1461.5 1462.2 860.9 865.7 891.5 894.6 909.4 7991.6 8100.6 8172.0 8299.0 8328.3 960.9 974.3 991.9 1009.4 1020.4 4789.6 4837.1 5118.1 5136.7 5148.4 17795.5 18737.4 18789.8 18809.4 18915.5 16985.0 19251.7 19325.1 19361.0 19372.6 10560.3 10797.3 10803.9 10827.1 10872.6 7514.0 8300.4 8348.2 8372.6 8391.4 15820.6 16305.1 16347.6 16617.8 16681.2 15424.4 15758.4 15928.3 17001.9 17134.7 10610.8 11521.5 11528.4 11533.5 11563.9 12823.9 13010.2 13016.7 13068.9 13109.2 9769.0 9941.4 10019.7 10412.7 10592.0 9895.6 10261.8 10374.1 10480.4 10764.4 8779.0 8829.7 8851.6 8862.4 8883.1 6482.7 6718.2 6792.9 6870.9 6879.4 6771.2 6872.6 6914.8 6937.0 7032.9 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | [#4] prototype.html Cycles:180 Average:5562.85 Median:6028.23 stddev:1484.70 (24.6%) stddev-sans-first:1438.92 08:37:28 INFO - PID 3685 | Values: 475.4 493.6 512.8 519.6 520.7 6160.1 6179.9 6198.2 6200.0 6217.3 5702.2 5912.2 6058.5 6095.6 6133.4 5078.1 5110.2 5139.0 5147.2 5157.0 5007.6 5065.1 5070.2 5092.3 5112.2 5069.7 5101.8 5113.4 5129.9 5153.3 4891.7 5034.7 5043.8 5087.7 5119.0 4671.2 4706.8 4758.3 4763.5 4781.1 5966.2 5997.3 6026.0 6030.5 6059.0 5908.9 5922.4 5925.2 6003.8 6010.5 6435.8 6471.8 6511.9 6551.7 6618.3 5250.5 5258.5 5281.1 5286.6 5306.8 6849.8 6861.5 6875.8 6878.9 6914.2 5425.8 5451.8 5477.6 5495.9 5515.8 5526.4 5536.3 5579.9 5597.3 5609.9 5866.2 5894.4 5925.4 5928.0 6012.2 6476.9 6540.1 6549.4 6581.9 6607.0 1904.5 1936.2 1942.4 1947.3 1953.7 1328.9 1415.5 1425.6 1449.3 1449.8 5493.8 5566.0 5647.7 5667.9 5714.1 6495.8 6527.9 6535.2 6629.8 6690.2 5645.2 5658.4 5675.8 5707.9 5724.4 3498.0 3507.8 3534.4 3535.7 3539.5 6445.5 6453.4 6468.2 6542.9 6580.0 6770.8 6778.3 6797.8 6833.2 6898.7 6438.8 6447.2 6454.6 6471.7 6528.2 6629.8 6708.2 6742.6 6756.0 6767.3 6572.4 6591.4 6624.7 6632.5 6681.7 6342.7 6390.5 6406.5 6441.6 6466.1 5336.5 5367.9 5383.5 5434.5 5434.9 6602.2 6709.4 6710.5 6720.2 6729.3 6452.9 6491.5 6492.8 6541.6 6543.7 6430.0 6501.2 6516.6 6527.2 6552.1 6339.2 6358.4 6368.5 6435.6 6469.5 6356.5 6419.1 6420.2 6434.7 6448.6 5906.0 6166.0 6173.8 6265.6 6274.7 08:37:28 INFO - PID 3685 | 08:37:28 INFO - PID 3685 | [#5] yui.html Cycles:180 Average:21910.59 Median:18886.36 stddev:28324.23 (150.0%) stddev-sans-first:28359.75 08:37:28 INFO - PID 3685 | Values: 901.1 901.2 920.4 920.8 921.1 17508.6 18138.6 18282.4 18313.3 18356.2 17460.7 18091.4 18723.2 18798.5 18856.7 1005.8 1032.5 1035.3 1036.3 1037.2 1032.9 1047.4 1050.2 1054.9 1057.7 1109.1 1111.4 1111.8 1115.2 1117.9 1035.6 1082.3 1083.4 1086.7 1092.9 785.5 791.4 796.2 797.3 798.3 17267.1 17378.7 17452.1 17476.5 18028.8 19783.7 20299.2 20436.4 20530.0 20586.6 15612.4 16050.1 16051.0 16064.0 16100.5 3489.2 3542.1 3554.7 3556.9 3564.5 104487.5 105233.9 109406.5 109961.5 110029.0 15603.8 15992.2 16107.4 16174.7 16264.8 25371.9 29103.0 29344.6 29400.6 29762.0 8527.2 8854.8 8873.4 8892.4 8902.8 3845.1 4097.8 4122.9 4215.7 4223.3 4849.5 5002.4 5012.2 5029.5 5044.4 994.3 1006.1 1011.7 1019.2 1021.0 582.2 647.2 667.5 681.1 710.6 11821.9 11903.5 12536.8 12681.4 12795.4 663.5 669.0 687.7 694.6 705.8 4986.4 5105.0 5112.3 5150.4 5315.0 95839.0 96249.0 98431.5 100365.5 101370.0 84357.6 87264.6 87372.6 89051.6 90321.1 73986.0 77639.6 77777.6 78066.2 80767.6 10750.2 10908.9 11048.2 11204.9 12396.8 34304.1 35245.3 36345.0 36665.0 37455.4 63699.0 65209.0 66340.3 66388.0 66678.0 17906.5 18442.9 18545.0 18784.5 18804.2 19961.3 20182.2 20184.8 20713.9 21648.6 18605.3 18690.7 18796.9 19182.7 19262.5 18245.8 18672.6 18809.9 18928.1 19393.6 17310.9 17765.6 18132.8 18306.5 18916.0 13125.0 13422.8 13501.2 13844.7 14015.5 13318.0 13384.2 13431.9 13925.6 14115.9 08:37:28 INFO - PID 3685 | -------- Summary: end -------- 08:37:28 INFO - PID 3685 | 08:37:28 INFO - TEST-INFO | 3685: exit 0 08:37:29 INFO - TEST-OK | dromaeo_css | took 1112485ms 08:37:29 INFO - TEST-START | kraken 08:37:29 INFO - Initialising browser for kraken test... 08:37:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38464/getInfo.html -profile /tmp/tmpEkh1_s/profile 08:37:29 INFO - TEST-INFO | started process 4088 (/builds/slave/test/build/application/firefox/firefox http://localhost:38464/getInfo.html) 08:37:35 INFO - TEST-INFO | 4088: exit 0 08:37:35 INFO - Browser initialized. 08:37:35 INFO - Running cycle 1/1 for kraken test... 08:37:35 INFO - TEST-INFO | started process 4293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkh1_s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:46 INFO - PID 4293 | RSS: Main: 167211008 08:37:46 INFO - PID 4293 | 08:37:49 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38464/tests/kraken/driver.html?testName=audio-beat-detection) 08:37:50 INFO - PID 4293 | RSS: Main: 173232128 08:37:50 INFO - PID 4293 | 08:37:53 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38464/tests/kraken/driver.html?testName=audio-dft) 08:37:53 INFO - PID 4293 | RSS: Main: 174182400 08:37:53 INFO - PID 4293 | 08:37:56 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38464/tests/kraken/driver.html?testName=audio-fft) 08:37:57 INFO - PID 4293 | RSS: Main: 167804928 08:37:57 INFO - PID 4293 | 08:37:59 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38464/tests/kraken/driver.html?testName=audio-oscillator) 08:37:59 INFO - PID 4293 | RSS: Main: 168169472 08:37:59 INFO - PID 4293 | 08:38:02 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:02 INFO - PID 4293 | RSS: Main: 169160704 08:38:02 INFO - PID 4293 | 08:38:05 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38464/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:06 INFO - PID 4293 | RSS: Main: 172584960 08:38:06 INFO - PID 4293 | 08:38:09 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38464/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:10 INFO - PID 4293 | RSS: Main: 173187072 08:38:10 INFO - PID 4293 | 08:38:13 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38464/tests/kraken/driver.html?testName=json-parse-financial) 08:38:13 INFO - PID 4293 | RSS: Main: 173129728 08:38:13 INFO - PID 4293 | 08:38:15 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:15 INFO - PID 4293 | RSS: Main: 173010944 08:38:15 INFO - PID 4293 | 08:38:17 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:18 INFO - PID 4293 | RSS: Main: 173191168 08:38:18 INFO - PID 4293 | 08:38:20 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:20 INFO - PID 4293 | RSS: Main: 172843008 08:38:20 INFO - PID 4293 | 08:38:23 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:24 INFO - PID 4293 | RSS: Main: 172720128 08:38:24 INFO - PID 4293 | 08:38:27 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:38:27 INFO - PID 4293 | RSS: Main: 172863488 08:38:27 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | Cycle 1(1): loaded http://localhost:38464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38464/tests/kraken/driver.html?testName=ai-astar) 08:38:29 INFO - PID 4293 | RSS: Main: 174043136 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | __start_tp_report 08:38:29 INFO - PID 4293 | _x_x_mozilla_page_load 08:38:29 INFO - PID 4293 | _x_x_mozilla_page_load_details 08:38:29 INFO - PID 4293 | |i|pagename|runs| 08:38:29 INFO - PID 4293 | |0;ai-astar;101;107;110;111;108;109;109;110;110;111 08:38:29 INFO - PID 4293 | |1;audio-beat-detection;162;119;161;176;130;152;145;124;168;132 08:38:29 INFO - PID 4293 | |2;audio-dft;166;164;164;162;163;169;164;165;165;165 08:38:29 INFO - PID 4293 | |3;audio-fft;75;77;75;172;76;74;75;75;98;78 08:38:29 INFO - PID 4293 | |4;audio-oscillator;82;82;137;81;81;82;130;81;82;132 08:38:29 INFO - PID 4293 | |5;imaging-gaussian-blur;114;114;113;114;114;115;115;114;115;113 08:38:29 INFO - PID 4293 | |6;imaging-darkroom;151;149;149;149;151;151;150;150;150;150 08:38:29 INFO - PID 4293 | |7;imaging-desaturate;94;95;94;95;95;94;94;94;95;95 08:38:29 INFO - PID 4293 | |8;json-parse-financial;56;59;56;54;55;55;55;57;56;56 08:38:29 INFO - PID 4293 | |9;json-stringify-tinderbox;54;55;54;54;54;55;54;55;55;54 08:38:29 INFO - PID 4293 | |10;stanford-crypto-aes;76;79;77;79;76;77;76;77;78;78 08:38:29 INFO - PID 4293 | |11;stanford-crypto-ccm;145;132;126;127;124;125;126;128;125;162 08:38:29 INFO - PID 4293 | |12;stanford-crypto-pbkdf2;182;184;189;186;185;190;182;182;182;180 08:38:29 INFO - PID 4293 | |13;stanford-crypto-sha256-iterative;69;68;72;67;68;69;70;69;68;68 08:38:29 INFO - PID 4293 | __end_tp_report 08:38:29 INFO - PID 4293 | __start_cc_report 08:38:29 INFO - PID 4293 | _x_x_mozilla_cycle_collect,987 08:38:29 INFO - PID 4293 | __end_cc_report 08:38:29 INFO - PID 4293 | __startTimestamp1500219509935__endTimestamp 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | ------- Summary: start ------- 08:38:29 INFO - PID 4293 | Number of tests: 14 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:2.95 (2.7%) stddev-sans-first:1.33 08:38:29 INFO - PID 4293 | Values: 101.0 107.0 110.0 111.0 108.0 109.0 109.0 110.0 110.0 111.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:156.50 stddev:19.89 (12.7%) stddev-sans-first:20.33 08:38:29 INFO - PID 4293 | Values: 162.0 119.0 161.0 176.0 130.0 152.0 145.0 124.0 168.0 132.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.89 (1.1%) stddev-sans-first:1.94 08:38:29 INFO - PID 4293 | Values: 166.0 164.0 164.0 162.0 163.0 169.0 164.0 165.0 165.0 165.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#3] audio-fft Cycles:10 Average:87.50 Median:75.50 stddev:30.53 (40.4%) stddev-sans-first:32.05 08:38:29 INFO - PID 4293 | Values: 75.0 77.0 75.0 172.0 76.0 74.0 75.0 75.0 98.0 78.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:81.50 stddev:24.90 (30.6%) stddev-sans-first:25.82 08:38:29 INFO - PID 4293 | Values: 82.0 82.0 137.0 81.0 81.0 82.0 130.0 81.0 82.0 132.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 08:38:29 INFO - PID 4293 | Values: 114.0 114.0 113.0 114.0 114.0 115.0 115.0 114.0 115.0 113.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 08:38:29 INFO - PID 4293 | Values: 151.0 149.0 149.0 149.0 151.0 151.0 150.0 150.0 150.0 150.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:38:29 INFO - PID 4293 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.37 (2.4%) stddev-sans-first:1.45 08:38:29 INFO - PID 4293 | Values: 56.0 59.0 56.0 54.0 55.0 55.0 55.0 57.0 56.0 56.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:38:29 INFO - PID 4293 | Values: 54.0 55.0 54.0 54.0 54.0 55.0 54.0 55.0 55.0 54.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.50 stddev:1.16 (1.5%) stddev-sans-first:1.13 08:38:29 INFO - PID 4293 | Values: 76.0 79.0 77.0 79.0 76.0 77.0 76.0 77.0 78.0 78.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:127.50 stddev:12.22 (9.6%) stddev-sans-first:12.02 08:38:29 INFO - PID 4293 | Values: 145.0 132.0 126.0 127.0 124.0 125.0 126.0 128.0 125.0 162.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:184.50 stddev:3.29 (1.8%) stddev-sans-first:3.40 08:38:29 INFO - PID 4293 | Values: 182.0 184.0 189.0 186.0 185.0 190.0 182.0 182.0 182.0 180.0 08:38:29 INFO - PID 4293 | 08:38:29 INFO - PID 4293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 08:38:29 INFO - PID 4293 | Values: 69.0 68.0 72.0 67.0 68.0 69.0 70.0 69.0 68.0 68.0 08:38:29 INFO - PID 4293 | -------- Summary: end -------- 08:38:29 INFO - PID 4293 | 08:38:30 INFO - PID 4293 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:38:30 INFO - TEST-INFO | 4293: exit 0 08:38:30 INFO - TEST-OK | kraken | took 61711ms 08:38:30 INFO - SUITE-END | took 1174s 08:38:31 INFO - Completed test suite (00:19:34) 08:38:31 INFO - javascript benchmark 08:38:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8359.295758618988, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3009.623797025372, 3054.847257637118, 3067.279189390493, 3069.508878579428, 3082.9691703082963, 5874.030784920488, 5886.587938844283, 5910.852228694284, 5911.733971971266, 5962.940370596293, 5936.673482958436, 5944.405559444053, 5950.821475355736, 5962.403759624035, 5970.253718285215, 5422.078246698071, 5427.3215848019, 5442.401335853053, 5449.373322067973, 5457.672539647634, 5465.371482279549, 5478.863028424302, 5494.5054945054935, 5499.807506737265, 5510.228568000483, 5472.945270547283, 5476.014317422862, 5476.7535460904355, 5478.726063696819, 5480.013597552439, 5475.972620136914, 5476.342838859323, 5482.725863706799, 5485.725713714299, 5489.807856725015, 5378.327709036371, 5436.809711660112, 5465.398806131322, 5518.530924871391, 5602.215689803431, 5954.5534084943365, 6013.128096426038, 6018.759249630009, 6037.818865434044, 6078.574499785017, 6271.749130034793, 6410.1987251593555, 6449.3873082057125, 6489.059086432441, 6516.902246466307, 6469.061986012002, 6480.57876238043, 6521.673916304213, 6556.672166391661, 6563.048357988113, 6072.180255665517, 6109.541784366146, 6112.419320164578, 6114.571979961404, 6130.356312587203, 6646.90029649546, 6651.16860392451, 6717.66411679419, 6730.831729206809, 6731.225909020427, 6298.789230524183, 6327.525435592257, 6401.103845461639, 6432.71052802625, 6440.4847612190915, 6205.0, 6303.36966303366, 6471.223453185554, 6497.675116244169, 6517.608943463408, 6277.52918531112, 6302.527310451735, 6355.237371515448, 6368.936310636835, 6395.16862807832, 6385.584936979174, 6395.456386207225, 6461.224653041665, 6476.384743449365, 6480.546361754727, 5085.542301192911, 5176.275321454999, 5182.170852663556, 5232.869178270574, 5235.712035837989, 4446.510883802779, 4473.239549276631, 4473.507914129443, 4481.0, 4489.820407183742, 5564.387917329091, 5571.913476871971, 5577.024020796425, 5578.693171875586, 5581.995240856685, 6386.904196437057, 6455.870882582322, 6463.515236357292, 6465.515086368541, 6465.676716164267, 5502.422245664147, 5549.112142057332, 5581.162825576196, 5585.162225666101, 5586.804461843816, 5666.15007748841, 5678.119891416837, 5680.204771332017, 5682.6306290091015, 5690.7439165237665, 5273.419923808378, 6202.125397461129, 6267.780627678009, 6283.120363149163, 6383.489320854321, 6513.967430162819, 6518.1200537927725, 6523.739050437929, 6593.044008618627, 6598.571092879043, 6208.0, 6235.906461403173, 6284.905726414016, 6316.557840951273, 6363.745450181941, 6163.722632481638, 6228.844278893064, 6248.281447633581, 6257.906131408124, 6448.871022579616, 5449.9562664001, 6308.053791931064, 6333.556651034568, 6523.478121750343, 6615.338466153346, 6281.183446151971, 6294.653794041372, 6313.905291420724, 6374.426301632875, 6389.8722025560155, 6297.96851015742, 6300.779472718433, 6330.303666596763, 6355.459785918064, 6365.840853978502, 6081.0, 6124.112003759341, 6141.785037523665, 6145.293291271561, 6279.686015699288, 6215.533834962486, 6248.4688801452385, 6278.497720182466, 6306.684665766785, 6313.463355614824, 5219.530242278061, 6013.037913933749, 6038.698065096815, 6082.0, 6158.599691020069], "value": 5855.764556803065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.4265342933229, 855.5593869157383, 889.5552223888056, 893.3121496447733, 1174.131142954214, 29077.41845163098, 29597.40805183898, 39709.205815883666, 40485.59514404855, 40892.0, 40530.0, 40639.59360406395, 40815.0, 40910.7954460228, 41127.38308925361, 7397.445191610637, 7587.658555364994, 7639.847203055935, 7649.655765490566, 7652.349550288232, 7372.447066470009, 7464.440166987471, 7473.4021278297605, 7487.438442116836, 7522.962385188066, 7310.561366318038, 7489.513181643176, 7564.773056808304, 7600.353969912564, 7607.733729319475, 7500.137484189334, 7552.924470755277, 7554.093508778982, 7573.6213189340315, 7589.468737188399, 7436.962815185943, 7471.514351567131, 7499.0, 7523.510971786816, 7524.134724506697, 37133.07167320811, 37628.43557346642, 37638.059048524, 37800.43299350512, 37935.24129517394, 3460.2560449503476, 3498.860045598173, 3502.404591219499, 3508.0, 3544.379733546619, 30119.0, 30352.392952141054, 30356.241093972607, 30428.69571304281, 30490.39019219603, 4820.373351464323, 4839.516048395132, 4847.660663753539, 4879.975600122012, 4931.260310953386, 212900.0, 217973.0, 219655.0, 222219.0, 222417.0, 48935.26597101046, 49046.26430603544, 49253.0, 49302.26046609304, 49317.50682493129, 50096.49903500918, 50131.74934125306, 50300.49699503031, 50589.0, 50716.49283507118, 16171.595710107342, 16321.755173672404, 16352.427665031666, 16531.66936661284, 16534.421295254608, 13599.048066635438, 13633.454661813616, 13657.795133073012, 13669.0, 13670.726585468434, 14142.505012324726, 14221.502247421291, 14344.282785860665, 14384.0, 14461.0, 5636.239107720406, 5794.420557944256, 5795.9420405796245, 5801.82594522165, 5983.491403230687, 978.188103873783, 997.9950100249453, 1006.7382480555109, 1018.0277834667875, 1025.179856115105, 22168.1132754688, 22226.666600001012, 22282.331530054125, 22589.548209035725, 28544.71455285462, 1098.785736781336, 1101.944902754859, 1111.155521803419, 1116.3971455414148, 1125.0774365020604, 12170.81743773844, 12429.0, 12449.128561000824, 12466.81299780504, 12479.688007799696, 223760.0, 226845.0, 226975.0, 227434.0, 227919.0, 44094.11811763811, 52086.0, 52572.73713631407, 52651.47348526466, 52673.7366313166, 1331.2079312808862, 1339.8995075369387, 1351.959441216765, 1463.0928824129107, 1488.6278430392185, 26243.343916402242, 26590.601140982515, 27225.59161612617, 27285.72714272832, 27576.0, 36325.45511817378, 36520.63479365279, 36535.45196822103, 36694.44958325574, 36754.63245367619, 136990.0, 137964.31017844848, 138768.30615846856, 139044.0, 139552.0, 32390.83804580962, 32624.510632340058, 32871.0, 32901.0, 32904.696671232785, 38198.61801382062, 40185.39721904232, 40761.59238407697, 41284.1743165129, 41592.1681566373, 29245.415091698473, 30694.693053069182, 30697.0, 31056.378872422876, 31159.376812464077, 29879.0, 30249.848750756104, 31028.68971310258, 33168.668313317525, 34010.65989340075, 36685.26629467449, 36989.815050924575, 37288.067798304175, 37372.81313593415, 37925.431118533794, 31572.0, 32216.872409465555, 32220.355592887543, 32496.35007299888, 33413.49879751854, 23531.17640882561, 23947.042118315072, 24374.146904858244, 24393.51212975766, 24719.50560988806], "value": 16933.89722507096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.2062629813068, 562.1623780566954, 564.5793883556751, 578.4129108954411, 593.1636392686312, 21509.0, 22092.8895355523, 22230.888845555768, 22269.66595501069, 22322.776772232293, 23940.281791546236, 24924.12765553206, 26323.210303690874, 26415.735842641567, 26484.337891552674, 6380.585261957969, 6457.225132984025, 6486.448651864597, 6493.090967264587, 6509.869802603945, 6355.205599300088, 6366.299707032223, 6377.107204991305, 6395.328490508499, 6429.38920802523, 3853.8651147209853, 5924.496417804492, 6396.5202609804455, 6404.103425520431, 6465.579737317059, 6426.260979987291, 6427.550071494998, 6450.516211284125, 6454.612723236621, 6455.677216139221, 5987.221661184061, 5994.040953447471, 6005.579609427342, 6012.75948962041, 6041.728122234466, 28137.859310703316, 29918.102456926328, 30253.24366890823, 30318.242043949078, 30343.69656303453, 1907.4849790556611, 1975.9012049397472, 1981.3758666020158, 1985.2753744883157, 1991.0343483410534, 17709.20308586117, 18356.90821545897, 18378.1729822157, 18382.632347353112, 18415.44753657379, 2246.4047027537717, 2286.0512887151813, 2286.371247906822, 2358.516504116652, 2368.265837590335, 133056.0, 136675.0, 136745.0, 137143.0, 137724.31137844248, 13703.45186192541, 14900.478483253035, 15151.696966060617, 15152.242387880562, 15184.772228416583, 23809.52380952371, 23855.642165367186, 23868.761312387, 23883.28350149498, 23889.641655375184, 10420.0, 10530.15758739299, 10569.894301057046, 10608.257421980386, 10840.891591084146, 9863.0, 9905.158061564847, 9950.35322704022, 9964.10323070927, 10057.748556286151, 9046.366754327266, 9235.676751313671, 9379.859302110473, 9495.90504094964, 9546.331756777097, 2517.5971844504793, 2673.8395696258285, 2717.9864100679765, 2750.944981100407, 2830.6315484573292, 923.1184219070772, 953.7472569769017, 967.9836172019352, 969.970900872975, 974.9567962280292, 19407.611847762964, 19576.902115489615, 20097.095630696655, 20381.796182038288, 22974.77025229726, 1016.7508960304773, 1033.1476531861244, 1041.073444634276, 1050.7163065972145, 1059.1791361694595, 12994.805077923838, 13943.372548235353, 14044.227567483682, 14187.290635468391, 14340.0, 502157.0, 503390.0, 504658.0, 520483.0, 524237.0, 119059.40470297592, 119311.0, 122938.0, 123689.0, 123910.38044809719, 1262.3688155922039, 1272.8981681465461, 1296.7212049409422, 1311.9934400327936, 1312.0422091872795, 19792.604147916674, 20652.07065682018, 20781.688274676195, 20790.480237994172, 21249.36251912445, 55108.72445637907, 57384.0, 57872.71063644655, 57927.4207257922, 57978.130328045954, 70926.64536677283, 70938.29061709317, 72659.0, 72831.63584182045, 73179.63410182916, 14162.079464834753, 14517.274136293354, 14683.853161468676, 14966.476173333882, 14969.0, 22875.428114297276, 22954.54090918206, 23152.0, 23152.4211894704, 23259.651105233097, 17695.64608707793, 17737.29050837952, 17757.911210443865, 17900.820991790435, 18243.179056942736, 15228.77156842626, 15590.532284031497, 15738.370465181264, 15896.205189740698, 17238.310467581156, 19828.405147845588, 20406.877621730946, 20432.0, 20545.178192872118, 20566.897165514078, 20909.477263068544, 21301.6804747932, 21618.783812161677, 22196.667049994587, 22311.665325019814, 17113.401030963858, 17213.74179387285, 17236.74144887853, 17356.21897014612, 17412.39056633012], "value": 12218.441084177075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.1965101288215, 1375.2711063136528, 1390.1659004597243, 1392.7771556550954, 1393.5053056165061, 13189.8021529677, 14020.158790472578, 14095.577132686023, 14120.29398530072, 14160.221187834677, 13572.93213533931, 14032.92983535081, 14061.578152655411, 14068.929655351709, 14069.92965035176, 2536.822422430431, 2576.943453184195, 2584.883680234394, 2597.2727636261875, 2607.634931109646, 2527.9620805687928, 2613.59489279162, 2614.5293847107514, 2614.6208799724027, 2623.0950322138833, 2515.962260566093, 2546.898124075035, 2561.346856551586, 2578.2909699832603, 2580.0711743772226, 2427.2960841355984, 2471.7281099079087, 2476.4304210031614, 2482.056818409002, 2492.8628925409093, 2320.6286994081033, 2326.325365643961, 2356.587597170488, 2378.500514891875, 2383.713954325492, 13277.933610331984, 13572.728545429134, 13575.185488870698, 13593.932030339785, 13634.386452609657, 7223.349898509106, 7532.54804711719, 7534.208908064629, 7535.1334596521, 7545.7358992435, 4666.510016448292, 4888.608911287089, 4928.063667903087, 4974.1543937530705, 4996.600271978233, 1819.2359209132064, 1850.8622540965207, 1877.896795501833, 1899.591587808614, 1904.3239649924217, 20889.5822083559, 20978.475538111517, 21193.894030529904, 21234.0, 21583.244586439556, 5549.667019978814, 5702.6293290935955, 6166.4758495527485, 6406.103145559626, 6416.262129855127, 15005.24973751308, 15160.393584256726, 15162.393504259926, 15231.47685231468, 15287.770683439758, 7096.396806271525, 7241.710331586783, 7268.0, 7290.088738907637, 7330.560166390033, 6508.479321654257, 6612.173478315211, 6635.071090047397, 6657.267700552935, 6742.0, 4716.481187069419, 4757.595604373667, 4980.975095124501, 4996.950640365491, 5042.168042272984, 1419.5031738891305, 1445.4724025730532, 1449.8405175430694, 1461.4738694070127, 1462.21771352326, 860.870869369587, 865.7489328094782, 891.4784850862188, 894.5661354243186, 909.3634455880909, 7991.561518926649, 8100.554469504234, 8172.0, 8298.958505207556, 8328.250457458858, 960.8943016268205, 974.3179774158118, 991.9305648604673, 1009.3893194617298, 1020.3826684855555, 4789.592884604778, 4837.129316722953, 5118.078745825713, 5136.666116702402, 5148.433672296044, 17795.46613601594, 18737.437876863714, 18789.812101878808, 18809.435716928514, 18915.527111822314, 16985.0, 19251.711224331648, 19325.13036913342, 19361.0, 19372.612547748966, 10560.260781745357, 10797.29817561856, 10803.945980270206, 10827.133829293638, 10872.61945831892, 7514.009550945898, 8300.418970671995, 8348.165183481604, 8372.623231954454, 8391.370647201362, 15820.60448488797, 16305.103219323051, 16347.59131021734, 16617.83382166163, 16681.165941703108, 15424.383024678888, 15758.448454304043, 15928.283227255033, 17001.914990425463, 17134.742978855076, 10610.8408373876, 11521.481533331187, 11528.423578820857, 11533.480993355151, 11563.88436115628, 12823.93588032054, 13010.154339967872, 13016.739665206833, 13068.934655326662, 13109.213447193199, 9769.0, 9941.403515789076, 10019.699409017741, 10412.68761937143, 10592.046715795615, 9895.604175832887, 10261.794764104527, 10374.118199953089, 10480.371177729361, 10764.40795756241, 8778.956105219433, 8829.69096081634, 8851.557422128997, 8862.379633425857, 8883.067277935983, 6482.675866206765, 6718.193816742022, 6792.9470932005615, 6870.936864356192, 6879.415249703831, 6771.153605799275, 6872.553284036521, 6914.792556223321, 6937.0, 7032.894506582303], "value": 6185.331222631588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.4176134235564, 493.57799081785083, 512.8282025521451, 519.5505887407392, 520.7346148858273, 6160.106784516248, 6179.938200617992, 6198.2252218472695, 6199.969000155004, 6217.253929528457, 5702.230198923144, 5912.201852749878, 6058.545609079315, 6095.634261944276, 6133.355997620252, 5078.136716758141, 5110.156824124015, 5138.9743051284695, 5147.1764517677175, 5156.96860627875, 5007.624428167884, 5065.1005872797705, 5070.2141168119, 5092.275632536594, 5112.182050871861, 5069.74651267437, 5101.846944591668, 5113.386393632769, 5129.871753206181, 5153.330067091291, 4891.706497610155, 5034.697918124888, 5043.773030213649, 5087.669301495391, 5118.976204759045, 4671.178240486213, 4706.788194531255, 4758.3100450434495, 4763.452202996665, 4781.139394908915, 5966.164736936832, 5997.280326360821, 6026.0, 6030.457258846681, 6059.0, 5908.852278693024, 5922.3781502942, 5925.20009798676, 6003.759849606011, 6010.519158467312, 6435.806925792187, 6471.7734879279, 6511.93488065118, 6551.672416379162, 6618.30507796684, 5250.5274525292525, 5258.474152584749, 5281.07581173297, 5286.550643195333, 5306.752913065427, 6849.7945061648725, 6861.519693621449, 6875.759348422831, 6878.89937609985, 6914.154986563316, 5425.810096646598, 5451.836444906659, 5477.616566840283, 5495.917561236584, 5515.751791169407, 5526.447355264522, 5536.252605898233, 5579.888402231933, 5597.328320601554, 5609.887802244014, 5866.208061911588, 5894.351621321737, 5925.377835327228, 5928.0, 6012.158297838306, 6476.870462590722, 6540.149780528501, 6549.410553050248, 6581.86836263272, 6607.041978913031, 1904.4762690260013, 1936.244864502845, 1942.3978566644385, 1947.2989723699457, 1953.746013018327, 1328.9269090200132, 1415.4762737787084, 1425.6435891027243, 1449.289847974506, 1449.811524501808, 5493.7802487900035, 5565.972170139124, 5647.661140331511, 5667.914981275284, 5714.114312281603, 6495.805125846232, 6527.902081468782, 6535.248446428722, 6629.834254143685, 6690.2306234782645, 5645.2096706461125, 5658.377578466366, 5675.836453527017, 5707.914381284284, 5724.398938111522, 3498.003069125338, 3507.7898125146785, 3534.416821224469, 3535.7171426285836, 3539.486774417695, 6445.51658625605, 6453.419192272718, 6468.191476065492, 6542.901856472156, 6580.012188908071, 6770.763023294259, 6778.3221677831825, 6797.830054248683, 6833.214180369222, 6898.689558969859, 6438.806835794933, 6447.194100737408, 6454.6449945252525, 6471.708773105222, 6528.21661400635, 6629.801105966829, 6708.161479815023, 6742.595444273359, 6756.0, 6767.323267673391, 6572.375624315682, 6591.439727623206, 6624.701888415129, 6632.535722499379, 6681.732730690718, 6342.746290148342, 6390.488760899024, 6406.526498905185, 6441.581297215666, 6466.06242094903, 5336.493033161843, 5367.919481207707, 5383.461653834742, 5434.510894019557, 5434.891302174014, 6602.1747281589805, 6709.429698475489, 6710.496712746662, 6720.193576770819, 6729.2934241903895, 6452.935470645233, 6491.545591808528, 6492.837679058061, 6541.574797638138, 6543.672816359258, 6430.0, 6501.1548498694865, 6516.609003459807, 6527.2167339919515, 6552.082708420729, 6339.175907132043, 6358.427741503287, 6368.458681011981, 6435.646039467687, 6469.482441404771, 6356.523260755369, 6419.133416988647, 6420.165378500765, 6434.661858069891, 6448.645324507197, 5905.970470147622, 6165.951788195927, 6173.796109758554, 6265.561410701207, 6274.686265686789], "value": 5134.878116539708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.1214066285372, 901.2249465459707, 920.4431319051976, 920.8020275640736, 921.1341339141211, 17508.56228594286, 18138.637227255447, 18282.360117395892, 18313.267469301212, 18356.17397217125, 17460.650786984254, 18091.366802161927, 18723.157457914393, 18798.53003674909, 18856.717149242773, 1005.7586179316966, 1032.4785983078573, 1035.337384074193, 1036.3056751976194, 1037.2169012395668, 1032.8554002439664, 1047.4396198034053, 1050.1756121444666, 1054.910332621728, 1057.7249915022112, 1109.1348747976551, 1111.4442778610694, 1111.8443417921496, 1115.24720813451, 1117.9385133817636, 1035.5961175141701, 1082.2802836113974, 1083.4203701019956, 1086.6685660873432, 1092.9453527323642, 785.4933567848763, 791.3629528229773, 796.1799346672937, 797.2784629909941, 798.2855344466669, 17267.136643167792, 17378.739318910226, 17452.127393630268, 17476.47570572872, 18028.819711802975, 19783.703244451346, 20299.188032478683, 20436.38690839277, 20530.0, 20586.5882682347, 15612.375504979787, 16050.1172435516, 16051.0, 16064.0, 16100.516984490485, 3489.1974845785358, 3542.096765324826, 3554.680078792921, 3556.8577256909693, 3564.536610240678, 104487.47756261246, 105233.94766052318, 109406.45296773466, 109961.45019274933, 110029.0, 15603.765943510856, 15992.200389980455, 16107.436239731553, 16174.676506469805, 16264.83735162657, 25371.87314063418, 29103.0, 29344.559831602543, 29400.558991614715, 29762.0, 8527.18991695788, 8854.778630534289, 8873.423227490193, 8892.421992570462, 8902.777430564158, 3845.0771814764257, 4097.774622395737, 4122.9381559276635, 4215.662746980234, 4223.282042052859, 4849.466558678542, 5002.449730529639, 5012.223105418666, 5029.5221953914315, 5044.4198917125, 994.3089552760762, 1006.0744115413837, 1011.7470632341915, 1019.1642852860731, 1021.0198209718604, 582.1849410824794, 647.1683886206202, 667.5260564998808, 681.0669382945397, 710.5701050864257, 11821.88178118225, 11903.523859045541, 12536.81194782079, 12681.429335679917, 12795.424205910756, 663.5222639699409, 668.9531732778756, 687.669918439152, 694.5832500499761, 705.7776800307989, 4986.401631804134, 5105.004524117836, 5112.284280200774, 5150.356205474316, 5315.016721906382, 95839.0, 96249.0, 98431.50784246033, 100365.49817250867, 101370.0, 84357.57821210855, 87264.56367718248, 87372.56313718518, 89051.55474222587, 90321.09678903258, 73986.0, 77639.61180194176, 77777.61111194408, 78066.21933780704, 80767.59616201882, 10750.247482676137, 10908.890911090788, 11048.226624136234, 11204.887951120385, 12396.81404778911, 34304.142396440286, 35245.29509409849, 36345.0, 36665.0, 37455.438168426954, 63699.0, 65209.0, 66340.33659663534, 66388.0, 66678.0, 17906.462806115836, 18442.907785460986, 18545.0, 18784.53038674044, 18804.15381307817, 19961.301354452524, 20182.192712291344, 20184.79815201829, 20713.887006100427, 21648.567028659025, 18605.348812791486, 18690.719639205694, 18796.906015470384, 19182.712259315842, 19262.518437038627, 18245.817541824414, 18672.626547468702, 18809.90595047016, 18928.14823332926, 19393.61212775765, 17310.913445433194, 17765.555861103578, 18132.818671813115, 18306.450806475827, 18916.0, 13125.0, 13422.798658020332, 13501.189928604315, 13844.653883652989, 14015.50945716895, 13318.0, 13384.19694818314, 13431.932840335736, 13925.582232533041, 14115.858841411866], "value": 8866.277485289613, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 110.0, 111.0, 108.0, 109.0, 109.0, 110.0, 110.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 119.0, 161.0, 176.0, 130.0, 152.0, 145.0, 124.0, 168.0, 132.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 162.0, 163.0, 169.0, 164.0, 165.0, 165.0, 165.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 172.0, 76.0, 74.0, 75.0, 75.0, 98.0, 78.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 137.0, 81.0, 81.0, 82.0, 130.0, 81.0, 82.0, 132.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 149.0, 151.0, 151.0, 150.0, 150.0, 150.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 56.0, 54.0, 55.0, 55.0, 55.0, 57.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 77.0, 79.0, 76.0, 77.0, 76.0, 77.0, 78.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 126.0, 127.0, 124.0, 125.0, 126.0, 128.0, 125.0, 162.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 189.0, 186.0, 185.0, 190.0, 182.0, 182.0, 182.0, 180.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 72.0, 67.0, 68.0, 69.0, 70.0, 69.0, 68.0, 68.0], "value": 68.8, "unit": "score"}]}]} 08:38:31 INFO - Return code: 0 08:38:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:38:31 INFO - # TBPL SUCCESS # 08:38:31 INFO - Running post-action listener: _package_coverage_data 08:38:31 INFO - Running post-action listener: _resource_record_post_action 08:38:31 INFO - [mozharness: 2017-07-16 15:38:31.227928Z] Finished run-tests step (success) 08:38:31 INFO - Running post-run listener: _resource_record_post_run 08:38:31 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 5881856; Write bytes: 432283648; Read time: 1900; Write time: 360168 08:38:31 INFO - TinderboxPrint: CPU usage
13.1% 08:38:31 INFO - TinderboxPrint: I/O read bytes / time
5,881,856 / 1,900 08:38:31 INFO - TinderboxPrint: I/O write bytes / time
432,283,648 / 360,168 08:38:31 INFO - TinderboxPrint: CPU idle
8,266.2 (86.9%) 08:38:31 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 08:38:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:38:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107257856; Read time: 0; Write time: 77648 08:38:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:38:31 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 3375104; Write bytes: 325025792; Read time: 1304; Write time: 282520 08:38:31 INFO - Running post-run listener: _upload_blobber_files 08:38:31 INFO - Blob upload gear active. 08:38:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:38:31 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:38:31 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:38:31 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:38:32 INFO - Traceback (most recent call last): 08:38:32 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:38:32 INFO - main() 08:38:32 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:38:32 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:38:32 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:38:32 INFO - return set(response.json().get('whitelist', [])) 08:38:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:38:32 INFO - return json.loads(self.text or self.content, **kwargs) 08:38:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:38:32 INFO - return _default_decoder.decode(s) 08:38:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:38:32 INFO - obj, end = self.raw_decode(s) 08:38:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:38:32 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:38:32 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:38:32 ERROR - Return code: 1 08:38:32 INFO - Setting buildbot property blobber_files to {} 08:38:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:38:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:38:32 INFO - Contents: 08:38:32 INFO - blobber_files:{} 08:38:32 INFO - Running post-run listener: copy_logs_to_upload_dir 08:38:32 INFO - Copying logs to upload dir... 08:38:32 INFO - mkdir: /builds/slave/test/build/upload/logs 08:38:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.115229 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-16 08:38:32.363601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:38:32.368412) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/K-F0aVy-RdC_0SkTW0u8gw/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:38:32.421497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:38:32.421778) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500211041.389756-115065235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:38:32.470561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:38:32.470833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:38:32.474105) ========= ========= Total master_lag: 0.29 =========