builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1499740189.73 results: success (0) revision: 0e41d07a703f19224f60b01577b2cbb5708046c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.734153) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.734613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.734944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.752892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.753198) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-10 19:29:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.8M=0s 2017-07-10 19:29:49 (26.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099580 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.865620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.866121) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:49.915710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 19:29:49.916239) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e41d07a703f19224f60b01577b2cbb5708046c9 --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 0e41d07a703f19224f60b01577b2cbb5708046c9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-10 19:29:50,073 truncating revision to first 12 chars 2017-07-10 19:29:50,073 Setting DEBUG logging. 2017-07-10 19:29:50,073 attempt 1/10 2017-07-10 19:29:50,073 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e41d07a703f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-10 19:29:51,488 unpacking tar archive at: mozilla-central-0e41d07a703f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.743298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 19:29:51.672289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:51.672668) ========= script_repo_revision: 0e41d07a703f19224f60b01577b2cbb5708046c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:51.673084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:51.673361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 19:29:51.681849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-10 19:29:51.682122) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:29:51 INFO - MultiFileLogger online at 20170710 19:29:51 in /builds/slave/test 19:29:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:29:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:29:51 INFO - {'append_to_log': False, 19:29:51 INFO - 'base_work_dir': '/builds/slave/test', 19:29:51 INFO - 'blob_upload_branch': 'Firefox', 19:29:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:29:51 INFO - 'branch': 'Firefox', 19:29:51 INFO - 'buildbot_json_path': 'buildprops.json', 19:29:51 INFO - 'code_coverage': False, 19:29:51 INFO - 'config_files': ('talos/linux_config.py',), 19:29:51 INFO - 'default_actions': ('clobber', 19:29:51 INFO - 'read-buildbot-config', 19:29:51 INFO - 'download-and-extract', 19:29:51 INFO - 'populate-webroot', 19:29:51 INFO - 'create-virtualenv', 19:29:51 INFO - 'install', 19:29:51 INFO - 'setup-mitmproxy', 19:29:51 INFO - 'run-tests'), 19:29:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:29:51 INFO - 'disable_ccov_upload': False, 19:29:51 INFO - 'download_minidump_stackwalk': True, 19:29:51 INFO - 'download_symbols': 'ondemand', 19:29:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:29:51 INFO - 'tooltool.py': '/tools/tooltool.py', 19:29:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:29:51 INFO - '/tools/misc-python/virtualenv.py')}, 19:29:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:29:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:29:51 INFO - 'gecko_profile': False, 19:29:51 INFO - 'gecko_profile_interval': 0, 19:29:51 INFO - 'installer_path': 'installer.exe', 19:29:51 INFO - 'log_level': 'info', 19:29:51 INFO - 'log_name': 'talos', 19:29:51 INFO - 'log_to_console': True, 19:29:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:29:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:29:51 INFO - 'opt_config_files': (), 19:29:51 INFO - 'pip_index': False, 19:29:51 INFO - 'suite': 'dromaeojs-e10s', 19:29:51 INFO - 'system_bits': '32', 19:29:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:29:51 INFO - 'title': 'talos-linux64-ix-088', 19:29:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:29:51 INFO - 'use_talos_json': True, 19:29:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:29:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:29:51 INFO - 'work_dir': 'build'} 19:29:51 INFO - [mozharness: 2017-07-11 02:29:51.946558Z] Running clobber step. 19:29:51 INFO - Running pre-action listener: _resource_record_pre_action 19:29:51 INFO - Running main action method: clobber 19:29:51 INFO - rmtree: /builds/slave/test/build 19:29:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:29:52 INFO - Running post-action listener: _resource_record_post_action 19:29:52 INFO - [mozharness: 2017-07-11 02:29:52.984272Z] Finished clobber step (success) 19:29:52 INFO - [mozharness: 2017-07-11 02:29:52.984374Z] Running read-buildbot-config step. 19:29:52 INFO - Running pre-action listener: _resource_record_pre_action 19:29:52 INFO - Running main action method: read_buildbot_config 19:29:52 INFO - Using buildbot properties: 19:29:52 INFO - { 19:29:52 INFO - "project": "", 19:29:52 INFO - "product": "firefox", 19:29:52 INFO - "who": "kwierso@gmail.com", 19:29:52 INFO - "installer_path": "public/build/target.tar.bz2", 19:29:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:29:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:29:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:29:52 INFO - "stage_platform": "linux64-stylo", 19:29:52 INFO - "basedir": "/builds/slave/test", 19:29:52 INFO - "buildnumber": 201, 19:29:52 INFO - "platform": "ubuntu64_hw_stylo", 19:29:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:29:52 INFO - "slavebuilddir": "test", 19:29:52 INFO - "taskId": "D8ywrjifTEyry4eAO7Kmeg", 19:29:52 INFO - "branch": "mozilla-central", 19:29:52 INFO - "script_repo_revision": "production", 19:29:52 INFO - "revision": "0e41d07a703f19224f60b01577b2cbb5708046c9", 19:29:52 INFO - "slavename": "talos-linux64-ix-088", 19:29:52 INFO - "repo_path": "mozilla-central" 19:29:52 INFO - } 19:29:52 INFO - Finding installer, test and symbols from parent task. 19:29:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8ywrjifTEyry4eAO7Kmeg'}, attempt #1 19:29:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D8ywrjifTEyry4eAO7Kmeg'}, attempt #1 19:29:53 INFO - Task dependencies: OtRgFQB_SSeTZ-Yqm0eoYw 19:29:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw'}, attempt #1 19:29:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:29:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/test_packages.json 19:29:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip 19:29:54 INFO - Running post-action listener: _resource_record_post_action 19:29:54 INFO - [mozharness: 2017-07-11 02:29:54.347013Z] Finished read-buildbot-config step (success) 19:29:54 INFO - [mozharness: 2017-07-11 02:29:54.347240Z] Running download-and-extract step. 19:29:54 INFO - Running pre-action listener: _resource_record_pre_action 19:29:54 INFO - Running main action method: download_and_extract 19:29:54 INFO - mkdir: /builds/slave/test/build/tests 19:29:54 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')]} 19:29:54 INFO - trying https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.test_packages.json 19:29:54 INFO - Downloading https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:29:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:29:54 INFO - Downloaded 989 bytes. 19:29:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:29:55 INFO - Using the following test package requirements: 19:29:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:29:55 INFO - u'common': [u'target.common.tests.zip'], 19:29:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:29:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:29:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:29:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:29:55 INFO - u'mozbase': [u'target.common.tests.zip'], 19:29:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:29:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:29:55 INFO - u'web-platform': [u'target.common.tests.zip', 19:29:55 INFO - u'target.web-platform.tests.tar.gz'], 19:29:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:29:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:29:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip 19:29:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:29:55 INFO - Fetch https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip into memory 19:29:57 INFO - Content-Length response header: 67424567 19:29:57 INFO - Bytes received: 67424567 19:30:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:30:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip 19:30:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:30:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.common.tests.zip into memory 19:30:09 INFO - Content-Length response header: 67424567 19:30:09 INFO - Bytes received: 67424567 19:30:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.talos.tests.zip 19:30:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:30:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.talos.tests.zip into memory 19:30:22 INFO - Content-Length response header: 14474423 19:30:22 INFO - Bytes received: 14474423 19:30: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')]} 19:30:22 INFO - trying https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:30:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:30:23 INFO - Downloaded 62281803 bytes. 19:30:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:30:23 INFO - mkdir: /builds/slave/test/properties 19:30:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:23 INFO - Contents: 19:30:23 INFO - build_url:https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 19:30:23 INFO - Running post-action listener: _resource_record_post_action 19:30:23 INFO - Running post-action listener: set_extra_try_arguments 19:30:23 INFO - [mozharness: 2017-07-11 02:30:23.820076Z] Finished download-and-extract step (success) 19:30:23 INFO - [mozharness: 2017-07-11 02:30:23.820174Z] Running populate-webroot step. 19:30:23 INFO - Running pre-action listener: _resource_record_pre_action 19:30:23 INFO - Running main action method: populate_webroot 19:30:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:30:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:30:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:30:23 INFO - '--tppagecycles', 19:30:23 INFO - '7'], 19:30:23 INFO - 'tests': ['tsvgm']}}, 19:30:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:30:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:30:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:30:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['damp', 'tps']}, 19:30:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'tests': ['damp', 'tps']}, 19:30:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['dromaeo_dom']}, 19:30:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:30:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:30:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:30:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:30:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['a11yr', 19:30:23 INFO - 'ts_paint', 19:30:23 INFO - 'tpaint', 19:30:23 INFO - 'sessionrestore', 19:30:23 INFO - 'sessionrestore_no_auto_restore', 19:30:23 INFO - 'tabpaint']}, 19:30:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:30:23 INFO - 'ts_paint', 19:30:23 INFO - 'tpaint', 19:30:23 INFO - 'sessionrestore', 19:30:23 INFO - 'sessionrestore_many_windows', 19:30:23 INFO - 'sessionrestore_no_auto_restore', 19:30:23 INFO - 'tabpaint']}, 19:30:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:30:23 INFO - 'ts_paint', 19:30:23 INFO - 'tpaint', 19:30:23 INFO - 'sessionrestore', 19:30:23 INFO - 'sessionrestore_many_windows', 19:30:23 INFO - 'sessionrestore_no_auto_restore', 19:30:23 INFO - 'tabpaint']}, 19:30:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:30:23 INFO - 'ts_paint', 19:30:23 INFO - 'tpaint', 19:30:23 INFO - 'sessionrestore', 19:30:23 INFO - 'sessionrestore_many_windows', 19:30:23 INFO - 'sessionrestore_no_auto_restore', 19:30:23 INFO - 'tabpaint']}, 19:30:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['a11yr', 19:30:23 INFO - 'ts_paint', 19:30:23 INFO - 'tpaint', 19:30:23 INFO - 'sessionrestore', 19:30:23 INFO - 'sessionrestore_no_auto_restore', 19:30:23 INFO - 'tabpaint']}, 19:30:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['a11yr', 19:30:23 INFO - 'ts_paint', 19:30:23 INFO - 'tpaint', 19:30:23 INFO - 'sessionrestore', 19:30:23 INFO - 'sessionrestore_no_auto_restore', 19:30:23 INFO - 'tabpaint']}, 19:30:23 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 19:30:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:30:23 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:30:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:30:23 INFO - 'talos_options': ['--mitmproxy', 19:30:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:30:23 INFO - '--firstNonBlankPaint'], 19:30:23 INFO - 'tests': ['quantum_pageload_google', 19:30:23 INFO - 'quantum_pageload_youtube', 19:30:23 INFO - 'quantum_pageload_amazon', 19:30:23 INFO - 'quantum_pageload_facebook']}, 19:30:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['tsvgx', 19:30:23 INFO - 'tsvgr_opacity', 19:30:23 INFO - 'tart', 19:30:23 INFO - 'tscrollx', 19:30:23 INFO - 'cart', 19:30:23 INFO - 'tsvg_static']}, 19:30:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:30:23 INFO - 'tsvgr_opacity', 19:30:23 INFO - 'tart', 19:30:23 INFO - 'tscrollx', 19:30:23 INFO - 'cart', 19:30:23 INFO - 'tsvg_static']}, 19:30:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'talos_options': ['--disable-e10s'], 19:30:23 INFO - 'tests': ['tp5o']}, 19:30:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:30:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'talos_options': ['--disable-e10s', 19:30:23 INFO - '--xperf_path', 19:30:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:23 INFO - 'tests': ['tp5n']}, 19:30:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:30:23 INFO - 'talos_options': ['--xperf_path', 19:30:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:23 INFO - 'tests': ['tp5n']}}, 19:30:23 INFO - 'talos.zip': {'path': '', 19:30:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:30:23 INFO - Running post-action listener: _resource_record_post_action 19:30:23 INFO - [mozharness: 2017-07-11 02:30:23.835496Z] Finished populate-webroot step (success) 19:30:23 INFO - [mozharness: 2017-07-11 02:30:23.835587Z] Running create-virtualenv step. 19:30:23 INFO - Running pre-action listener: _resource_record_pre_action 19:30:23 INFO - Running main action method: create_virtualenv 19:30:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:30:23 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 19:30:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:30:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:30:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:23 INFO - Using real prefix '/usr' 19:30:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:30:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:30:26 INFO - Installing pip.................done. 19:30:26 INFO - Return code: 0 19:30:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:30:26 INFO - Reading from file tmpfile_stdout 19:30:26 INFO - Output received: 19:30:26 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) 19:30:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30: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', 'pip>=1.5'] in /builds/slave/test/build 19:30: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 pip>=1.5 19:30:26 INFO - Using env: {'DISPLAY': ':0', 19:30:26 INFO - 'HOME': '/home/cltbld', 19:30:26 INFO - 'LANG': 'en_US.UTF-8', 19:30:26 INFO - 'LANGUAGE': 'en_US:en', 19:30:26 INFO - 'LOGNAME': 'cltbld', 19:30:26 INFO - 'MAIL': '/var/mail/cltbld', 19:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:26 INFO - 'MOZ_NO_REMOTE': '1', 19:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:26 INFO - 'NO_EM_RESTART': '1', 19:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:26 INFO - 'PWD': '/builds/slave/test', 19:30:26 INFO - 'SHELL': '/bin/bash', 19:30:26 INFO - 'SHLVL': '1', 19:30:26 INFO - 'TERM': 'linux', 19:30:26 INFO - 'TMOUT': '86400', 19:30:26 INFO - 'USER': 'cltbld', 19:30:26 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:26 INFO - '_': '/tools/buildbot/bin/python'} 19:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:26 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 19:30:26 INFO - Cleaning up... 19:30:26 INFO - Return code: 0 19:30:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30: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', '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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:30: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 psutil>=3.1.1 19:30:26 INFO - Using env: {'DISPLAY': ':0', 19:30:26 INFO - 'HOME': '/home/cltbld', 19:30:26 INFO - 'LANG': 'en_US.UTF-8', 19:30:26 INFO - 'LANGUAGE': 'en_US:en', 19:30:26 INFO - 'LOGNAME': 'cltbld', 19:30:26 INFO - 'MAIL': '/var/mail/cltbld', 19:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:26 INFO - 'MOZ_NO_REMOTE': '1', 19:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:26 INFO - 'NO_EM_RESTART': '1', 19:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:26 INFO - 'PWD': '/builds/slave/test', 19:30:26 INFO - 'SHELL': '/bin/bash', 19:30:26 INFO - 'SHLVL': '1', 19:30:26 INFO - 'TERM': 'linux', 19:30:26 INFO - 'TMOUT': '86400', 19:30:26 INFO - 'USER': 'cltbld', 19:30:26 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:26 INFO - '_': '/tools/buildbot/bin/python'} 19:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:27 INFO - Downloading/unpacking psutil>=3.1.1 19:30: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 19:30: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 19:30: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 19:30: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 19:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:28 INFO - Installing collected packages: psutil 19:30:28 INFO - Running setup.py install for psutil 19:30:28 INFO - building 'psutil._psutil_linux' extension 19:30:28 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 19:30:28 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 19:30:28 INFO - building 'psutil._psutil_posix' extension 19:30:28 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 19:30:28 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 19:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:28 INFO - Successfully installed psutil 19:30:28 INFO - Cleaning up... 19:30:28 INFO - Return code: 0 19:30:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:30: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')]} 19:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30: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')]} 19:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:28 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:28 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 19:30:28 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 19:30:28 INFO - Using env: {'DISPLAY': ':0', 19:30:28 INFO - 'HOME': '/home/cltbld', 19:30:28 INFO - 'LANG': 'en_US.UTF-8', 19:30:28 INFO - 'LANGUAGE': 'en_US:en', 19:30:28 INFO - 'LOGNAME': 'cltbld', 19:30:28 INFO - 'MAIL': '/var/mail/cltbld', 19:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:28 INFO - 'MOZ_NO_REMOTE': '1', 19:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:28 INFO - 'NO_EM_RESTART': '1', 19:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:28 INFO - 'PWD': '/builds/slave/test', 19:30:28 INFO - 'SHELL': '/bin/bash', 19:30:28 INFO - 'SHLVL': '1', 19:30:28 INFO - 'TERM': 'linux', 19:30:28 INFO - 'TMOUT': '86400', 19:30:28 INFO - 'USER': 'cltbld', 19:30:28 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:28 INFO - '_': '/tools/buildbot/bin/python'} 19:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:30:30 INFO - Installing collected packages: mozsystemmonitor 19:30:30 INFO - Running setup.py install for mozsystemmonitor 19:30:30 INFO - Successfully installed mozsystemmonitor 19:30:30 INFO - Cleaning up... 19:30:30 INFO - Return code: 0 19:30:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:30:30 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')]} 19:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:30 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')]} 19:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:30 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:30 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 19:30:30 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 19:30:30 INFO - Using env: {'DISPLAY': ':0', 19:30:30 INFO - 'HOME': '/home/cltbld', 19:30:30 INFO - 'LANG': 'en_US.UTF-8', 19:30:30 INFO - 'LANGUAGE': 'en_US:en', 19:30:30 INFO - 'LOGNAME': 'cltbld', 19:30:30 INFO - 'MAIL': '/var/mail/cltbld', 19:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:30 INFO - 'MOZ_NO_REMOTE': '1', 19:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:30 INFO - 'NO_EM_RESTART': '1', 19:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:30 INFO - 'PWD': '/builds/slave/test', 19:30:30 INFO - 'SHELL': '/bin/bash', 19:30:30 INFO - 'SHLVL': '1', 19:30:30 INFO - 'TERM': 'linux', 19:30:30 INFO - 'TMOUT': '86400', 19:30:30 INFO - 'USER': 'cltbld', 19:30:30 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:30 INFO - '_': '/tools/buildbot/bin/python'} 19:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:30:30 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 19:30:30 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 19:30:30 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 19:30:30 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 19:30:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:30:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:31 INFO - Downloading functools32-3.2.3-2.tar.gz 19:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:30:31 INFO - warning: no files found matching '*.txt' 19:30:31 INFO - no previously-included directories found matching 'build' 19:30:31 INFO - no previously-included directories found matching 'dist' 19:30:31 INFO - no previously-included directories found matching '.git*' 19:30:31 INFO - Installing collected packages: jsonschema, functools32 19:30:31 INFO - Running setup.py install for functools32 19:30:31 INFO - warning: no files found matching '*.txt' 19:30:31 INFO - no previously-included directories found matching 'build' 19:30:31 INFO - no previously-included directories found matching 'dist' 19:30:31 INFO - no previously-included directories found matching '.git*' 19:30:31 INFO - Successfully installed jsonschema functools32 19:30:31 INFO - Cleaning up... 19:30:31 INFO - Return code: 0 19:30:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:30: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')]} 19:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30: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')]} 19:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:31 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:31 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 19:30:31 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 19:30:31 INFO - Using env: {'DISPLAY': ':0', 19:30:31 INFO - 'HOME': '/home/cltbld', 19:30:31 INFO - 'LANG': 'en_US.UTF-8', 19:30:31 INFO - 'LANGUAGE': 'en_US:en', 19:30:31 INFO - 'LOGNAME': 'cltbld', 19:30:31 INFO - 'MAIL': '/var/mail/cltbld', 19:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:31 INFO - 'MOZ_NO_REMOTE': '1', 19:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:31 INFO - 'NO_EM_RESTART': '1', 19:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:31 INFO - 'PWD': '/builds/slave/test', 19:30:31 INFO - 'SHELL': '/bin/bash', 19:30:31 INFO - 'SHLVL': '1', 19:30:31 INFO - 'TERM': 'linux', 19:30:31 INFO - 'TMOUT': '86400', 19:30:31 INFO - 'USER': 'cltbld', 19:30:31 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:31 INFO - '_': '/tools/buildbot/bin/python'} 19:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:30:32 INFO - Cleaning up... 19:30:32 INFO - Return code: 0 19:30:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:32 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:32 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 19:30:32 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 19:30:32 INFO - Using env: {'DISPLAY': ':0', 19:30:32 INFO - 'HOME': '/home/cltbld', 19:30:32 INFO - 'LANG': 'en_US.UTF-8', 19:30:32 INFO - 'LANGUAGE': 'en_US:en', 19:30:32 INFO - 'LOGNAME': 'cltbld', 19:30:32 INFO - 'MAIL': '/var/mail/cltbld', 19:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:32 INFO - 'MOZ_NO_REMOTE': '1', 19:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:32 INFO - 'NO_EM_RESTART': '1', 19:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:32 INFO - 'PWD': '/builds/slave/test', 19:30:32 INFO - 'SHELL': '/bin/bash', 19:30:32 INFO - 'SHLVL': '1', 19:30:32 INFO - 'TERM': 'linux', 19:30:32 INFO - 'TMOUT': '86400', 19:30:32 INFO - 'USER': 'cltbld', 19:30:32 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:32 INFO - '_': '/tools/buildbot/bin/python'} 19:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:30:32 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 19:30:32 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 19:30:32 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 19:30:32 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 19:30:33 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:30:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:30: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 19:30: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 19:30: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 19:30: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 19:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:30:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:30: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 19:30: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 19:30: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 19:30: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 19:30:34 INFO - Downloading docopt-0.6.1.tar.gz 19:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:30:34 INFO - Installing collected packages: blobuploader, requests, docopt 19:30:34 INFO - Running setup.py install for blobuploader 19:30:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:30:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:30:34 INFO - Running setup.py install for requests 19:30:34 INFO - Running setup.py install for docopt 19:30:34 INFO - Successfully installed blobuploader requests docopt 19:30:34 INFO - Cleaning up... 19:30:34 INFO - Return code: 0 19:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30: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')]} 19:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30: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')]} 19:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:34 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:34 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 19:30:34 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 19:30:34 INFO - Using env: {'DISPLAY': ':0', 19:30:34 INFO - 'HOME': '/home/cltbld', 19:30:34 INFO - 'LANG': 'en_US.UTF-8', 19:30:34 INFO - 'LANGUAGE': 'en_US:en', 19:30:34 INFO - 'LOGNAME': 'cltbld', 19:30:34 INFO - 'MAIL': '/var/mail/cltbld', 19:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:34 INFO - 'MOZ_NO_REMOTE': '1', 19:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:34 INFO - 'NO_EM_RESTART': '1', 19:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:34 INFO - 'PWD': '/builds/slave/test', 19:30:34 INFO - 'SHELL': '/bin/bash', 19:30:34 INFO - 'SHLVL': '1', 19:30:34 INFO - 'TERM': 'linux', 19:30:34 INFO - 'TMOUT': '86400', 19:30:34 INFO - 'USER': 'cltbld', 19:30:34 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:34 INFO - '_': '/tools/buildbot/bin/python'} 19:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:34 INFO - Running setup.py (path:/tmp/pip-i6CRyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:34 INFO - Running setup.py (path:/tmp/pip-aK3uK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:35 INFO - Running setup.py (path:/tmp/pip-rjEzrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:35 INFO - Running setup.py (path:/tmp/pip-5HHiGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:35 INFO - Running setup.py (path:/tmp/pip-wIdHlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:35 INFO - Running setup.py (path:/tmp/pip-Ppr0Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:35 INFO - Running setup.py (path:/tmp/pip-3CxHvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:35 INFO - Running setup.py (path:/tmp/pip-HaVJd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:35 INFO - Running setup.py (path:/tmp/pip-IQxBnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:35 INFO - Running setup.py (path:/tmp/pip-pQXFtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:35 INFO - Running setup.py (path:/tmp/pip-GbPHVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:35 INFO - Running setup.py (path:/tmp/pip-y58YUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:35 INFO - Running setup.py (path:/tmp/pip-x444gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:35 INFO - Running setup.py (path:/tmp/pip-L06KuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:35 INFO - Running setup.py (path:/tmp/pip-TZGApn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:35 INFO - Running setup.py (path:/tmp/pip-PLsk2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:36 INFO - Running setup.py (path:/tmp/pip-K7tW7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:30:36 INFO - Running setup.py install for manifestparser 19:30:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Running setup.py install for mozcrash 19:30:36 INFO - Running setup.py install for mozdebug 19:30:36 INFO - Running setup.py install for mozdevice 19:30:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Running setup.py install for mozfile 19:30:36 INFO - Running setup.py install for mozhttpd 19:30:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Running setup.py install for mozinfo 19:30:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Running setup.py install for mozInstall 19:30:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:30:36 INFO - Running setup.py install for mozleak 19:30:37 INFO - Running setup.py install for mozlog 19:30:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for moznetwork 19:30:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozprocess 19:30:37 INFO - Running setup.py install for mozprofile 19:30:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozrunner 19:30:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Running setup.py install for mozscreenshot 19:30:37 INFO - Running setup.py install for moztest 19:30:37 INFO - Running setup.py install for mozversion 19:30:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:30:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:30:37 INFO - Cleaning up... 19:30:37 INFO - Return code: 0 19:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30: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')]} 19:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30: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')]} 19:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:37 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:37 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 19:30:37 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 19:30:37 INFO - Using env: {'DISPLAY': ':0', 19:30:37 INFO - 'HOME': '/home/cltbld', 19:30:37 INFO - 'LANG': 'en_US.UTF-8', 19:30:37 INFO - 'LANGUAGE': 'en_US:en', 19:30:37 INFO - 'LOGNAME': 'cltbld', 19:30:37 INFO - 'MAIL': '/var/mail/cltbld', 19:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:37 INFO - 'MOZ_NO_REMOTE': '1', 19:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:37 INFO - 'NO_EM_RESTART': '1', 19:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:37 INFO - 'PWD': '/builds/slave/test', 19:30:37 INFO - 'SHELL': '/bin/bash', 19:30:37 INFO - 'SHLVL': '1', 19:30:37 INFO - 'TERM': 'linux', 19:30:37 INFO - 'TMOUT': '86400', 19:30:37 INFO - 'USER': 'cltbld', 19:30:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:37 INFO - '_': '/tools/buildbot/bin/python'} 19:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:30:38 INFO - Running setup.py (path:/tmp/pip-lBVZIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:30:38 INFO - Running setup.py (path:/tmp/pip-TSUiCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:30:38 INFO - Running setup.py (path:/tmp/pip-DAt0My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:30:38 INFO - Running setup.py (path:/tmp/pip-XVtSyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:30:38 INFO - Running setup.py (path:/tmp/pip-cJx39a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:30:38 INFO - Running setup.py (path:/tmp/pip-aNeBrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:30:38 INFO - Running setup.py (path:/tmp/pip-BxxHHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:30:38 INFO - Running setup.py (path:/tmp/pip-hMaCYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:30:38 INFO - Running setup.py (path:/tmp/pip-9GVVwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:30:38 INFO - Running setup.py (path:/tmp/pip-RIHBsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:30:38 INFO - Running setup.py (path:/tmp/pip-I24wwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:30:38 INFO - Running setup.py (path:/tmp/pip-sCiQJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:30:38 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)) 19:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:30:38 INFO - Running setup.py (path:/tmp/pip-1SDOE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:30:39 INFO - Running setup.py (path:/tmp/pip-1_TQbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:39 INFO - Running setup.py (path:/tmp/pip-VMPzTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:30:39 INFO - Running setup.py (path:/tmp/pip-dKNBOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:30:39 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)) 19:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:30:39 INFO - Running setup.py (path:/tmp/pip-yTyOJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:30:39 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)) 19:30:39 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)) 19:30:39 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)) 19:30:39 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)) 19:30:39 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)) 19:30:39 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)) 19:30:39 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)) 19:30:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:30:39 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 19:30:39 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 19:30:39 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 19:30:39 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 19:30:40 INFO - Downloading blessings-1.6.tar.gz 19:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:30:40 INFO - Installing collected packages: blessings 19:30:40 INFO - Running setup.py install for blessings 19:30:40 INFO - Successfully installed blessings 19:30:40 INFO - Cleaning up... 19:30:40 INFO - Return code: 0 19:30:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:30:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:40 INFO - Reading from file tmpfile_stdout 19:30:40 INFO - Current package versions: 19:30:40 INFO - argparse == 1.2.1 19:30:40 INFO - blessings == 1.6 19:30:40 INFO - blobuploader == 1.2.4 19:30:40 INFO - docopt == 0.6.1 19:30:40 INFO - functools32 == 3.2.3-2 19:30:40 INFO - jsonschema == 2.5.1 19:30:40 INFO - manifestparser == 1.1 19:30:40 INFO - mozInstall == 1.13 19:30:40 INFO - mozcrash == 1.0 19:30:40 INFO - mozdebug == 0.1 19:30:40 INFO - mozdevice == 0.51 19:30:40 INFO - mozfile == 1.2 19:30:40 INFO - mozhttpd == 0.7 19:30:40 INFO - mozinfo == 0.10 19:30:40 INFO - mozleak == 0.1 19:30:40 INFO - mozlog == 3.5 19:30:40 INFO - moznetwork == 0.27 19:30:40 INFO - mozprocess == 0.25 19:30:40 INFO - mozprofile == 0.28 19:30:40 INFO - mozrunner == 6.13 19:30:40 INFO - mozscreenshot == 0.1 19:30:40 INFO - mozsystemmonitor == 0.3 19:30:40 INFO - moztest == 0.8 19:30:40 INFO - mozversion == 1.4 19:30:40 INFO - psutil == 3.1.1 19:30:40 INFO - requests == 1.2.3 19:30:40 INFO - wsgiref == 0.1.2 19:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:30:40 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')]} 19:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:40 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')]} 19:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:40 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:40 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 19:30:40 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 19:30:40 INFO - Using env: {'DISPLAY': ':0', 19:30:40 INFO - 'HOME': '/home/cltbld', 19:30:40 INFO - 'LANG': 'en_US.UTF-8', 19:30:40 INFO - 'LANGUAGE': 'en_US:en', 19:30:40 INFO - 'LOGNAME': 'cltbld', 19:30:40 INFO - 'MAIL': '/var/mail/cltbld', 19:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:40 INFO - 'MOZ_NO_REMOTE': '1', 19:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:40 INFO - 'NO_EM_RESTART': '1', 19:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:40 INFO - 'PWD': '/builds/slave/test', 19:30:40 INFO - 'SHELL': '/bin/bash', 19:30:40 INFO - 'SHLVL': '1', 19:30:40 INFO - 'TERM': 'linux', 19:30:40 INFO - 'TMOUT': '86400', 19:30:40 INFO - 'USER': 'cltbld', 19:30:40 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:40 INFO - '_': '/tools/buildbot/bin/python'} 19:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 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)) 19:30:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:30:41 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 19:30:41 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 19:30:41 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 19:30:41 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 19:30:42 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:30:42 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 19:30:42 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 19:30:42 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 19:30:42 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 19:30:42 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 19:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 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)) 19:30:42 INFO - Installing collected packages: marionette-driver, simplejson 19:30:42 INFO - Running setup.py install for marionette-driver 19:30:42 INFO - Running setup.py install for simplejson 19:30:42 INFO - building 'simplejson._speedups' extension 19:30:42 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 19:30:43 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 19:30:43 INFO - Successfully installed marionette-driver simplejson 19:30:43 INFO - Cleaning up... 19:30:43 INFO - Return code: 0 19:30:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:30:43 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')]} 19:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:43 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')]} 19:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:43 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 0x1de71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2156fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', '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 19:30:43 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 19:30:43 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 19:30:43 INFO - Using env: {'DISPLAY': ':0', 19:30:43 INFO - 'HOME': '/home/cltbld', 19:30:43 INFO - 'LANG': 'en_US.UTF-8', 19:30:43 INFO - 'LANGUAGE': 'en_US:en', 19:30:43 INFO - 'LOGNAME': 'cltbld', 19:30:43 INFO - 'MAIL': '/var/mail/cltbld', 19:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:43 INFO - 'MOZ_NO_REMOTE': '1', 19:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:43 INFO - 'NO_EM_RESTART': '1', 19:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:43 INFO - 'PWD': '/builds/slave/test', 19:30:43 INFO - 'SHELL': '/bin/bash', 19:30:43 INFO - 'SHLVL': '1', 19:30:43 INFO - 'TERM': 'linux', 19:30:43 INFO - 'TMOUT': '86400', 19:30:43 INFO - 'USER': 'cltbld', 19:30:43 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:43 INFO - '_': '/tools/buildbot/bin/python'} 19:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:30:43 INFO - Cleaning up... 19:30:43 INFO - Return code: 0 19:30:43 INFO - Running post-action listener: _resource_record_post_action 19:30:43 INFO - Running post-action listener: _start_resource_monitoring 19:30:43 INFO - Starting resource monitoring. 19:30:43 INFO - [mozharness: 2017-07-11 02:30:43.922322Z] Finished create-virtualenv step (success) 19:30:43 INFO - [mozharness: 2017-07-11 02:30:43.922846Z] Running install step. 19:30:43 INFO - Running pre-action listener: _resource_record_pre_action 19:30:43 INFO - Running main action method: install 19:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:30:44 INFO - Reading from file tmpfile_stdout 19:30:44 INFO - Detecting whether we're running mozinstall >=1.0... 19:30:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:30:44 INFO - Reading from file tmpfile_stdout 19:30:44 INFO - Output received: 19:30:44 INFO - Usage: mozinstall [options] installer 19:30:44 INFO - Options: 19:30:44 INFO - -h, --help show this help message and exit 19:30:44 INFO - -d DEST, --destination=DEST 19:30:44 INFO - Directory to install application into. [default: 19:30:44 INFO - "/builds/slave/test"] 19:30:44 INFO - --app=APP Application being installed. [default: firefox] 19:30:44 INFO - mkdir: /builds/slave/test/build/application 19:30:44 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'] 19:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:31:02 INFO - Reading from file tmpfile_stdout 19:31:02 INFO - Output received: 19:31:02 INFO - /builds/slave/test/build/application/firefox/firefox 19:31:02 INFO - Running post-action listener: _resource_record_post_action 19:31:02 INFO - [mozharness: 2017-07-11 02:31:02.396743Z] Finished install step (success) 19:31:02 INFO - [mozharness: 2017-07-11 02:31:02.396894Z] Running setup-mitmproxy step. 19:31:02 INFO - Running pre-action listener: _resource_record_pre_action 19:31:02 INFO - Running main action method: setup_mitmproxy 19:31:02 INFO - Skipping: mitmproxy is not required 19:31:02 INFO - Running post-action listener: _resource_record_post_action 19:31:02 INFO - [mozharness: 2017-07-11 02:31:02.398169Z] Finished setup-mitmproxy step (success) 19:31:02 INFO - [mozharness: 2017-07-11 02:31:02.398499Z] Running run-tests step. 19:31:02 INFO - Running pre-action listener: _resource_record_pre_action 19:31:02 INFO - Running pre-action listener: _set_gcov_prefix 19:31:02 INFO - Running main action method: run_tests 19:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:31:02 INFO - Python 2.7.3 19:31:02 INFO - Return code: 0 19:31:02 INFO - grabbing minidump binary from tooltool 19:31:02 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')]} 19:31:02 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 0x215a2a0>, '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 0x215b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21554d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:31:02 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 19:31:02 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 19:31:02 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 19:31:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:31:02 INFO - Return code: 0 19:31:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:31:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:31:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:31:02 INFO - ENV: RUST_BACKTRACE is now 1 19:31:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:31:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:31:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:31:02 INFO - Using env: {'DISPLAY': ':0', 19:31:02 INFO - 'HOME': '/home/cltbld', 19:31:02 INFO - 'LANG': 'en_US.UTF-8', 19:31:02 INFO - 'LANGUAGE': 'en_US:en', 19:31:02 INFO - 'LOGNAME': 'cltbld', 19:31:02 INFO - 'MAIL': '/var/mail/cltbld', 19:31:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:02 INFO - 'MOZ_NO_REMOTE': '1', 19:31:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:02 INFO - 'NO_EM_RESTART': '1', 19:31:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:02 INFO - 'PWD': '/builds/slave/test', 19:31:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:02 INFO - 'RUST_BACKTRACE': '1', 19:31:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:31:02 INFO - 'SHELL': '/bin/bash', 19:31:02 INFO - 'SHLVL': '1', 19:31:02 INFO - 'TERM': 'linux', 19:31:02 INFO - 'TMOUT': '86400', 19:31:02 INFO - 'USER': 'cltbld', 19:31:02 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408', 19:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:02 INFO - '_': '/tools/buildbot/bin/python'} 19:31:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:31:02 INFO - mozversion application_buildid: 20170711014314 19:31:02 INFO - mozversion application_changeset: 0e41d07a703f19224f60b01577b2cbb5708046c9 19:31:02 INFO - mozversion application_display_name: Nightly 19:31:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:31:02 INFO - mozversion application_name: Firefox 19:31:02 INFO - mozversion application_remotingname: firefox 19:31:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:31:02 INFO - mozversion application_vendor: Mozilla 19:31:02 INFO - mozversion application_version: 56.0a1 19:31:02 INFO - mozversion platform_buildid: 20170711014314 19:31:02 INFO - mozversion platform_changeset: 0e41d07a703f19224f60b01577b2cbb5708046c9 19:31:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:31:02 INFO - mozversion platform_version: 56.0a1 19:31:02 INFO - using testdate: 1499740262 19:31:02 INFO - actual date: 1499740262 19:31:02 INFO - starting webserver on 'localhost:41915' 19:31:02 INFO - SUITE-START | Running 2 tests 19:31:02 INFO - TEST-START | dromaeo_css 19:31:02 INFO - Initialising browser for dromaeo_css test... 19:31:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41915/getInfo.html -profile /tmp/tmpPoTHWq/profile 19:31:02 INFO - TEST-INFO | started process 12915 (/builds/slave/test/build/application/firefox/firefox http://localhost:41915/getInfo.html) 19:31:08 INFO - TEST-INFO | 12915: exit 0 19:31:08 INFO - Browser initialized. 19:31:08 INFO - Running cycle 1/1 for dromaeo_css test... 19:31:08 INFO - TEST-INFO | started process 13133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPoTHWq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:20 INFO - PID 13133 | RSS: Main: 174563328 19:31:20 INFO - PID 13133 | 19:34:20 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41915/tests/dromaeo/cssquery-ext.html) 19:34:22 INFO - PID 13133 | RSS: Main: 179597312 19:34:22 INFO - PID 13133 | 19:37:24 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-ext.html (next: http://localhost:41915/tests/dromaeo/cssquery-jquery.html) 19:37:25 INFO - PID 13133 | RSS: Main: 176017408 19:37:25 INFO - PID 13133 | 19:40:26 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41915/tests/dromaeo/cssquery-mootools.html) 19:40:27 INFO - PID 13133 | RSS: Main: 180490240 19:40:27 INFO - PID 13133 | 19:43:29 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41915/tests/dromaeo/cssquery-prototype.html) 19:43:29 INFO - PID 13133 | RSS: Main: 179519488 19:43:29 INFO - PID 13133 | 19:46:33 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41915/tests/dromaeo/cssquery-yui.html) 19:46:33 INFO - PID 13133 | RSS: Main: 178606080 19:46:33 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | Cycle 1(1): loaded http://localhost:41915/tests/dromaeo/cssquery-yui.html (next: http://localhost:41915/tests/dromaeo/cssquery-dojo.html) 19:49:35 INFO - PID 13133 | RSS: Main: 183042048 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | __start_tp_report 19:49:35 INFO - PID 13133 | _x_x_mozilla_page_load 19:49:35 INFO - PID 13133 | _x_x_mozilla_page_load_details 19:49:35 INFO - PID 13133 | |i|pagename|runs| 19:49:35 INFO - PID 13133 | |0;dojo.html;3097.6127984002;3141.638711548172;3173.4922412414016;3186.7131958123764;3186.7609929255295;5978.163057171994;6040.214772079635;6047.455728984391;6053.757849686018;6144.416280453361;6063.151158837766;6089.939100608993;6128.3258841527395;6132.264128304599;6147.47746441553;5549.334079910396;5576.1356989666665;5581.6930068846295;5620.634658747189;5628.268325117729;5522.806701765439;5590.944090559083;5591.552675785927;5599.552035837123;5606.187102870082;5595.020871347519;5596.804111856086;5600.299962504687;5604.579656525777;5625.099984002561;5625.634333768292;5629.831105066854;5633.436656334375;5635.126555383922;5652.604317697763;5500.697461639608;5575.69333686647;5598.524125449342;5603.103503439471;5681.573881958829;6071.423214794588;6097.57316987811;6101.237345331833;6185.876282474325;6189.50483961282;6331.398517140864;6422.421982021594;6490.415862572391;6537.41163295301;6592.439642630382;6572.704228309737;6584.9012264816065;6590.242122155965;6597.670116494156;6599.8020059398295;6084.30030546484;6117.847053823645;6122.4183702548635;6130.203073600448;6134.754609815602;5079.847604571869;6644.767433139817;6731.596104233761;6735.663216839139;6743.15710536183;6146.7233974471255;6312.684365781693;6394.648294343856;6414.61512309263;6415.871682566416;6376.808695739135;6452.77415290472;6500.967495162494;6507.446867016262;6537.967310163419;5702.54379649627;6408.67956602168;6437.967810160919;6572.4084832365315;6588.209414870246;6053.086846918079;6589.077529145923;6631.668416579152;6638.269790323061;6655.567388119756;5123.795048198105;5222.321098257202;5304.867378315495;5402.135658294654;5403.5136837684795;4552.863414097583;4562.520935301812;4566.132434837436;4567.908641827211;4568.406107206109;5663.716814159358;5669.489745922804;5669.518090962314;5679.37526872052;5679.8864022720145;6514.6416947068365;6515.902261466082;6518.902216466757;6522.902156467657;6530.151080359523;5633.464820842096;5652.802151924745;5664.461876121762;5707.686077265707;5720.08478643415;5713.085906255063;5801.187833703285;5815.331236907725;5832;5873.119032145212;6319.115323854664;6348.301686814539;6389.329120442287;6396.616203027833;6413.743450262031;6521.250056243593;6618.801435956929;6638.070670106285;6641.867162656817;6660.500462465237;6340.904886426615;6356.078368636429;6361.936380636134;6407.8718425630295;6485.837854053686;6414.390632889868;6415;6420.1974753155855;6504.934950650433;6513.674316284261;6490.156279683611;6530.575512591667;6587.341265873566;6641.236257830411;6648.83377915556;6248.156498872594;6317.147185129948;6330.272018717907;6351.904721429275;6438.710258038306;6347.174867267226;6374.171357723651;6386.201724784402;6386.9680651596445;6388.361163883575;6294.842628934313;6301.495880329654;6303.558750887394;6331.05034244867;6350.841228969312;6340.9048864268;6396.712147953446;6397.552171347961;6466.191726034246;6493.675316234075;6190.907136392868;6211.596246243979;6309.558330916791;6320.431161195331;6328.114064031131 19:49:35 INFO - PID 13133 | |1;ext.html;773.6789232468526;838.358655628444;857.9742607721769;881.9691310804124;895.9283257339409;39537;40418.1916361673;40619.79690101553;40747.185056298855;40832.79583602085;37916;38367.232655346874;38425.807870960605;38547.03632409191;38632.42051369232;6696.832579185523;6849.657517124148;6865.4850886183485;6865.828354291133;6885.690143943534;6841.5552989055805;6914.930850691479;6921.411680007205;6955.02629631852;6985.161780586337;6869.725210991554;6890.035395044698;6896.379325860671;6897.3447522485285;6967.303269673042;6848.212455567624;6870.690818913136;6873.175218973705;6890.379865812076;6936.375726184668;6258.06129080637;6300.21247344082;6349.079383489415;6349.873002539969;6357.364263573651;32958.50562241568;33052.6694733052;33254.50118248228;33301.33397332064;33375.49936750951;3355.8489867956;3391.5251864738957;3394;3396.2018925552475;3407.897763067112;26895.462090758272;29087;29680.70319296801;30963.84518077395;31115.53326700079;4667.556582124693;4794.640401969867;4877.561019508225;4932.5807306379;4948.208286674151;190869;190913;191995;192932;193132.0343398288;49172.50827491679;49836.50163498391;49993.75003125034;50168.74915625399;50195.247071293226;52196;52351.73824130855;52373.73813130986;52385;52466.73766631143;16402.671946561;16433.09617970999;16565.58586035359;16577.254023568967;16601.833981660027;13732.45070197201;13807.17156970565;13839.723205535833;13854.30728463593;13856.237906915216;14042;14042.297885105703;14300.284985750672;14338.139711617336;14507.782383264259;5963.254593175853;5982.551308651869;6023.216981792339;6114.480269177081;6151.692415379213;950.9809803803885;977.203579083045;977.2328721953232;1009.3590569987964;1034.343192073039;22187.779672117864;22406.215782447536;22782.31653050411;22918.197863075045;22984.425389365064;1084.4794498640697;1084.6312253833735;1104.3925840787535;1116.3636727065657;1123.1183520936027;11593.263279687575;11828.52685892572;11961.940190298992;12079;12130.636080917586;242706;243372;243795;244088;244947;51981.48018519842;52175.47824521782;52197.21704174441;52341.2148817768;52395.73802130965;1425.9215743134228;1471.830739464954;1474.8303945046243;1476.6751314710746;1476.7858660493953;21265.78734212638;22306;22469.325920222418;22693.773062269825;22913.65629515525;34204.31591368208;34278.314433710686;34340.65659343375;34441.48337774885;34490.65509344975;184748;185646;186499;186606;188110.05944970186;31117.53323700101;31239.53140702846;31266.53100203544;31522.68477315289;34093;37551.624483754815;37644.43533347057;38227.42658860064;43367.34948975831;43812;30804.691953080182;30984.380312394078;31542;31712;33567.83216083904;32878.83560582182;33596.83201583976;33915.3216935655;34000.31999359949;34332;34725.47911781275;36074.63925360713;36456.08859778527;36724.63275367212;36775.448368275036;31854;33040.33919321552;33173.33653326872;33225.50161747624;33518;23635.64546531838;23763.098952084136;24057.75942240555;24529.264122076365;24951.126710565044 19:49:35 INFO - PID 13133 | |2;jquery.html;568.2413977340253;573.936866944636;575.160266011623;580.7851095094816;586.6069733278703;21428.464288392777;22181.778182218193;22195.11219551218;22244.666330005064;22270.88864555679;24682.136125235622;25871.611925821082;26288.342791430223;27318.59022114665;27564.310892227706;6529.771457998982;6689.598624082546;6702.961041038647;6711.060451536764;6711.664416779166;6582.8683426331445;6593.044008618771;6599.043138744879;6606.4384527315;6619.073329733817;3850.788206648633;4156.833726650931;6179.814605561818;6566.9821177717295;6618.040384144296;6546.574472659262;6580;6598.901016484757;6620.30486798884;6641.302663220341;6131.540134489886;6142.8771424571705;6146.231721034871;6168.352323006065;6182.258129024501;29237.707622923925;30416.239594010105;30677.69322306771;30836.84581577078;30906.53640195399;1888.2163901980662;1907.675695131817;1917.8849269043762;1918.2710569983456;1927.4892153579312;19155.32956346535;19466;19476.70784938227;19483;19496.70754938677;2191.3425972208433;2335.74306826249;2368.810495160383;2427.526632306701;2440.04838113136;134945;137382.3130884339;137952.620473795;138791;139352;14909.329080191417;15050.623734406727;15104.885316055761;15185.544433667008;15328.23725271608;21639.35081947544;21658.675119873216;21857.890710546664;21894.78105218959;21897.671534926987;9994;10132.898671013196;10190.133838623651;10212.08091271789;10564.683059508227;9770.36492627977;9776.902230977741;9820.607175712892;9840.261980351503;9845.655402061037;8792.736217913473;9199.632014719336;9212.401193922373;9222.123898229658;9462.621495140254;2741.629879966219;2778.569321755131;4303.806328715153;4382.905471147318;4562.726236425825;919.117647058831;924.1359329027381;944.2257348973776;949.107838631684;954.2604481526872;24879.129230476847;25771.226863194133;25993.870030650105;26034.609480857423;26206.606900896502;1034.425893629043;1052.0478966535297;1071.5874388360537;1071.807074726541;1079.5088234853124;10917.235793494538;11347;11620.941895290638;11701.94682478564;11925.70185745346;477034;497222;507556;510669;528263;121320.39339803245;122165;124021.37989309996;125303.37348313382;125550.37224813817;1238.721287710258;1284.5504073574175;1302.3553341096217;1312.2612538386675;1316.967075823093;17633.647327053644;18353.724694129865;18670.906645466686;18914.43256702301;18929.33747318837;57089;58538.12192817196;58550;58564.707176463846;62463.68768156312;75178.24821751713;75359.62320188365;75387;76544.61727691548;76849;14650.120992740469;15388.769168462706;15413.152276624893;15512.92243538775;15527.922360388126;23894.641580376658;23928.641070384307;24109.397265068514;24168.033278669358;24886.875565622056;18192.272309108015;19123;19127.426177214707;19210.8078919209;19273.132709027846;15874.285657145225;16674.833251667813;17716.202770875083;17722.46832595024;18303.725444118616;19167.233310667416;19659.311924082587;19801.504962376057;19893.502662433555;20283.087261072993;14939.925300373428;15261.465848695243;15342.23288835576;15359.617634412509;15461.84538154604;18036.54908627295;18779.436616901516;19051.237950481827;19147.521311967314;19278.518037049187 19:49:35 INFO - PID 13133 | |3;mootools.html;1357.8777909988098;1409.337611322678;1421.4456362018807;1423.5088894331452;1424.935877885495;12521.686957826047;13027.544035958743;13095.803562946563;13169.670758231048;13208.207507549541;12732.809007864866;13004;13130.606081817561;13139.408726607302;13148.934255328733;2581.948361032783;2676.51822671919;2676.5985102234627;2680.276325392143;2682.1953413975825;2504.186139504659;2571.562834318161;2596.701379341381;2599.597062455313;2607.4915391498666;2461.692288463942;2532.2529853693204;2570.190390027145;2582.173704414588;2585.5346037713202;2551.170869467421;2623.8688065596643;2629.4872499862536;2637.103384849141;2648.9337766555795;2557.09223225754;2585.818992670514;2590.171145233526;2591.663083799113;2594.818362714611;12934.029947753956;12983.545575904893;13017.934910325388;13053.934730326288;13119.803202951867;7123.572585644878;7430.108386993541;7451.739189128354;7473.177950425449;7516.98520699704;4735.431748190204;4789.185838407479;4975.527324904128;5007.799688012475;5013.473585273567;1727.3522429089091;1776.5292197567655;1793.8608983295571;1851.7500137481536;1852.1202428846325;20276.797232027788;20480.59038819215;20495.385138445723;20604;20659.380218593466;6050.636961782219;6082.36135205797;6135.723892424851;6292.653904035322;6299.118123462719;14607.634809129857;14626;14653.267336633126;14659;14691.632709182357;6797.626130562867;7049.7885063448175;7053.753118640926;7070.75252366175;7070.964645176741;6512.218533775977;6590.3080176581725;6646.401823835878;6683.2314283857;6816.556923799937;4729.597984171315;4799.712017278975;4852.684575502581;4909.533594308535;5090.363704536933;1402.558194168854;1412.5268035208321;1416.525463969561;1426.2583456602715;1435.468876515696;874.226309715906;881.5988725130051;901.6663834381321;902.4900930973979;911.0570559471048;7079.327463890922;7103.183133939663;7211.278872112852;7233;7245.275472452818;705.263000164829;717.7703134996856;723.7430712097236;732.2238427267007;737.0455260437745;5196.714180720097;5255.816046438356;5311.521963023347;5490.450954904478;5573.024720673866;16778.1610919456;17483.912580437016;17505.474835754947;17514.562135946704;17524.737128943078;17173.656526869392;17293.481195564153;17299.13504324779;18597.16312765929;18926.905365473085;10188.235882308856;10414.895851041545;10446;10513.737156571147;10665.573377064831;7471.066116735408;8077.919220807717;8140.470869393471;8267.545285009382;8394.748157555283;14895.47865824691;15658.217089145724;16373.09947952874;16450.83549164541;16610.50168494947;15632.531024069296;15881;15894.761578576099;16617.91691041537;16777.580560485596;10745.677629671123;11086.944565277123;11093.5562577496;11136.164787640797;11144.442777860912;12321.568745093879;12331;12440.937795310965;12499.312537810507;12538.310392928477;10029.899701002896;10191.898081019095;10311.639092631722;10317.638882639072;10442.269041167045;9790.608375664893;10193.439360835226;10214.233932454947;10321.845172322272;10345.482725863527;8727.476351418934;8875.378723489552;8895.243904268209;8931.151540603632;8952.28381729447;6264.718087685974;6416.839579010562;6721.1598550181225;6752.426043786137;6945.131858517685;6998.930010699828;7073.6816843243205;7075.893861591977;7122;7143.1428228612895 19:49:35 INFO - PID 13133 | |4;prototype.html;489.6078799882417;502.6807976934645;514.7426286856572;520.5549255386644;522.0837430309808;5913.172155898178;6008.158857759906;6031.246094238215;6040.818775436738;6122.448979591836;5815.185873977646;5924.259467566554;5942.643441393519;5966.374795090168;6014.849628759283;4993.300937868701;5069.3663292088395;5101.362329708786;5102.668326558781;5128.666636668605;5037.3451451311275;5059.620528460362;5066.150854937958;5074.416442109168;5131.102057140004;5042.369703787027;5097.49025097491;5110.361204849394;5123.2827404163445;5123.615728820335;4886.853394398174;4957.851264462072;5002.324686167357;5031.949680503203;5077.619178561604;4599.632029437637;4629.560191781776;4632;4635.165670179366;4645.5354464553275;5826;5826.737796799154;5828.854278643025;5908.852278693067;5913.7232165616115;5788.960795582353;5819.185314056035;5820.912686309709;5830.7667693292215;5870.471657550798;6387.584806987531;6407.743690252384;6421.357864213588;6449.032645103225;6464.903026454607;5082.949170508322;5130.743462826844;5138.948610513884;5204.115300398941;5207.635465517377;6679.732810687616;6702.731890724365;6787.423069039138;6818.465845184844;6852.417544508673;5373.769885497553;5375.435579264199;5398.4871437213405;5430.104032834617;5458.2904222450825;5445.809396671098;5457.263269458652;5512.200730893998;5524.453153117053;5570.86072848182;5654.660720356792;5868.823935281948;5892.852678682982;5895.852603684943;5902.852428689317;6424.710888009958;6426.196725409324;6437.25971513282;6467.348387161335;6509.837254068686;1915.9329423470112;1930.6814375628146;1933.7486126803708;1933.7582802149732;1938.185961896007;1303.244118411319;1409.9013069085065;1434.153849228939;1437.252628633105;1451.5717863230373;5439.945600543944;5504.2294078829;5508.20131080991;5572.609917305831;5657;6229.345918678564;6409.198850143732;6445.613263204223;6496.610203387811;6539.673016349164;5595.608307418523;5600.215969764236;5621.80323688669;5707.74315155819;5716.1997320375185;3392.2028323343993;3461.394256005189;3475.913102172415;3482.460218666111;3508.2808024354945;6279.497640188774;6284.308726040132;6303.243610766645;6314.621122732558;6346.143270658495;6565.8358541035905;6566.212054553484;6619;6626.271110177877;6710.899336509956;6223.657698826608;6272.560920735596;6281.59169653971;6358.33237510064;6363.90454143179;6462.838429039123;6479.384458476437;6492.545521813617;6518.641474718936;6554.934450655433;6400.743970241138;6453.096566480603;6524.771632992823;6543.247526534509;6556.508261880283;6333.461655759312;6375.521835862236;6387.754387894316;6404.775832845828;6420.582662126947;5308.309919710413;5325.201219817059;5346.866328341823;5356.116240820221;5359.097520380365;6453.741850325934;6474.902876456951;6493.603875166862;6529.444997175104;6549.574277671936;6228.56400051992;6294.968525157345;6330.3669633036325;6341.017142342944;6378.011408231731;6384.744610215539;6386.521010924293;6412.487001039999;6424;6426.646534440651;6260.968695156495;6288.245410550763;6323.588966717149;6324.747010119728;6333.303336632875;6291.276503202007;6333.145025421509;6396.273006288369;6398;6453.677316134081;5660.377358490645;6213.316535181036;6222.906656400067;6230;6313.715882785377 19:49:35 INFO - PID 13133 | |5;yui.html;928.9210417114549;933.9019402962689;947.4457442396198;948.4356807699417;957.7509847439663;18133;18319.633607327847;18743.4376968691;18755.4373368799;18767.906160469214;19369.709454358162;19946.401607951786;20411.285605003828;20544.97275136241;20705;1036.0520124086452;1052.5947510208548;1053.2048303530823;1058.3068090400761;1060.6340812419703;1058.2222066780948;1061.495789499989;1062.7768168684586;1065.0361422912276;1066.7653116314398;1045.9424731639795;1125.6004118537924;1125.656674714212;1132.2866594045781;1140.4126874659557;1078.0190027075323;1083.2958576925023;1086.1907878630432;1087.2009073331096;1087.2335003822286;786.0410299434681;790.5177841516728;791.0665414810521;791.2601717394255;791.4380789639363;18258.543536411562;18823.24707011718;19175;19210.327638532584;19402.22391104354;19157.137928793098;19518.902405487883;19916.402507924784;19950.700739488773;19979.700304495444;15076.924615376962;15376.53870383879;15423;15475.226238688021;15513.146776927377;3395.7622966392114;3418.1454636340914;3425.469052296898;3438.277961628061;3446.0695612184822;106284;108990.45504772505;109138.45430772875;111747;113568.4321578395;13807.240601767;13952.372143253579;13968.092074015156;13987.79018314726;14141.43434262618;27233.183004509898;28933;28978.27554311159;29016.564751528746;29154.708452915624;8377.539235341992;8540.444871083484;8558.101399353103;8587.184217499327;8593.871091933626;4045.615666511677;4077.6533994610195;4094.324436468009;4125.876223713293;4145;4750.572448479654;4986.351774269322;5021.548060674557;5028.371453568304;5031.270465782441;894.458852394305;929.8977112517617;940.7459985803931;962.2254085461271;963.3930623707159;623.8440389902524;666.1839246922481;708.8794904866185;719.4388377065897;720.0782997762872;11499.137564682682;12097.947187692222;12317.568885088978;12658.177218480769;12744.80882786759;674.8380388706676;695.4818660098259;702.4415589606275;714.8391611887283;715.1775458223085;5535.889282214333;5617.101263797855;5630.296212973379;5656.151577263361;5698.458646428583;97605;98221;98737;99088;102607.4869625662;87343;87876;89463;91194.54402727944;94833;79057.60471197723;79098;80066.5996670013;82494.58752706199;83088.99999999879;11368.886311136783;11896.940515297369;12027.939860300992;12125.75748485043;12642.620721378373;34727;35564.644353556134;35773.622291021675;36123;37125.814370927976;61060.389396107246;64219;66264;66749.33250667431;66963;18461.16924738417;18600.441986740418;19182.808171918103;19192.71210931865;19691.326237269994;19837;20750.896245518677;20850.478738031063;21049.89475052676;21524.784752152278;18638.81361186425;18757.90621046886;19334.419967401;19382.61234775325;19603.509912252306;18890.52773680669;18933.90533047326;19365.515862102995;19410.320638777575;19882.204711811366;17757.46727598174;18777.248910043447;18854.245830167187;18949.526261843563;18961.241550337832;14120.788188177392;14209.715805683622;14222.644433888821;14421.42314307416;14453.132812031312;13966.860331396556;14083.366248519047;14092.436302547783;14129.788053179005;14202.715945680822 19:49:35 INFO - PID 13133 | __end_tp_report 19:49:35 INFO - PID 13133 | __start_cc_report 19:49:35 INFO - PID 13133 | _x_x_mozilla_cycle_collect,387 19:49:35 INFO - PID 13133 | __end_cc_report 19:49:35 INFO - PID 13133 | __startTimestamp1499741375752__endTimestamp 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | ------- Summary: start ------- 19:49:35 INFO - PID 13133 | Number of tests: 6 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | [#0] dojo.html Cycles:165 Average:6010.84 Median:6294.84 stddev:696.92 (11.1%) stddev-sans-first:660.52 19:49:35 INFO - PID 13133 | Values: 3097.6 3141.6 3173.5 3186.7 3186.8 5978.2 6040.2 6047.5 6053.8 6144.4 6063.2 6089.9 6128.3 6132.3 6147.5 5549.3 5576.1 5581.7 5620.6 5628.3 5522.8 5590.9 5591.6 5599.6 5606.2 5595.0 5596.8 5600.3 5604.6 5625.1 5625.6 5629.8 5633.4 5635.1 5652.6 5500.7 5575.7 5598.5 5603.1 5681.6 6071.4 6097.6 6101.2 6185.9 6189.5 6331.4 6422.4 6490.4 6537.4 6592.4 6572.7 6584.9 6590.2 6597.7 6599.8 6084.3 6117.8 6122.4 6130.2 6134.8 5079.8 6644.8 6731.6 6735.7 6743.2 6146.7 6312.7 6394.6 6414.6 6415.9 6376.8 6452.8 6501.0 6507.4 6538.0 5702.5 6408.7 6438.0 6572.4 6588.2 6053.1 6589.1 6631.7 6638.3 6655.6 5123.8 5222.3 5304.9 5402.1 5403.5 4552.9 4562.5 4566.1 4567.9 4568.4 5663.7 5669.5 5669.5 5679.4 5679.9 6514.6 6515.9 6518.9 6522.9 6530.2 5633.5 5652.8 5664.5 5707.7 5720.1 5713.1 5801.2 5815.3 5832.0 5873.1 6319.1 6348.3 6389.3 6396.6 6413.7 6521.3 6618.8 6638.1 6641.9 6660.5 6340.9 6356.1 6361.9 6407.9 6485.8 6414.4 6415.0 6420.2 6504.9 6513.7 6490.2 6530.6 6587.3 6641.2 6648.8 6248.2 6317.1 6330.3 6351.9 6438.7 6347.2 6374.2 6386.2 6387.0 6388.4 6294.8 6301.5 6303.6 6331.1 6350.8 6340.9 6396.7 6397.6 6466.2 6493.7 6190.9 6211.6 6309.6 6320.4 6328.1 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | [#1] ext.html Cycles:180 Average:37144.16 Median:18654.66 stddev:54269.54 (290.9%) stddev-sans-first:54353.07 19:49:35 INFO - PID 13133 | Values: 773.7 838.4 858.0 882.0 895.9 39537.0 40418.2 40619.8 40747.2 40832.8 37916.0 38367.2 38425.8 38547.0 38632.4 6696.8 6849.7 6865.5 6865.8 6885.7 6841.6 6914.9 6921.4 6955.0 6985.2 6869.7 6890.0 6896.4 6897.3 6967.3 6848.2 6870.7 6873.2 6890.4 6936.4 6258.1 6300.2 6349.1 6349.9 6357.4 32958.5 33052.7 33254.5 33301.3 33375.5 3355.8 3391.5 3394.0 3396.2 3407.9 26895.5 29087.0 29680.7 30963.8 31115.5 4667.6 4794.6 4877.6 4932.6 4948.2 190869.0 190913.0 191995.0 192932.0 193132.0 49172.5 49836.5 49993.8 50168.7 50195.2 52196.0 52351.7 52373.7 52385.0 52466.7 16402.7 16433.1 16565.6 16577.3 16601.8 13732.5 13807.2 13839.7 13854.3 13856.2 14042.0 14042.3 14300.3 14338.1 14507.8 5963.3 5982.6 6023.2 6114.5 6151.7 951.0 977.2 977.2 1009.4 1034.3 22187.8 22406.2 22782.3 22918.2 22984.4 1084.5 1084.6 1104.4 1116.4 1123.1 11593.3 11828.5 11961.9 12079.0 12130.6 242706.0 243372.0 243795.0 244088.0 244947.0 51981.5 52175.5 52197.2 52341.2 52395.7 1425.9 1471.8 1474.8 1476.7 1476.8 21265.8 22306.0 22469.3 22693.8 22913.7 34204.3 34278.3 34340.7 34441.5 34490.7 184748.0 185646.0 186499.0 186606.0 188110.1 31117.5 31239.5 31266.5 31522.7 34093.0 37551.6 37644.4 38227.4 43367.3 43812.0 30804.7 30984.4 31542.0 31712.0 33567.8 32878.8 33596.8 33915.3 34000.3 34332.0 34725.5 36074.6 36456.1 36724.6 36775.4 31854.0 33040.3 33173.3 33225.5 33518.0 23635.6 23763.1 24057.8 24529.3 24951.1 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | [#2] jquery.html Cycles:180 Average:35932.14 Median:2352.28 stddev:85019.13 (3614.3%) stddev-sans-first:85216.17 19:49:35 INFO - PID 13133 | Values: 568.2 573.9 575.2 580.8 586.6 21428.5 22181.8 22195.1 22244.7 22270.9 24682.1 25871.6 26288.3 27318.6 27564.3 6529.8 6689.6 6703.0 6711.1 6711.7 6582.9 6593.0 6599.0 6606.4 6619.1 3850.8 4156.8 6179.8 6567.0 6618.0 6546.6 6580.0 6598.9 6620.3 6641.3 6131.5 6142.9 6146.2 6168.4 6182.3 29237.7 30416.2 30677.7 30836.8 30906.5 1888.2 1907.7 1917.9 1918.3 1927.5 19155.3 19466.0 19476.7 19483.0 19496.7 2191.3 2335.7 2368.8 2427.5 2440.0 134945.0 137382.3 137952.6 138791.0 139352.0 14909.3 15050.6 15104.9 15185.5 15328.2 21639.4 21658.7 21857.9 21894.8 21897.7 9994.0 10132.9 10190.1 10212.1 10564.7 9770.4 9776.9 9820.6 9840.3 9845.7 8792.7 9199.6 9212.4 9222.1 9462.6 2741.6 2778.6 4303.8 4382.9 4562.7 919.1 924.1 944.2 949.1 954.3 24879.1 25771.2 25993.9 26034.6 26206.6 1034.4 1052.0 1071.6 1071.8 1079.5 10917.2 11347.0 11620.9 11701.9 11925.7 477034.0 497222.0 507556.0 510669.0 528263.0 121320.4 122165.0 124021.4 125303.4 125550.4 1238.7 1284.6 1302.4 1312.3 1317.0 17633.6 18353.7 18670.9 18914.4 18929.3 57089.0 58538.1 58550.0 58564.7 62463.7 75178.2 75359.6 75387.0 76544.6 76849.0 14650.1 15388.8 15413.2 15512.9 15527.9 23894.6 23928.6 24109.4 24168.0 24886.9 18192.3 19123.0 19127.4 19210.8 19273.1 15874.3 16674.8 17716.2 17722.5 18303.7 19167.2 19659.3 19801.5 19893.5 20283.1 14939.9 15261.5 15342.2 15359.6 15461.8 18036.5 18779.4 19051.2 19147.5 19278.5 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | [#3] mootools.html Cycles:180 Average:8204.40 Median:2576.76 stddev:5410.55 (210.0%) stddev-sans-first:5401.27 19:49:35 INFO - PID 13133 | Values: 1357.9 1409.3 1421.4 1423.5 1424.9 12521.7 13027.5 13095.8 13169.7 13208.2 12732.8 13004.0 13130.6 13139.4 13148.9 2581.9 2676.5 2676.6 2680.3 2682.2 2504.2 2571.6 2596.7 2599.6 2607.5 2461.7 2532.3 2570.2 2582.2 2585.5 2551.2 2623.9 2629.5 2637.1 2648.9 2557.1 2585.8 2590.2 2591.7 2594.8 12934.0 12983.5 13017.9 13053.9 13119.8 7123.6 7430.1 7451.7 7473.2 7517.0 4735.4 4789.2 4975.5 5007.8 5013.5 1727.4 1776.5 1793.9 1851.8 1852.1 20276.8 20480.6 20495.4 20604.0 20659.4 6050.6 6082.4 6135.7 6292.7 6299.1 14607.6 14626.0 14653.3 14659.0 14691.6 6797.6 7049.8 7053.8 7070.8 7071.0 6512.2 6590.3 6646.4 6683.2 6816.6 4729.6 4799.7 4852.7 4909.5 5090.4 1402.6 1412.5 1416.5 1426.3 1435.5 874.2 881.6 901.7 902.5 911.1 7079.3 7103.2 7211.3 7233.0 7245.3 705.3 717.8 723.7 732.2 737.0 5196.7 5255.8 5311.5 5490.5 5573.0 16778.2 17483.9 17505.5 17514.6 17524.7 17173.7 17293.5 17299.1 18597.2 18926.9 10188.2 10414.9 10446.0 10513.7 10665.6 7471.1 8077.9 8140.5 8267.5 8394.7 14895.5 15658.2 16373.1 16450.8 16610.5 15632.5 15881.0 15894.8 16617.9 16777.6 10745.7 11086.9 11093.6 11136.2 11144.4 12321.6 12331.0 12440.9 12499.3 12538.3 10029.9 10191.9 10311.6 10317.6 10442.3 9790.6 10193.4 10214.2 10321.8 10345.5 8727.5 8875.4 8895.2 8931.2 8952.3 6264.7 6416.8 6721.2 6752.4 6945.1 6998.9 7073.7 7075.9 7122.0 7143.1 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | [#4] prototype.html Cycles:180 Average:5471.17 Median:5911.01 stddev:1447.59 (24.5%) stddev-sans-first:1402.53 19:49:35 INFO - PID 13133 | Values: 489.6 502.7 514.7 520.6 522.1 5913.2 6008.2 6031.2 6040.8 6122.4 5815.2 5924.3 5942.6 5966.4 6014.8 4993.3 5069.4 5101.4 5102.7 5128.7 5037.3 5059.6 5066.2 5074.4 5131.1 5042.4 5097.5 5110.4 5123.3 5123.6 4886.9 4957.9 5002.3 5031.9 5077.6 4599.6 4629.6 4632.0 4635.2 4645.5 5826.0 5826.7 5828.9 5908.9 5913.7 5789.0 5819.2 5820.9 5830.8 5870.5 6387.6 6407.7 6421.4 6449.0 6464.9 5082.9 5130.7 5138.9 5204.1 5207.6 6679.7 6702.7 6787.4 6818.5 6852.4 5373.8 5375.4 5398.5 5430.1 5458.3 5445.8 5457.3 5512.2 5524.5 5570.9 5654.7 5868.8 5892.9 5895.9 5902.9 6424.7 6426.2 6437.3 6467.3 6509.8 1915.9 1930.7 1933.7 1933.8 1938.2 1303.2 1409.9 1434.2 1437.3 1451.6 5439.9 5504.2 5508.2 5572.6 5657.0 6229.3 6409.2 6445.6 6496.6 6539.7 5595.6 5600.2 5621.8 5707.7 5716.2 3392.2 3461.4 3475.9 3482.5 3508.3 6279.5 6284.3 6303.2 6314.6 6346.1 6565.8 6566.2 6619.0 6626.3 6710.9 6223.7 6272.6 6281.6 6358.3 6363.9 6462.8 6479.4 6492.5 6518.6 6554.9 6400.7 6453.1 6524.8 6543.2 6556.5 6333.5 6375.5 6387.8 6404.8 6420.6 5308.3 5325.2 5346.9 5356.1 5359.1 6453.7 6474.9 6493.6 6529.4 6549.6 6228.6 6295.0 6330.4 6341.0 6378.0 6384.7 6386.5 6412.5 6424.0 6426.6 6261.0 6288.2 6323.6 6324.7 6333.3 6291.3 6333.1 6396.3 6398.0 6453.7 5660.4 6213.3 6222.9 6230.0 6313.7 19:49:35 INFO - PID 13133 | 19:49:35 INFO - PID 13133 | [#5] yui.html Cycles:180 Average:22251.18 Median:19931.40 stddev:28854.32 (144.8%) stddev-sans-first:28890.84 19:49:35 INFO - PID 13133 | Values: 928.9 933.9 947.4 948.4 957.8 18133.0 18319.6 18743.4 18755.4 18767.9 19369.7 19946.4 20411.3 20545.0 20705.0 1036.1 1052.6 1053.2 1058.3 1060.6 1058.2 1061.5 1062.8 1065.0 1066.8 1045.9 1125.6 1125.7 1132.3 1140.4 1078.0 1083.3 1086.2 1087.2 1087.2 786.0 790.5 791.1 791.3 791.4 18258.5 18823.2 19175.0 19210.3 19402.2 19157.1 19518.9 19916.4 19950.7 19979.7 15076.9 15376.5 15423.0 15475.2 15513.1 3395.8 3418.1 3425.5 3438.3 3446.1 106284.0 108990.5 109138.5 111747.0 113568.4 13807.2 13952.4 13968.1 13987.8 14141.4 27233.2 28933.0 28978.3 29016.6 29154.7 8377.5 8540.4 8558.1 8587.2 8593.9 4045.6 4077.7 4094.3 4125.9 4145.0 4750.6 4986.4 5021.5 5028.4 5031.3 894.5 929.9 940.7 962.2 963.4 623.8 666.2 708.9 719.4 720.1 11499.1 12097.9 12317.6 12658.2 12744.8 674.8 695.5 702.4 714.8 715.2 5535.9 5617.1 5630.3 5656.2 5698.5 97605.0 98221.0 98737.0 99088.0 102607.5 87343.0 87876.0 89463.0 91194.5 94833.0 79057.6 79098.0 80066.6 82494.6 83089.0 11368.9 11896.9 12027.9 12125.8 12642.6 34727.0 35564.6 35773.6 36123.0 37125.8 61060.4 64219.0 66264.0 66749.3 66963.0 18461.2 18600.4 19182.8 19192.7 19691.3 19837.0 20750.9 20850.5 21049.9 21524.8 18638.8 18757.9 19334.4 19382.6 19603.5 18890.5 18933.9 19365.5 19410.3 19882.2 17757.5 18777.2 18854.2 18949.5 18961.2 14120.8 14209.7 14222.6 14421.4 14453.1 13966.9 14083.4 14092.4 14129.8 14202.7 19:49:35 INFO - PID 13133 | -------- Summary: end -------- 19:49:35 INFO - PID 13133 | 19:49:36 INFO - TEST-INFO | 13133: exit 0 19:49:36 INFO - TEST-OK | dromaeo_css | took 1113494ms 19:49:36 INFO - TEST-START | kraken 19:49:36 INFO - Initialising browser for kraken test... 19:49:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41915/getInfo.html -profile /tmp/tmp976D9H/profile 19:49:36 INFO - TEST-INFO | started process 13547 (/builds/slave/test/build/application/firefox/firefox http://localhost:41915/getInfo.html) 19:49:42 INFO - TEST-INFO | 13547: exit 0 19:49:42 INFO - Browser initialized. 19:49:42 INFO - Running cycle 1/1 for kraken test... 19:49:42 INFO - TEST-INFO | started process 13766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp976D9H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:53 INFO - PID 13766 | RSS: Main: 173993984 19:49:53 INFO - PID 13766 | 19:49:56 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-beat-detection) 19:49:57 INFO - PID 13766 | RSS: Main: 178249728 19:49:57 INFO - PID 13766 | 19:49:59 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-dft) 19:50:00 INFO - PID 13766 | RSS: Main: 178552832 19:50:00 INFO - PID 13766 | 19:50:03 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-fft) 19:50:04 INFO - PID 13766 | RSS: Main: 172752896 19:50:04 INFO - PID 13766 | 19:50:06 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41915/tests/kraken/driver.html?testName=audio-oscillator) 19:50:06 INFO - PID 13766 | RSS: Main: 173670400 19:50:06 INFO - PID 13766 | 19:50:08 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:09 INFO - PID 13766 | RSS: Main: 173404160 19:50:09 INFO - PID 13766 | 19:50:12 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:13 INFO - PID 13766 | RSS: Main: 177819648 19:50:13 INFO - PID 13766 | 19:50:16 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41915/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:17 INFO - PID 13766 | RSS: Main: 179216384 19:50:17 INFO - PID 13766 | 19:50:20 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41915/tests/kraken/driver.html?testName=json-parse-financial) 19:50:20 INFO - PID 13766 | RSS: Main: 177713152 19:50:20 INFO - PID 13766 | 19:50:22 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:22 INFO - PID 13766 | RSS: Main: 177864704 19:50:22 INFO - PID 13766 | 19:50:24 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:25 INFO - PID 13766 | RSS: Main: 178020352 19:50:25 INFO - PID 13766 | 19:50:27 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:50:27 INFO - PID 13766 | RSS: Main: 177819648 19:50:27 INFO - PID 13766 | 19:50:30 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:50:31 INFO - PID 13766 | RSS: Main: 177643520 19:50:31 INFO - PID 13766 | 19:50:34 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:50:34 INFO - PID 13766 | RSS: Main: 177692672 19:50:34 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | Cycle 1(1): loaded http://localhost:41915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41915/tests/kraken/driver.html?testName=ai-astar) 19:50:36 INFO - PID 13766 | RSS: Main: 178851840 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | __start_tp_report 19:50:36 INFO - PID 13766 | _x_x_mozilla_page_load 19:50:36 INFO - PID 13766 | _x_x_mozilla_page_load_details 19:50:36 INFO - PID 13766 | |i|pagename|runs| 19:50:36 INFO - PID 13766 | |0;ai-astar;102;108;108;107;111;108;109;110;109;108 19:50:36 INFO - PID 13766 | |1;audio-beat-detection;154;122;153;172;122;151;152;128;168;124 19:50:36 INFO - PID 13766 | |2;audio-dft;164;163;162;162;163;174;164;165;167;169 19:50:36 INFO - PID 13766 | |3;audio-fft;74;75;75;181;74;76;75;74;98;74 19:50:36 INFO - PID 13766 | |4;audio-oscillator;82;84;131;82;82;82;132;82;83;132 19:50:36 INFO - PID 13766 | |5;imaging-gaussian-blur;113;113;114;113;114;114;113;114;113;113 19:50:36 INFO - PID 13766 | |6;imaging-darkroom;151;149;150;150;149;151;149;150;149;150 19:50:36 INFO - PID 13766 | |7;imaging-desaturate;95;95;94;94;95;104;94;94;95;94 19:50:36 INFO - PID 13766 | |8;json-parse-financial;55;58;54;55;58;55;55;54;55;55 19:50:36 INFO - PID 13766 | |9;json-stringify-tinderbox;53;54;55;54;53;54;53;54;54;54 19:50:36 INFO - PID 13766 | |10;stanford-crypto-aes;79;78;77;78;78;79;77;77;77;77 19:50:36 INFO - PID 13766 | |11;stanford-crypto-ccm;131;130;126;144;125;129;129;135;123;172 19:50:36 INFO - PID 13766 | |12;stanford-crypto-pbkdf2;181;194;180;181;180;185;178;181;180;181 19:50:36 INFO - PID 13766 | |13;stanford-crypto-sha256-iterative;70;71;68;71;76;67;68;72;68;72 19:50:36 INFO - PID 13766 | __end_tp_report 19:50:36 INFO - PID 13766 | __start_cc_report 19:50:36 INFO - PID 13766 | _x_x_mozilla_cycle_collect,947 19:50:36 INFO - PID 13766 | __end_cc_report 19:50:36 INFO - PID 13766 | __startTimestamp1499741436971__endTimestamp 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | ------- Summary: start ------- 19:50:36 INFO - PID 13766 | Number of tests: 14 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:2.40 (2.2%) stddev-sans-first:1.22 19:50:36 INFO - PID 13766 | Values: 102.0 108.0 108.0 107.0 111.0 108.0 109.0 110.0 109.0 108.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:152.50 stddev:19.07 (12.5%) stddev-sans-first:19.93 19:50:36 INFO - PID 13766 | Values: 154.0 122.0 153.0 172.0 122.0 151.0 152.0 128.0 168.0 124.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:3.77 (2.3%) stddev-sans-first:3.97 19:50:36 INFO - PID 13766 | Values: 164.0 163.0 162.0 162.0 163.0 174.0 164.0 165.0 167.0 169.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.00 stddev:33.64 (44.8%) stddev-sans-first:35.31 19:50:36 INFO - PID 13766 | Values: 74.0 75.0 75.0 181.0 74.0 76.0 75.0 74.0 98.0 74.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:82.00 stddev:23.79 (29.0%) stddev-sans-first:24.59 19:50:36 INFO - PID 13766 | Values: 82.0 84.0 131.0 82.0 82.0 82.0 132.0 82.0 83.0 132.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:50:36 INFO - PID 13766 | Values: 113.0 113.0 114.0 113.0 114.0 114.0 113.0 114.0 113.0 113.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 19:50:36 INFO - PID 13766 | Values: 151.0 149.0 150.0 150.0 149.0 151.0 149.0 150.0 149.0 150.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.50 stddev:3.06 (3.2%) stddev-sans-first:3.24 19:50:36 INFO - PID 13766 | Values: 95.0 95.0 94.0 94.0 95.0 104.0 94.0 94.0 95.0 94.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.43 (2.6%) stddev-sans-first:1.51 19:50:36 INFO - PID 13766 | Values: 55.0 58.0 54.0 55.0 58.0 55.0 55.0 54.0 55.0 55.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 19:50:36 INFO - PID 13766 | Values: 53.0 54.0 55.0 54.0 53.0 54.0 53.0 54.0 54.0 54.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:0.82 (1.1%) stddev-sans-first:0.73 19:50:36 INFO - PID 13766 | Values: 79.0 78.0 77.0 78.0 78.0 79.0 77.0 77.0 77.0 77.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:130.50 stddev:14.47 (11.1%) stddev-sans-first:15.30 19:50:36 INFO - PID 13766 | Values: 131.0 130.0 126.0 144.0 125.0 129.0 129.0 135.0 123.0 172.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:181.00 stddev:4.53 (2.5%) stddev-sans-first:4.79 19:50:36 INFO - PID 13766 | Values: 181.0 194.0 180.0 181.0 180.0 185.0 178.0 181.0 180.0 181.0 19:50:36 INFO - PID 13766 | 19:50:36 INFO - PID 13766 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:71.00 stddev:2.71 (3.8%) stddev-sans-first:2.87 19:50:36 INFO - PID 13766 | Values: 70.0 71.0 68.0 71.0 76.0 67.0 68.0 72.0 68.0 72.0 19:50:36 INFO - PID 13766 | -------- Summary: end -------- 19:50:36 INFO - PID 13766 | 19:50:37 INFO - PID 13766 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:50:37 INFO - TEST-INFO | 13766: exit 0 19:50:37 INFO - TEST-OK | kraken | took 61458ms 19:50:37 INFO - SUITE-END | took 1174s 19:50:38 INFO - Completed test suite (00:19:35) 19:50:38 INFO - javascript benchmark 19:50:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8337.985512984365, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.6127984002, 3141.638711548172, 3173.4922412414016, 3186.7131958123764, 3186.7609929255295, 5978.163057171994, 6040.214772079635, 6047.455728984391, 6053.757849686018, 6144.416280453361, 6063.151158837766, 6089.939100608993, 6128.3258841527395, 6132.264128304599, 6147.47746441553, 5549.334079910396, 5576.1356989666665, 5581.6930068846295, 5620.634658747189, 5628.268325117729, 5522.806701765439, 5590.944090559083, 5591.552675785927, 5599.552035837123, 5606.187102870082, 5595.020871347519, 5596.804111856086, 5600.299962504687, 5604.579656525777, 5625.099984002561, 5625.634333768292, 5629.831105066854, 5633.436656334375, 5635.126555383922, 5652.604317697763, 5500.697461639608, 5575.69333686647, 5598.524125449342, 5603.103503439471, 5681.573881958829, 6071.423214794588, 6097.57316987811, 6101.237345331833, 6185.876282474325, 6189.50483961282, 6331.398517140864, 6422.421982021594, 6490.415862572391, 6537.41163295301, 6592.439642630382, 6572.704228309737, 6584.9012264816065, 6590.242122155965, 6597.670116494156, 6599.8020059398295, 6084.30030546484, 6117.847053823645, 6122.4183702548635, 6130.203073600448, 6134.754609815602, 5079.847604571869, 6644.767433139817, 6731.596104233761, 6735.663216839139, 6743.15710536183, 6146.7233974471255, 6312.684365781693, 6394.648294343856, 6414.61512309263, 6415.871682566416, 6376.808695739135, 6452.77415290472, 6500.967495162494, 6507.446867016262, 6537.967310163419, 5702.54379649627, 6408.67956602168, 6437.967810160919, 6572.4084832365315, 6588.209414870246, 6053.086846918079, 6589.077529145923, 6631.668416579152, 6638.269790323061, 6655.567388119756, 5123.795048198105, 5222.321098257202, 5304.867378315495, 5402.135658294654, 5403.5136837684795, 4552.863414097583, 4562.520935301812, 4566.132434837436, 4567.908641827211, 4568.406107206109, 5663.716814159358, 5669.489745922804, 5669.518090962314, 5679.37526872052, 5679.8864022720145, 6514.6416947068365, 6515.902261466082, 6518.902216466757, 6522.902156467657, 6530.151080359523, 5633.464820842096, 5652.802151924745, 5664.461876121762, 5707.686077265707, 5720.08478643415, 5713.085906255063, 5801.187833703285, 5815.331236907725, 5832.0, 5873.119032145212, 6319.115323854664, 6348.301686814539, 6389.329120442287, 6396.616203027833, 6413.743450262031, 6521.250056243593, 6618.801435956929, 6638.070670106285, 6641.867162656817, 6660.500462465237, 6340.904886426615, 6356.078368636429, 6361.936380636134, 6407.8718425630295, 6485.837854053686, 6414.390632889868, 6415.0, 6420.1974753155855, 6504.934950650433, 6513.674316284261, 6490.156279683611, 6530.575512591667, 6587.341265873566, 6641.236257830411, 6648.83377915556, 6248.156498872594, 6317.147185129948, 6330.272018717907, 6351.904721429275, 6438.710258038306, 6347.174867267226, 6374.171357723651, 6386.201724784402, 6386.9680651596445, 6388.361163883575, 6294.842628934313, 6301.495880329654, 6303.558750887394, 6331.05034244867, 6350.841228969312, 6340.9048864268, 6396.712147953446, 6397.552171347961, 6466.191726034246, 6493.675316234075, 6190.907136392868, 6211.596246243979, 6309.558330916791, 6320.431161195331, 6328.114064031131], "value": 5961.430719351552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.6789232468526, 838.358655628444, 857.9742607721769, 881.9691310804124, 895.9283257339409, 39537.0, 40418.1916361673, 40619.79690101553, 40747.185056298855, 40832.79583602085, 37916.0, 38367.232655346874, 38425.807870960605, 38547.03632409191, 38632.42051369232, 6696.832579185523, 6849.657517124148, 6865.4850886183485, 6865.828354291133, 6885.690143943534, 6841.5552989055805, 6914.930850691479, 6921.411680007205, 6955.02629631852, 6985.161780586337, 6869.725210991554, 6890.035395044698, 6896.379325860671, 6897.3447522485285, 6967.303269673042, 6848.212455567624, 6870.690818913136, 6873.175218973705, 6890.379865812076, 6936.375726184668, 6258.06129080637, 6300.21247344082, 6349.079383489415, 6349.873002539969, 6357.364263573651, 32958.50562241568, 33052.6694733052, 33254.50118248228, 33301.33397332064, 33375.49936750951, 3355.8489867956, 3391.5251864738957, 3394.0, 3396.2018925552475, 3407.897763067112, 26895.462090758272, 29087.0, 29680.70319296801, 30963.84518077395, 31115.53326700079, 4667.556582124693, 4794.640401969867, 4877.561019508225, 4932.5807306379, 4948.208286674151, 190869.0, 190913.0, 191995.0, 192932.0, 193132.0343398288, 49172.50827491679, 49836.50163498391, 49993.75003125034, 50168.74915625399, 50195.247071293226, 52196.0, 52351.73824130855, 52373.73813130986, 52385.0, 52466.73766631143, 16402.671946561, 16433.09617970999, 16565.58586035359, 16577.254023568967, 16601.833981660027, 13732.45070197201, 13807.17156970565, 13839.723205535833, 13854.30728463593, 13856.237906915216, 14042.0, 14042.297885105703, 14300.284985750672, 14338.139711617336, 14507.782383264259, 5963.254593175853, 5982.551308651869, 6023.216981792339, 6114.480269177081, 6151.692415379213, 950.9809803803885, 977.203579083045, 977.2328721953232, 1009.3590569987964, 1034.343192073039, 22187.779672117864, 22406.215782447536, 22782.31653050411, 22918.197863075045, 22984.425389365064, 1084.4794498640697, 1084.6312253833735, 1104.3925840787535, 1116.3636727065657, 1123.1183520936027, 11593.263279687575, 11828.52685892572, 11961.940190298992, 12079.0, 12130.636080917586, 242706.0, 243372.0, 243795.0, 244088.0, 244947.0, 51981.48018519842, 52175.47824521782, 52197.21704174441, 52341.2148817768, 52395.73802130965, 1425.9215743134228, 1471.830739464954, 1474.8303945046243, 1476.6751314710746, 1476.7858660493953, 21265.78734212638, 22306.0, 22469.325920222418, 22693.773062269825, 22913.65629515525, 34204.31591368208, 34278.314433710686, 34340.65659343375, 34441.48337774885, 34490.65509344975, 184748.0, 185646.0, 186499.0, 186606.0, 188110.05944970186, 31117.53323700101, 31239.53140702846, 31266.53100203544, 31522.68477315289, 34093.0, 37551.624483754815, 37644.43533347057, 38227.42658860064, 43367.34948975831, 43812.0, 30804.691953080182, 30984.380312394078, 31542.0, 31712.0, 33567.83216083904, 32878.83560582182, 33596.83201583976, 33915.3216935655, 34000.31999359949, 34332.0, 34725.47911781275, 36074.63925360713, 36456.08859778527, 36724.63275367212, 36775.448368275036, 31854.0, 33040.33919321552, 33173.33653326872, 33225.50161747624, 33518.0, 23635.64546531838, 23763.098952084136, 24057.75942240555, 24529.264122076365, 24951.126710565044], "value": 16644.59979381015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2413977340253, 573.936866944636, 575.160266011623, 580.7851095094816, 586.6069733278703, 21428.464288392777, 22181.778182218193, 22195.11219551218, 22244.666330005064, 22270.88864555679, 24682.136125235622, 25871.611925821082, 26288.342791430223, 27318.59022114665, 27564.310892227706, 6529.771457998982, 6689.598624082546, 6702.961041038647, 6711.060451536764, 6711.664416779166, 6582.8683426331445, 6593.044008618771, 6599.043138744879, 6606.4384527315, 6619.073329733817, 3850.788206648633, 4156.833726650931, 6179.814605561818, 6566.9821177717295, 6618.040384144296, 6546.574472659262, 6580.0, 6598.901016484757, 6620.30486798884, 6641.302663220341, 6131.540134489886, 6142.8771424571705, 6146.231721034871, 6168.352323006065, 6182.258129024501, 29237.707622923925, 30416.239594010105, 30677.69322306771, 30836.84581577078, 30906.53640195399, 1888.2163901980662, 1907.675695131817, 1917.8849269043762, 1918.2710569983456, 1927.4892153579312, 19155.32956346535, 19466.0, 19476.70784938227, 19483.0, 19496.70754938677, 2191.3425972208433, 2335.74306826249, 2368.810495160383, 2427.526632306701, 2440.04838113136, 134945.0, 137382.3130884339, 137952.620473795, 138791.0, 139352.0, 14909.329080191417, 15050.623734406727, 15104.885316055761, 15185.544433667008, 15328.23725271608, 21639.35081947544, 21658.675119873216, 21857.890710546664, 21894.78105218959, 21897.671534926987, 9994.0, 10132.898671013196, 10190.133838623651, 10212.08091271789, 10564.683059508227, 9770.36492627977, 9776.902230977741, 9820.607175712892, 9840.261980351503, 9845.655402061037, 8792.736217913473, 9199.632014719336, 9212.401193922373, 9222.123898229658, 9462.621495140254, 2741.629879966219, 2778.569321755131, 4303.806328715153, 4382.905471147318, 4562.726236425825, 919.117647058831, 924.1359329027381, 944.2257348973776, 949.107838631684, 954.2604481526872, 24879.129230476847, 25771.226863194133, 25993.870030650105, 26034.609480857423, 26206.606900896502, 1034.425893629043, 1052.0478966535297, 1071.5874388360537, 1071.807074726541, 1079.5088234853124, 10917.235793494538, 11347.0, 11620.941895290638, 11701.94682478564, 11925.70185745346, 477034.0, 497222.0, 507556.0, 510669.0, 528263.0, 121320.39339803245, 122165.0, 124021.37989309996, 125303.37348313382, 125550.37224813817, 1238.721287710258, 1284.5504073574175, 1302.3553341096217, 1312.2612538386675, 1316.967075823093, 17633.647327053644, 18353.724694129865, 18670.906645466686, 18914.43256702301, 18929.33747318837, 57089.0, 58538.12192817196, 58550.0, 58564.707176463846, 62463.68768156312, 75178.24821751713, 75359.62320188365, 75387.0, 76544.61727691548, 76849.0, 14650.120992740469, 15388.769168462706, 15413.152276624893, 15512.92243538775, 15527.922360388126, 23894.641580376658, 23928.641070384307, 24109.397265068514, 24168.033278669358, 24886.875565622056, 18192.272309108015, 19123.0, 19127.426177214707, 19210.8078919209, 19273.132709027846, 15874.285657145225, 16674.833251667813, 17716.202770875083, 17722.46832595024, 18303.725444118616, 19167.233310667416, 19659.311924082587, 19801.504962376057, 19893.502662433555, 20283.087261072993, 14939.925300373428, 15261.465848695243, 15342.23288835576, 15359.617634412509, 15461.84538154604, 18036.54908627295, 18779.436616901516, 19051.237950481827, 19147.521311967314, 19278.518037049187], "value": 12326.99470140496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.8777909988098, 1409.337611322678, 1421.4456362018807, 1423.5088894331452, 1424.935877885495, 12521.686957826047, 13027.544035958743, 13095.803562946563, 13169.670758231048, 13208.207507549541, 12732.809007864866, 13004.0, 13130.606081817561, 13139.408726607302, 13148.934255328733, 2581.948361032783, 2676.51822671919, 2676.5985102234627, 2680.276325392143, 2682.1953413975825, 2504.186139504659, 2571.562834318161, 2596.701379341381, 2599.597062455313, 2607.4915391498666, 2461.692288463942, 2532.2529853693204, 2570.190390027145, 2582.173704414588, 2585.5346037713202, 2551.170869467421, 2623.8688065596643, 2629.4872499862536, 2637.103384849141, 2648.9337766555795, 2557.09223225754, 2585.818992670514, 2590.171145233526, 2591.663083799113, 2594.818362714611, 12934.029947753956, 12983.545575904893, 13017.934910325388, 13053.934730326288, 13119.803202951867, 7123.572585644878, 7430.108386993541, 7451.739189128354, 7473.177950425449, 7516.98520699704, 4735.431748190204, 4789.185838407479, 4975.527324904128, 5007.799688012475, 5013.473585273567, 1727.3522429089091, 1776.5292197567655, 1793.8608983295571, 1851.7500137481536, 1852.1202428846325, 20276.797232027788, 20480.59038819215, 20495.385138445723, 20604.0, 20659.380218593466, 6050.636961782219, 6082.36135205797, 6135.723892424851, 6292.653904035322, 6299.118123462719, 14607.634809129857, 14626.0, 14653.267336633126, 14659.0, 14691.632709182357, 6797.626130562867, 7049.7885063448175, 7053.753118640926, 7070.75252366175, 7070.964645176741, 6512.218533775977, 6590.3080176581725, 6646.401823835878, 6683.2314283857, 6816.556923799937, 4729.597984171315, 4799.712017278975, 4852.684575502581, 4909.533594308535, 5090.363704536933, 1402.558194168854, 1412.5268035208321, 1416.525463969561, 1426.2583456602715, 1435.468876515696, 874.226309715906, 881.5988725130051, 901.6663834381321, 902.4900930973979, 911.0570559471048, 7079.327463890922, 7103.183133939663, 7211.278872112852, 7233.0, 7245.275472452818, 705.263000164829, 717.7703134996856, 723.7430712097236, 732.2238427267007, 737.0455260437745, 5196.714180720097, 5255.816046438356, 5311.521963023347, 5490.450954904478, 5573.024720673866, 16778.1610919456, 17483.912580437016, 17505.474835754947, 17514.562135946704, 17524.737128943078, 17173.656526869392, 17293.481195564153, 17299.13504324779, 18597.16312765929, 18926.905365473085, 10188.235882308856, 10414.895851041545, 10446.0, 10513.737156571147, 10665.573377064831, 7471.066116735408, 8077.919220807717, 8140.470869393471, 8267.545285009382, 8394.748157555283, 14895.47865824691, 15658.217089145724, 16373.09947952874, 16450.83549164541, 16610.50168494947, 15632.531024069296, 15881.0, 15894.761578576099, 16617.91691041537, 16777.580560485596, 10745.677629671123, 11086.944565277123, 11093.5562577496, 11136.164787640797, 11144.442777860912, 12321.568745093879, 12331.0, 12440.937795310965, 12499.312537810507, 12538.310392928477, 10029.899701002896, 10191.898081019095, 10311.639092631722, 10317.638882639072, 10442.269041167045, 9790.608375664893, 10193.439360835226, 10214.233932454947, 10321.845172322272, 10345.482725863527, 8727.476351418934, 8875.378723489552, 8895.243904268209, 8931.151540603632, 8952.28381729447, 6264.718087685974, 6416.839579010562, 6721.1598550181225, 6752.426043786137, 6945.131858517685, 6998.930010699828, 7073.6816843243205, 7075.893861591977, 7122.0, 7143.1428228612895], "value": 6055.792109271228, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.6078799882417, 502.6807976934645, 514.7426286856572, 520.5549255386644, 522.0837430309808, 5913.172155898178, 6008.158857759906, 6031.246094238215, 6040.818775436738, 6122.448979591836, 5815.185873977646, 5924.259467566554, 5942.643441393519, 5966.374795090168, 6014.849628759283, 4993.300937868701, 5069.3663292088395, 5101.362329708786, 5102.668326558781, 5128.666636668605, 5037.3451451311275, 5059.620528460362, 5066.150854937958, 5074.416442109168, 5131.102057140004, 5042.369703787027, 5097.49025097491, 5110.361204849394, 5123.2827404163445, 5123.615728820335, 4886.853394398174, 4957.851264462072, 5002.324686167357, 5031.949680503203, 5077.619178561604, 4599.632029437637, 4629.560191781776, 4632.0, 4635.165670179366, 4645.5354464553275, 5826.0, 5826.737796799154, 5828.854278643025, 5908.852278693067, 5913.7232165616115, 5788.960795582353, 5819.185314056035, 5820.912686309709, 5830.7667693292215, 5870.471657550798, 6387.584806987531, 6407.743690252384, 6421.357864213588, 6449.032645103225, 6464.903026454607, 5082.949170508322, 5130.743462826844, 5138.948610513884, 5204.115300398941, 5207.635465517377, 6679.732810687616, 6702.731890724365, 6787.423069039138, 6818.465845184844, 6852.417544508673, 5373.769885497553, 5375.435579264199, 5398.4871437213405, 5430.104032834617, 5458.2904222450825, 5445.809396671098, 5457.263269458652, 5512.200730893998, 5524.453153117053, 5570.86072848182, 5654.660720356792, 5868.823935281948, 5892.852678682982, 5895.852603684943, 5902.852428689317, 6424.710888009958, 6426.196725409324, 6437.25971513282, 6467.348387161335, 6509.837254068686, 1915.9329423470112, 1930.6814375628146, 1933.7486126803708, 1933.7582802149732, 1938.185961896007, 1303.244118411319, 1409.9013069085065, 1434.153849228939, 1437.252628633105, 1451.5717863230373, 5439.945600543944, 5504.2294078829, 5508.20131080991, 5572.609917305831, 5657.0, 6229.345918678564, 6409.198850143732, 6445.613263204223, 6496.610203387811, 6539.673016349164, 5595.608307418523, 5600.215969764236, 5621.80323688669, 5707.74315155819, 5716.1997320375185, 3392.2028323343993, 3461.394256005189, 3475.913102172415, 3482.460218666111, 3508.2808024354945, 6279.497640188774, 6284.308726040132, 6303.243610766645, 6314.621122732558, 6346.143270658495, 6565.8358541035905, 6566.212054553484, 6619.0, 6626.271110177877, 6710.899336509956, 6223.657698826608, 6272.560920735596, 6281.59169653971, 6358.33237510064, 6363.90454143179, 6462.838429039123, 6479.384458476437, 6492.545521813617, 6518.641474718936, 6554.934450655433, 6400.743970241138, 6453.096566480603, 6524.771632992823, 6543.247526534509, 6556.508261880283, 6333.461655759312, 6375.521835862236, 6387.754387894316, 6404.775832845828, 6420.582662126947, 5308.309919710413, 5325.201219817059, 5346.866328341823, 5356.116240820221, 5359.097520380365, 6453.741850325934, 6474.902876456951, 6493.603875166862, 6529.444997175104, 6549.574277671936, 6228.56400051992, 6294.968525157345, 6330.3669633036325, 6341.017142342944, 6378.011408231731, 6384.744610215539, 6386.521010924293, 6412.487001039999, 6424.0, 6426.646534440651, 6260.968695156495, 6288.245410550763, 6323.588966717149, 6324.747010119728, 6333.303336632875, 6291.276503202007, 6333.145025421509, 6396.273006288369, 6398.0, 6453.677316134081, 5660.377358490645, 6213.316535181036, 6222.906656400067, 6230.0, 6313.715882785377], "value": 5058.050215308012, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.9210417114549, 933.9019402962689, 947.4457442396198, 948.4356807699417, 957.7509847439663, 18133.0, 18319.633607327847, 18743.4376968691, 18755.4373368799, 18767.906160469214, 19369.709454358162, 19946.401607951786, 20411.285605003828, 20544.97275136241, 20705.0, 1036.0520124086452, 1052.5947510208548, 1053.2048303530823, 1058.3068090400761, 1060.6340812419703, 1058.2222066780948, 1061.495789499989, 1062.7768168684586, 1065.0361422912276, 1066.7653116314398, 1045.9424731639795, 1125.6004118537924, 1125.656674714212, 1132.2866594045781, 1140.4126874659557, 1078.0190027075323, 1083.2958576925023, 1086.1907878630432, 1087.2009073331096, 1087.2335003822286, 786.0410299434681, 790.5177841516728, 791.0665414810521, 791.2601717394255, 791.4380789639363, 18258.543536411562, 18823.24707011718, 19175.0, 19210.327638532584, 19402.22391104354, 19157.137928793098, 19518.902405487883, 19916.402507924784, 19950.700739488773, 19979.700304495444, 15076.924615376962, 15376.53870383879, 15423.0, 15475.226238688021, 15513.146776927377, 3395.7622966392114, 3418.1454636340914, 3425.469052296898, 3438.277961628061, 3446.0695612184822, 106284.0, 108990.45504772505, 109138.45430772875, 111747.0, 113568.4321578395, 13807.240601767, 13952.372143253579, 13968.092074015156, 13987.79018314726, 14141.43434262618, 27233.183004509898, 28933.0, 28978.27554311159, 29016.564751528746, 29154.708452915624, 8377.539235341992, 8540.444871083484, 8558.101399353103, 8587.184217499327, 8593.871091933626, 4045.615666511677, 4077.6533994610195, 4094.324436468009, 4125.876223713293, 4145.0, 4750.572448479654, 4986.351774269322, 5021.548060674557, 5028.371453568304, 5031.270465782441, 894.458852394305, 929.8977112517617, 940.7459985803931, 962.2254085461271, 963.3930623707159, 623.8440389902524, 666.1839246922481, 708.8794904866185, 719.4388377065897, 720.0782997762872, 11499.137564682682, 12097.947187692222, 12317.568885088978, 12658.177218480769, 12744.80882786759, 674.8380388706676, 695.4818660098259, 702.4415589606275, 714.8391611887283, 715.1775458223085, 5535.889282214333, 5617.101263797855, 5630.296212973379, 5656.151577263361, 5698.458646428583, 97605.0, 98221.0, 98737.0, 99088.0, 102607.4869625662, 87343.0, 87876.0, 89463.0, 91194.54402727944, 94833.0, 79057.60471197723, 79098.0, 80066.5996670013, 82494.58752706199, 83088.99999999879, 11368.886311136783, 11896.940515297369, 12027.939860300992, 12125.75748485043, 12642.620721378373, 34727.0, 35564.644353556134, 35773.622291021675, 36123.0, 37125.814370927976, 61060.389396107246, 64219.0, 66264.0, 66749.33250667431, 66963.0, 18461.16924738417, 18600.441986740418, 19182.808171918103, 19192.71210931865, 19691.326237269994, 19837.0, 20750.896245518677, 20850.478738031063, 21049.89475052676, 21524.784752152278, 18638.81361186425, 18757.90621046886, 19334.419967401, 19382.61234775325, 19603.509912252306, 18890.52773680669, 18933.90533047326, 19365.515862102995, 19410.320638777575, 19882.204711811366, 17757.46727598174, 18777.248910043447, 18854.245830167187, 18949.526261843563, 18961.241550337832, 14120.788188177392, 14209.715805683622, 14222.644433888821, 14421.42314307416, 14453.132812031312, 13966.860331396556, 14083.366248519047, 14092.436302547783, 14129.788053179005, 14202.715945680822], "value": 8968.173497017644, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 108.0, 107.0, 111.0, 108.0, 109.0, 110.0, 109.0, 108.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 153.0, 172.0, 122.0, 151.0, 152.0, 128.0, 168.0, 124.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 163.0, 174.0, 164.0, 165.0, 167.0, 169.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 181.0, 74.0, 76.0, 75.0, 74.0, 98.0, 74.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 131.0, 82.0, 82.0, 82.0, 132.0, 82.0, 83.0, 132.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 150.0, 149.0, 151.0, 149.0, 150.0, 149.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 104.0, 94.0, 94.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 54.0, 55.0, 58.0, 55.0, 55.0, 54.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 78.0, 78.0, 79.0, 77.0, 77.0, 77.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 126.0, 144.0, 125.0, 129.0, 129.0, 135.0, 123.0, 172.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 194.0, 180.0, 181.0, 180.0, 185.0, 178.0, 181.0, 180.0, 181.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 68.0, 71.0, 76.0, 67.0, 68.0, 72.0, 68.0, 72.0], "value": 70.3, "unit": "score"}]}]} 19:50:38 INFO - Return code: 0 19:50:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:50:38 INFO - # TBPL SUCCESS # 19:50:38 INFO - Running post-action listener: _package_coverage_data 19:50:38 INFO - Running post-action listener: _resource_record_post_action 19:50:38 INFO - [mozharness: 2017-07-11 02:50:38.233414Z] Finished run-tests step (success) 19:50:38 INFO - Running post-run listener: _resource_record_post_run 19:50:38 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 439484416; Read time: 12; Write time: 489496 19:50:38 INFO - TinderboxPrint: CPU usage
13.1% 19:50:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:50:38 INFO - TinderboxPrint: I/O write bytes / time
439,484,416 / 489,496 19:50:38 INFO - TinderboxPrint: CPU idle
8,269.5 (86.8%) 19:50:38 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 19:50:38 INFO - TinderboxPrint: Swap in / out
0 / 0 19:50:38 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109170688; Read time: 0; Write time: 156312 19:50:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:50:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 330313728; Read time: 0; Write time: 333184 19:50:38 INFO - Running post-run listener: _upload_blobber_files 19:50:38 INFO - Blob upload gear active. 19:50:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:50:38 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 19:50:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:50:39 INFO - (blobuploader) - INFO - Open directory for files ... 19:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:40 INFO - (blobuploader) - INFO - Done attempting. 19:50:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:50:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:50:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:43 INFO - (blobuploader) - INFO - Done attempting. 19:50:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:50:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:50:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:44 INFO - (blobuploader) - INFO - Done attempting. 19:50:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:50:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:50:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:50:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:50:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:50:45 INFO - (blobuploader) - INFO - Done attempting. 19:50:45 INFO - (blobuploader) - INFO - Iteration through files over. 19:50:45 INFO - Return code: 0 19:50:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:50:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:50:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79a105ccebfebb9ecca311ea66fcd7dda0765929d31dc54a8a9186bd317a4f78818276a4123815f5c37ab715f4cf0c3215fade56faacde5697104db9f01003b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d1d218fdcb8d12e59cd012c9c587dd1ead11301d8c174276090f78783982e4e432a01855949b10494d8888ba98a17afd6d720d3f7977b3a3b4e546c5eeb84e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18bb5b7c749fc782cf1cf75e1502212dbfb7e0dba513cb7021cdc08a1638bb11c671c0bdb07758eedfd08da72f8f7e7708a233bf565d457f88572afe150483a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c8e8eff0f908aefbd573c1f4a1f7b2789d655ef64acf57af476755142627aa8cd03a9ef09efe60544fe9a8f40d6bdf78de6114ba8f79f106b96739781fec10"} 19:50:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:50:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:50:45 INFO - Contents: 19:50:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79a105ccebfebb9ecca311ea66fcd7dda0765929d31dc54a8a9186bd317a4f78818276a4123815f5c37ab715f4cf0c3215fade56faacde5697104db9f01003b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d1d218fdcb8d12e59cd012c9c587dd1ead11301d8c174276090f78783982e4e432a01855949b10494d8888ba98a17afd6d720d3f7977b3a3b4e546c5eeb84e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18bb5b7c749fc782cf1cf75e1502212dbfb7e0dba513cb7021cdc08a1638bb11c671c0bdb07758eedfd08da72f8f7e7708a233bf565d457f88572afe150483a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c8e8eff0f908aefbd573c1f4a1f7b2789d655ef64acf57af476755142627aa8cd03a9ef09efe60544fe9a8f40d6bdf78de6114ba8f79f106b96739781fec10"} 19:50:45 INFO - Running post-run listener: copy_logs_to_upload_dir 19:50:45 INFO - Copying logs to upload dir... 19:50:45 INFO - mkdir: /builds/slave/test/build/upload/logs 19:50:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.743337 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-10 19:50:45.433323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:45.437197) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79a105ccebfebb9ecca311ea66fcd7dda0765929d31dc54a8a9186bd317a4f78818276a4123815f5c37ab715f4cf0c3215fade56faacde5697104db9f01003b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d1d218fdcb8d12e59cd012c9c587dd1ead11301d8c174276090f78783982e4e432a01855949b10494d8888ba98a17afd6d720d3f7977b3a3b4e546c5eeb84e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18bb5b7c749fc782cf1cf75e1502212dbfb7e0dba513cb7021cdc08a1638bb11c671c0bdb07758eedfd08da72f8f7e7708a233bf565d457f88572afe150483a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c8e8eff0f908aefbd573c1f4a1f7b2789d655ef64acf57af476755142627aa8cd03a9ef09efe60544fe9a8f40d6bdf78de6114ba8f79f106b96739781fec10"} build_url:https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/OtRgFQB_SSeTZ-Yqm0eoYw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f79a105ccebfebb9ecca311ea66fcd7dda0765929d31dc54a8a9186bd317a4f78818276a4123815f5c37ab715f4cf0c3215fade56faacde5697104db9f01003b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d1d218fdcb8d12e59cd012c9c587dd1ead11301d8c174276090f78783982e4e432a01855949b10494d8888ba98a17afd6d720d3f7977b3a3b4e546c5eeb84e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c18bb5b7c749fc782cf1cf75e1502212dbfb7e0dba513cb7021cdc08a1638bb11c671c0bdb07758eedfd08da72f8f7e7708a233bf565d457f88572afe150483a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25c8e8eff0f908aefbd573c1f4a1f7b2789d655ef64acf57af476755142627aa8cd03a9ef09efe60544fe9a8f40d6bdf78de6114ba8f79f106b96739781fec10"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:45.460517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:45.460801) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1499737799.172485-670853408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004711 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 19:50:45.544558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 19:50:45.544880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 19:50:45.545148) ========= ========= Total master_lag: 0.16 =========