builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1496138036.0 results: success (0) revision: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:55.997236) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.002942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.003289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.058569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.058828) ========= 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=8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 02:53:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.6M=0s 2017-05-30 02:53:56 (94.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.165068) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.165352) ========= 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=8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.226880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.227163) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 --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 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 --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=8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 02:53:56,445 truncating revision to first 12 chars 2017-05-30 02:53:56,445 Setting DEBUG logging. 2017-05-30 02:53:56,445 attempt 1/10 2017-05-30 02:53:56,445 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c712d76d598?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 02:53:56,749 unpacking tar archive at: mozilla-central-0c712d76d598/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.851037) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.854367) ========= script_repo_revision: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.854788) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.855059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 02:53:56.864022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2017-05-30 02:53:56.864293) ========= /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=8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:53:57 INFO - MultiFileLogger online at 20170530 02:53:57 in /builds/slave/test 02:53:57 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 02:53:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:53:57 INFO - {'append_to_log': False, 02:53:57 INFO - 'base_work_dir': '/builds/slave/test', 02:53:57 INFO - 'blob_upload_branch': 'Firefox', 02:53:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:53:57 INFO - 'branch': 'Firefox', 02:53:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:53:57 INFO - 'config_files': ('talos/linux_config.py',), 02:53:57 INFO - 'default_actions': ('clobber', 02:53:57 INFO - 'read-buildbot-config', 02:53:57 INFO - 'download-and-extract', 02:53:57 INFO - 'populate-webroot', 02:53:57 INFO - 'create-virtualenv', 02:53:57 INFO - 'install', 02:53:57 INFO - 'setup-mitmproxy', 02:53:57 INFO - 'run-tests'), 02:53:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:53:57 INFO - 'download_minidump_stackwalk': True, 02:53:57 INFO - 'download_symbols': 'ondemand', 02:53:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:53:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:53:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:53:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:53:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:53:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:53:57 INFO - 'gecko_profile': False, 02:53:57 INFO - 'gecko_profile_interval': 0, 02:53:57 INFO - 'installer_path': 'installer.exe', 02:53:57 INFO - 'log_level': 'info', 02:53:57 INFO - 'log_name': 'talos', 02:53:57 INFO - 'log_to_console': True, 02:53:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:53:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:53:57 INFO - 'opt_config_files': (), 02:53:57 INFO - 'pip_index': False, 02:53:57 INFO - 'suite': 'dromaeojs-e10s', 02:53:57 INFO - 'system_bits': '32', 02:53:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:53:57 INFO - 'title': 'talos-linux64-ix-038', 02:53:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:53:57 INFO - 'use_talos_json': True, 02:53:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:53:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:53:57 INFO - 'work_dir': 'build'} 02:53:57 INFO - [mozharness: 2017-05-30 09:53:57.176207Z] Running clobber step. 02:53:57 INFO - Running pre-action listener: _resource_record_pre_action 02:53:57 INFO - Running main action method: clobber 02:53:57 INFO - rmtree: /builds/slave/test/build 02:53:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:53:58 INFO - Running post-action listener: _resource_record_post_action 02:53:58 INFO - [mozharness: 2017-05-30 09:53:58.728462Z] Finished clobber step (success) 02:53:58 INFO - [mozharness: 2017-05-30 09:53:58.728563Z] Running read-buildbot-config step. 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: read_buildbot_config 02:53:58 INFO - Using buildbot properties: 02:53:58 INFO - { 02:53:58 INFO - "project": "", 02:53:58 INFO - "product": "firefox", 02:53:58 INFO - "who": "cbook@mozilla.com", 02:53:58 INFO - "installer_path": "public/build/target.tar.bz2", 02:53:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:53:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:53:58 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:53:58 INFO - "stage_platform": "linux64-stylosequential", 02:53:58 INFO - "basedir": "/builds/slave/test", 02:53:58 INFO - "buildnumber": 32, 02:53:58 INFO - "platform": "ubuntu64_hw_styloseq", 02:53:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:53:58 INFO - "slavebuilddir": "test", 02:53:58 INFO - "taskId": "SMMi7RcTRCecYOaGaQO2bg", 02:53:58 INFO - "branch": "mozilla-central", 02:53:58 INFO - "script_repo_revision": "production", 02:53:58 INFO - "revision": "0c712d76d598ec92a7adaaf7180fd4e559f9abc0", 02:53:58 INFO - "slavename": "talos-linux64-ix-038", 02:53:58 INFO - "repo_path": "mozilla-central" 02:53:58 INFO - } 02:53:58 INFO - Finding installer, test and symbols from parent task. 02:53:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SMMi7RcTRCecYOaGaQO2bg'}, attempt #1 02:53:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SMMi7RcTRCecYOaGaQO2bg'}, attempt #1 02:53:59 INFO - Task dependencies: AA8B3mXORxmPMa2Whv_bfw 02:53:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw'}, attempt #1 02:54:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2 02:54:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/test_packages.json 02:54:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.crashreporter-symbols.zip 02:54:00 INFO - Running post-action listener: _resource_record_post_action 02:54:00 INFO - [mozharness: 2017-05-30 09:54:00.088507Z] Finished read-buildbot-config step (success) 02:54:00 INFO - [mozharness: 2017-05-30 09:54:00.088732Z] Running download-and-extract step. 02:54:00 INFO - Running pre-action listener: _resource_record_pre_action 02:54:00 INFO - Running main action method: download_and_extract 02:54:00 INFO - mkdir: /builds/slave/test/build/tests 02:54:00 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')]} 02:54:00 INFO - trying https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.test_packages.json 02:54:00 INFO - Downloading https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:54:00 INFO - Downloaded 986 bytes. 02:54:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:54:00 INFO - Using the following test package requirements: 02:54:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:54:00 INFO - u'common': [u'target.common.tests.zip'], 02:54:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:54:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:54:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:54:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:54:00 INFO - u'mozbase': [u'target.common.tests.zip'], 02:54:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:54:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:54:00 INFO - u'web-platform': [u'target.common.tests.zip', 02:54:00 INFO - u'target.web-platform.tests.zip'], 02:54:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:54:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:54:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.common.tests.zip 02:54:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:54:00 INFO - Fetch https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.common.tests.zip into memory 02:54:03 INFO - Content-Length response header: 63528408 02:54:03 INFO - Bytes received: 63528408 02:54:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:54:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.common.tests.zip 02:54:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:54:14 INFO - Fetch https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.common.tests.zip into memory 02:54:15 INFO - Content-Length response header: 63528408 02:54:15 INFO - Bytes received: 63528408 02:54:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.talos.tests.zip 02:54:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:54:33 INFO - Fetch https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.talos.tests.zip into memory 02:54:34 INFO - Content-Length response header: 14447425 02:54:34 INFO - Bytes received: 14447425 02:54: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')]} 02:54:34 INFO - trying https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2 02:54:34 INFO - Downloading https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:54:35 INFO - Downloaded 56002478 bytes. 02:54:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2 02:54:35 INFO - mkdir: /builds/slave/test/properties 02:54:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:54:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:54:35 INFO - Contents: 02:54:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2 02:54:35 INFO - Running post-action listener: _resource_record_post_action 02:54:35 INFO - Running post-action listener: set_extra_try_arguments 02:54:35 INFO - [mozharness: 2017-05-30 09:54:35.765499Z] Finished download-and-extract step (success) 02:54:35 INFO - [mozharness: 2017-05-30 09:54:35.765597Z] Running populate-webroot step. 02:54:35 INFO - Running pre-action listener: _resource_record_pre_action 02:54:35 INFO - Running main action method: populate_webroot 02:54:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:54:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:54:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:54:35 INFO - '--tppagecycles', 02:54:35 INFO - '7'], 02:54:35 INFO - 'tests': ['tsvgm']}}, 02:54:35 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:54:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:54:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:54:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:54:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['damp', 'tps']}, 02:54:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'tests': ['damp', 'tps']}, 02:54:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['dromaeo_dom']}, 02:54:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:54:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:54:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:54:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:54:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['a11yr', 02:54:35 INFO - 'ts_paint', 02:54:35 INFO - 'tpaint', 02:54:35 INFO - 'sessionrestore', 02:54:35 INFO - 'sessionrestore_no_auto_restore', 02:54:35 INFO - 'tabpaint']}, 02:54:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:54:35 INFO - 'ts_paint', 02:54:35 INFO - 'tpaint', 02:54:35 INFO - 'sessionrestore', 02:54:35 INFO - 'sessionrestore_no_auto_restore', 02:54:35 INFO - 'tabpaint']}, 02:54:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:54:35 INFO - 'ts_paint', 02:54:35 INFO - 'tpaint', 02:54:35 INFO - 'sessionrestore', 02:54:35 INFO - 'sessionrestore_no_auto_restore', 02:54:35 INFO - 'tabpaint']}, 02:54:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:54:35 INFO - 'ts_paint', 02:54:35 INFO - 'tpaint', 02:54:35 INFO - 'sessionrestore', 02:54:35 INFO - 'sessionrestore_no_auto_restore', 02:54:35 INFO - 'tabpaint']}, 02:54:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['a11yr', 02:54:35 INFO - 'ts_paint', 02:54:35 INFO - 'tpaint', 02:54:35 INFO - 'sessionrestore', 02:54:35 INFO - 'sessionrestore_no_auto_restore', 02:54:35 INFO - 'tabpaint']}, 02:54:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['a11yr', 02:54:35 INFO - 'ts_paint', 02:54:35 INFO - 'tpaint', 02:54:35 INFO - 'sessionrestore', 02:54:35 INFO - 'sessionrestore_no_auto_restore', 02:54:35 INFO - 'tabpaint']}, 02:54:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:54:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:54:35 INFO - 'bloom_basic_ref']}, 02:54:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:54:35 INFO - 'talos_options': ['--mitmproxy', 02:54:35 INFO - 'mitmproxy-recording-1.mp', 02:54:35 INFO - '--firstNonBlankPaint'], 02:54:35 INFO - 'tests': ['Quantum_1']}, 02:54:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['tsvgx', 02:54:35 INFO - 'tsvgr_opacity', 02:54:35 INFO - 'tart', 02:54:35 INFO - 'tscrollx', 02:54:35 INFO - 'cart', 02:54:35 INFO - 'tsvg_static']}, 02:54:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:54:35 INFO - 'tsvgr_opacity', 02:54:35 INFO - 'tart', 02:54:35 INFO - 'tscrollx', 02:54:35 INFO - 'cart', 02:54:35 INFO - 'tsvg_static']}, 02:54:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'talos_options': ['--disable-e10s'], 02:54:35 INFO - 'tests': ['tp5o']}, 02:54:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:54:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'talos_options': ['--disable-e10s', 02:54:35 INFO - '--xperf_path', 02:54:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:35 INFO - 'tests': ['tp5n']}, 02:54:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:54:35 INFO - 'talos_options': ['--xperf_path', 02:54:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:54:35 INFO - 'tests': ['tp5n']}}, 02:54:35 INFO - 'talos.zip': {'path': '', 02:54:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:54:35 INFO - Running post-action listener: _resource_record_post_action 02:54:35 INFO - [mozharness: 2017-05-30 09:54:35.779945Z] Finished populate-webroot step (success) 02:54:35 INFO - [mozharness: 2017-05-30 09:54:35.780036Z] Running create-virtualenv step. 02:54:35 INFO - Running pre-action listener: _resource_record_pre_action 02:54:35 INFO - Running main action method: create_virtualenv 02:54:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:54:35 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 02:54:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:54:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:54:35 INFO - Using real prefix '/usr' 02:54:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:54:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:54:38 INFO - Installing pip.................done. 02:54:38 INFO - Return code: 0 02:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:54:38 INFO - Reading from file tmpfile_stdout 02:54:38 INFO - Output received: 02:54:38 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) 02:54:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:54:38 INFO - Using env: {'DISPLAY': ':0', 02:54:38 INFO - 'HOME': '/home/cltbld', 02:54:38 INFO - 'LANG': 'en_US.UTF-8', 02:54:38 INFO - 'LANGUAGE': 'en_US:en', 02:54:38 INFO - 'LOGNAME': 'cltbld', 02:54:38 INFO - 'MAIL': '/var/mail/cltbld', 02:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:38 INFO - 'MOZ_NO_REMOTE': '1', 02:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:38 INFO - 'NO_EM_RESTART': '1', 02:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:38 INFO - 'PWD': '/builds/slave/test', 02:54:38 INFO - 'SHELL': '/bin/bash', 02:54:38 INFO - 'SHLVL': '1', 02:54:38 INFO - 'TERM': 'linux', 02:54:38 INFO - 'TMOUT': '86400', 02:54:38 INFO - 'USER': 'cltbld', 02:54:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:38 INFO - '_': '/tools/buildbot/bin/python'} 02:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:38 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 02:54:38 INFO - Cleaning up... 02:54:38 INFO - Return code: 0 02:54:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:54:38 INFO - Using env: {'DISPLAY': ':0', 02:54:38 INFO - 'HOME': '/home/cltbld', 02:54:38 INFO - 'LANG': 'en_US.UTF-8', 02:54:38 INFO - 'LANGUAGE': 'en_US:en', 02:54:38 INFO - 'LOGNAME': 'cltbld', 02:54:38 INFO - 'MAIL': '/var/mail/cltbld', 02:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:38 INFO - 'MOZ_NO_REMOTE': '1', 02:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:38 INFO - 'NO_EM_RESTART': '1', 02:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:38 INFO - 'PWD': '/builds/slave/test', 02:54:38 INFO - 'SHELL': '/bin/bash', 02:54:38 INFO - 'SHLVL': '1', 02:54:38 INFO - 'TERM': 'linux', 02:54:38 INFO - 'TMOUT': '86400', 02:54:38 INFO - 'USER': 'cltbld', 02:54:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:38 INFO - '_': '/tools/buildbot/bin/python'} 02:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:39 INFO - Downloading/unpacking psutil>=3.1.1 02:54: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 02:54: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 02:54: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 02:54: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 02:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:54:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:40 INFO - Installing collected packages: psutil 02:54:40 INFO - Running setup.py install for psutil 02:54:40 INFO - building 'psutil._psutil_linux' extension 02:54:40 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 02:54:40 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 02:54:40 INFO - building 'psutil._psutil_posix' extension 02:54:40 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 02:54:40 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 02:54:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:54:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:54:40 INFO - Successfully installed psutil 02:54:40 INFO - Cleaning up... 02:54:40 INFO - Return code: 0 02:54:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54: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')]} 02:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:40 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:40 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 02:54:40 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 02:54:40 INFO - Using env: {'DISPLAY': ':0', 02:54:40 INFO - 'HOME': '/home/cltbld', 02:54:40 INFO - 'LANG': 'en_US.UTF-8', 02:54:40 INFO - 'LANGUAGE': 'en_US:en', 02:54:40 INFO - 'LOGNAME': 'cltbld', 02:54:40 INFO - 'MAIL': '/var/mail/cltbld', 02:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:40 INFO - 'MOZ_NO_REMOTE': '1', 02:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:40 INFO - 'NO_EM_RESTART': '1', 02:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:40 INFO - 'PWD': '/builds/slave/test', 02:54:40 INFO - 'SHELL': '/bin/bash', 02:54:40 INFO - 'SHLVL': '1', 02:54:40 INFO - 'TERM': 'linux', 02:54:40 INFO - 'TMOUT': '86400', 02:54:40 INFO - 'USER': 'cltbld', 02:54:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:40 INFO - '_': '/tools/buildbot/bin/python'} 02:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:54: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 02:54: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 02:54: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 02:54: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 02:54:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:54:42 INFO - Installing collected packages: mozsystemmonitor 02:54:42 INFO - Running setup.py install for mozsystemmonitor 02:54:42 INFO - Successfully installed mozsystemmonitor 02:54:42 INFO - Cleaning up... 02:54:42 INFO - Return code: 0 02:54:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:54:42 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')]} 02:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:42 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')]} 02:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:42 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:42 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 02:54:42 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 02:54:42 INFO - Using env: {'DISPLAY': ':0', 02:54:42 INFO - 'HOME': '/home/cltbld', 02:54:42 INFO - 'LANG': 'en_US.UTF-8', 02:54:42 INFO - 'LANGUAGE': 'en_US:en', 02:54:42 INFO - 'LOGNAME': 'cltbld', 02:54:42 INFO - 'MAIL': '/var/mail/cltbld', 02:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:42 INFO - 'MOZ_NO_REMOTE': '1', 02:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:42 INFO - 'NO_EM_RESTART': '1', 02:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:42 INFO - 'PWD': '/builds/slave/test', 02:54:42 INFO - 'SHELL': '/bin/bash', 02:54:42 INFO - 'SHLVL': '1', 02:54:42 INFO - 'TERM': 'linux', 02:54:42 INFO - 'TMOUT': '86400', 02:54:42 INFO - 'USER': 'cltbld', 02:54:42 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:42 INFO - '_': '/tools/buildbot/bin/python'} 02:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:42 INFO - Downloading/unpacking jsonschema==2.5.1 02:54: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 02:54: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 02:54: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 02:54: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 02:54:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:54:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:54:43 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 02:54:43 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 02:54:43 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 02:54:43 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 02:54:43 INFO - Downloading functools32-3.2.3-2.tar.gz 02:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:54:43 INFO - warning: no files found matching '*.txt' 02:54:43 INFO - no previously-included directories found matching 'build' 02:54:43 INFO - no previously-included directories found matching 'dist' 02:54:43 INFO - no previously-included directories found matching '.git*' 02:54:43 INFO - Installing collected packages: jsonschema, functools32 02:54:43 INFO - Running setup.py install for functools32 02:54:43 INFO - warning: no files found matching '*.txt' 02:54:43 INFO - no previously-included directories found matching 'build' 02:54:43 INFO - no previously-included directories found matching 'dist' 02:54:43 INFO - no previously-included directories found matching '.git*' 02:54:43 INFO - Successfully installed jsonschema functools32 02:54:43 INFO - Cleaning up... 02:54:43 INFO - Return code: 0 02:54:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54: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')]} 02:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54: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', '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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:54: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 functools32==3.2.3-2 02:54:43 INFO - Using env: {'DISPLAY': ':0', 02:54:43 INFO - 'HOME': '/home/cltbld', 02:54:43 INFO - 'LANG': 'en_US.UTF-8', 02:54:43 INFO - 'LANGUAGE': 'en_US:en', 02:54:43 INFO - 'LOGNAME': 'cltbld', 02:54:43 INFO - 'MAIL': '/var/mail/cltbld', 02:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:43 INFO - 'MOZ_NO_REMOTE': '1', 02:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:43 INFO - 'NO_EM_RESTART': '1', 02:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:43 INFO - 'PWD': '/builds/slave/test', 02:54:43 INFO - 'SHELL': '/bin/bash', 02:54:43 INFO - 'SHLVL': '1', 02:54:43 INFO - 'TERM': 'linux', 02:54:43 INFO - 'TMOUT': '86400', 02:54:43 INFO - 'USER': 'cltbld', 02:54:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:43 INFO - '_': '/tools/buildbot/bin/python'} 02:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:54:44 INFO - Cleaning up... 02:54:44 INFO - Return code: 0 02:54:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:44 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:44 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 02:54:44 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 02:54:44 INFO - Using env: {'DISPLAY': ':0', 02:54:44 INFO - 'HOME': '/home/cltbld', 02:54:44 INFO - 'LANG': 'en_US.UTF-8', 02:54:44 INFO - 'LANGUAGE': 'en_US:en', 02:54:44 INFO - 'LOGNAME': 'cltbld', 02:54:44 INFO - 'MAIL': '/var/mail/cltbld', 02:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:44 INFO - 'MOZ_NO_REMOTE': '1', 02:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:44 INFO - 'NO_EM_RESTART': '1', 02:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:44 INFO - 'PWD': '/builds/slave/test', 02:54:44 INFO - 'SHELL': '/bin/bash', 02:54:44 INFO - 'SHLVL': '1', 02:54:44 INFO - 'TERM': 'linux', 02:54:44 INFO - 'TMOUT': '86400', 02:54:44 INFO - 'USER': 'cltbld', 02:54:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:44 INFO - '_': '/tools/buildbot/bin/python'} 02:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:44 INFO - Downloading/unpacking blobuploader==1.2.4 02:54:44 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 02:54:44 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 02:54:44 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 02:54:44 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 02:54:45 INFO - Downloading blobuploader-1.2.4.tar.gz 02:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:54:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:54:45 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 02:54:45 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 02:54:45 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 02:54:45 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 02:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:54:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:54:45 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 02:54:45 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 02:54:45 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 02:54:45 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 02:54:46 INFO - Downloading docopt-0.6.1.tar.gz 02:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:54:46 INFO - Installing collected packages: blobuploader, requests, docopt 02:54:46 INFO - Running setup.py install for blobuploader 02:54:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:54:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:54:46 INFO - Running setup.py install for requests 02:54:46 INFO - Running setup.py install for docopt 02:54:46 INFO - Successfully installed blobuploader requests docopt 02:54:46 INFO - Cleaning up... 02:54:46 INFO - Return code: 0 02:54:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:46 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')]} 02:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:46 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')]} 02:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:46 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:46 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 02:54:46 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 02:54:46 INFO - Using env: {'DISPLAY': ':0', 02:54:46 INFO - 'HOME': '/home/cltbld', 02:54:46 INFO - 'LANG': 'en_US.UTF-8', 02:54:46 INFO - 'LANGUAGE': 'en_US:en', 02:54:46 INFO - 'LOGNAME': 'cltbld', 02:54:46 INFO - 'MAIL': '/var/mail/cltbld', 02:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:46 INFO - 'MOZ_NO_REMOTE': '1', 02:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:46 INFO - 'NO_EM_RESTART': '1', 02:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:46 INFO - 'PWD': '/builds/slave/test', 02:54:46 INFO - 'SHELL': '/bin/bash', 02:54:46 INFO - 'SHLVL': '1', 02:54:46 INFO - 'TERM': 'linux', 02:54:46 INFO - 'TMOUT': '86400', 02:54:46 INFO - 'USER': 'cltbld', 02:54:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:46 INFO - '_': '/tools/buildbot/bin/python'} 02:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:46 INFO - Running setup.py (path:/tmp/pip-yoVReF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:47 INFO - Running setup.py (path:/tmp/pip-mPCkGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:47 INFO - Running setup.py (path:/tmp/pip-9ujqv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:47 INFO - Running setup.py (path:/tmp/pip-GJqhag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:47 INFO - Running setup.py (path:/tmp/pip-RsRSk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:47 INFO - Running setup.py (path:/tmp/pip-UWSrqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:47 INFO - Running setup.py (path:/tmp/pip-_UZBFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:47 INFO - Running setup.py (path:/tmp/pip-NtaSzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:47 INFO - Running setup.py (path:/tmp/pip-5LsiBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:47 INFO - Running setup.py (path:/tmp/pip-V1zQJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:47 INFO - Running setup.py (path:/tmp/pip-JuFTiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:47 INFO - Running setup.py (path:/tmp/pip-LXqN9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:47 INFO - Running setup.py (path:/tmp/pip-6PVn9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:47 INFO - Running setup.py (path:/tmp/pip-M0k2e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:47 INFO - Running setup.py (path:/tmp/pip-W2vWNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:48 INFO - Running setup.py (path:/tmp/pip-MfcUj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:48 INFO - Running setup.py (path:/tmp/pip-KpsqWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:54:48 INFO - Running setup.py install for manifestparser 02:54:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Running setup.py install for mozcrash 02:54:48 INFO - Running setup.py install for mozdebug 02:54:48 INFO - Running setup.py install for mozdevice 02:54:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Running setup.py install for mozfile 02:54:48 INFO - Running setup.py install for mozhttpd 02:54:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Running setup.py install for mozinfo 02:54:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Running setup.py install for mozInstall 02:54:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:54:48 INFO - Running setup.py install for mozleak 02:54:49 INFO - Running setup.py install for mozlog 02:54:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Running setup.py install for moznetwork 02:54:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Running setup.py install for mozprocess 02:54:49 INFO - Running setup.py install for mozprofile 02:54:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Running setup.py install for mozrunner 02:54:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Running setup.py install for mozscreenshot 02:54:49 INFO - Running setup.py install for moztest 02:54:49 INFO - Running setup.py install for mozversion 02:54:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:54:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:54:49 INFO - Cleaning up... 02:54:49 INFO - Return code: 0 02:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:49 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')]} 02:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:49 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')]} 02:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:49 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:49 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 02:54:49 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 02:54:49 INFO - Using env: {'DISPLAY': ':0', 02:54:49 INFO - 'HOME': '/home/cltbld', 02:54:49 INFO - 'LANG': 'en_US.UTF-8', 02:54:49 INFO - 'LANGUAGE': 'en_US:en', 02:54:49 INFO - 'LOGNAME': 'cltbld', 02:54:49 INFO - 'MAIL': '/var/mail/cltbld', 02:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:49 INFO - 'MOZ_NO_REMOTE': '1', 02:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:49 INFO - 'NO_EM_RESTART': '1', 02:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:49 INFO - 'PWD': '/builds/slave/test', 02:54:49 INFO - 'SHELL': '/bin/bash', 02:54:49 INFO - 'SHLVL': '1', 02:54:49 INFO - 'TERM': 'linux', 02:54:49 INFO - 'TMOUT': '86400', 02:54:49 INFO - 'USER': 'cltbld', 02:54:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:49 INFO - '_': '/tools/buildbot/bin/python'} 02:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:54:50 INFO - Running setup.py (path:/tmp/pip-kFRF6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:54:50 INFO - Running setup.py (path:/tmp/pip-V9EO_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:54:50 INFO - Running setup.py (path:/tmp/pip-a7H1MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:54:50 INFO - Running setup.py (path:/tmp/pip-QTUA4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:54:50 INFO - Running setup.py (path:/tmp/pip-v3usX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:54:50 INFO - Running setup.py (path:/tmp/pip-f15fWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:54:50 INFO - Running setup.py (path:/tmp/pip-JhgPdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:54:50 INFO - Running setup.py (path:/tmp/pip-eX1kAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:54:50 INFO - Running setup.py (path:/tmp/pip-8LaQG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:54:50 INFO - Running setup.py (path:/tmp/pip-zDIyXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:54:50 INFO - Running setup.py (path:/tmp/pip-x_pmCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:54:50 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)) 02:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:54:50 INFO - Running setup.py (path:/tmp/pip-81ch35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:54:51 INFO - Running setup.py (path:/tmp/pip-NjiNfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:54:51 INFO - Running setup.py (path:/tmp/pip-70dt5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:51 INFO - Running setup.py (path:/tmp/pip-RrRHr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:54:51 INFO - Running setup.py (path:/tmp/pip-bVPmgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:54:51 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)) 02:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:54:51 INFO - Running setup.py (path:/tmp/pip-HRi9a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:54:51 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)) 02:54:51 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)) 02:54:51 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)) 02:54:51 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)) 02:54:51 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)) 02:54:51 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)) 02:54:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:54:51 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 02:54:51 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 02:54:51 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 02:54:51 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 02:54:52 INFO - Downloading blessings-1.6.tar.gz 02:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:54:52 INFO - Installing collected packages: blessings 02:54:52 INFO - Running setup.py install for blessings 02:54:52 INFO - Successfully installed blessings 02:54:52 INFO - Cleaning up... 02:54:52 INFO - Return code: 0 02:54:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:52 INFO - Reading from file tmpfile_stdout 02:54:52 INFO - Current package versions: 02:54:52 INFO - argparse == 1.2.1 02:54:52 INFO - blessings == 1.6 02:54:52 INFO - blobuploader == 1.2.4 02:54:52 INFO - docopt == 0.6.1 02:54:52 INFO - functools32 == 3.2.3-2 02:54:52 INFO - jsonschema == 2.5.1 02:54:52 INFO - manifestparser == 1.1 02:54:52 INFO - mozInstall == 1.12 02:54:52 INFO - mozcrash == 1.0 02:54:52 INFO - mozdebug == 0.1 02:54:52 INFO - mozdevice == 0.51 02:54:52 INFO - mozfile == 1.2 02:54:52 INFO - mozhttpd == 0.7 02:54:52 INFO - mozinfo == 0.9 02:54:52 INFO - mozleak == 0.1 02:54:52 INFO - mozlog == 3.4 02:54:52 INFO - moznetwork == 0.27 02:54:52 INFO - mozprocess == 0.25 02:54:52 INFO - mozprofile == 0.28 02:54:52 INFO - mozrunner == 6.13 02:54:52 INFO - mozscreenshot == 0.1 02:54:52 INFO - mozsystemmonitor == 0.3 02:54:52 INFO - moztest == 0.8 02:54:52 INFO - mozversion == 1.4 02:54:52 INFO - psutil == 3.1.1 02:54:52 INFO - requests == 1.2.3 02:54:52 INFO - wsgiref == 0.1.2 02:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:54:52 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')]} 02:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54:52 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')]} 02:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:52 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:52 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 02:54:52 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 02:54:52 INFO - Using env: {'DISPLAY': ':0', 02:54:52 INFO - 'HOME': '/home/cltbld', 02:54:52 INFO - 'LANG': 'en_US.UTF-8', 02:54:52 INFO - 'LANGUAGE': 'en_US:en', 02:54:52 INFO - 'LOGNAME': 'cltbld', 02:54:52 INFO - 'MAIL': '/var/mail/cltbld', 02:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:52 INFO - 'MOZ_NO_REMOTE': '1', 02:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:52 INFO - 'NO_EM_RESTART': '1', 02:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:52 INFO - 'PWD': '/builds/slave/test', 02:54:52 INFO - 'SHELL': '/bin/bash', 02:54:52 INFO - 'SHLVL': '1', 02:54:52 INFO - 'TERM': 'linux', 02:54:52 INFO - 'TMOUT': '86400', 02:54:52 INFO - 'USER': 'cltbld', 02:54:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:52 INFO - '_': '/tools/buildbot/bin/python'} 02:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 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)) 02:54:53 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:54:53 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 02:54:53 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 02:54:53 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 02:54:53 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 02:54:54 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:54:54 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)) 02:54:54 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)) 02:54:54 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)) 02:54:54 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)) 02:54:54 INFO - Installing collected packages: marionette-driver 02:54:54 INFO - Running setup.py install for marionette-driver 02:54:54 INFO - Successfully installed marionette-driver 02:54:54 INFO - Cleaning up... 02:54:54 INFO - Return code: 0 02:54:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:54: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')]} 02:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:54: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')]} 02:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:54:54 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 0x1f213b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, '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': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', '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 02:54:54 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 02:54:54 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 02:54:54 INFO - Using env: {'DISPLAY': ':0', 02:54:54 INFO - 'HOME': '/home/cltbld', 02:54:54 INFO - 'LANG': 'en_US.UTF-8', 02:54:54 INFO - 'LANGUAGE': 'en_US:en', 02:54:54 INFO - 'LOGNAME': 'cltbld', 02:54:54 INFO - 'MAIL': '/var/mail/cltbld', 02:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:54 INFO - 'MOZ_NO_REMOTE': '1', 02:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:54 INFO - 'NO_EM_RESTART': '1', 02:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:54 INFO - 'PWD': '/builds/slave/test', 02:54:54 INFO - 'SHELL': '/bin/bash', 02:54:54 INFO - 'SHLVL': '1', 02:54:54 INFO - 'TERM': 'linux', 02:54:54 INFO - 'TMOUT': '86400', 02:54:54 INFO - 'USER': 'cltbld', 02:54:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:54 INFO - '_': '/tools/buildbot/bin/python'} 02:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:54:54 INFO - Cleaning up... 02:54:54 INFO - Return code: 0 02:54:54 INFO - Running post-action listener: _resource_record_post_action 02:54:54 INFO - Running post-action listener: _start_resource_monitoring 02:54:54 INFO - Starting resource monitoring. 02:54:54 INFO - [mozharness: 2017-05-30 09:54:54.792309Z] Finished create-virtualenv step (success) 02:54:54 INFO - [mozharness: 2017-05-30 09:54:54.792890Z] Running install step. 02:54:54 INFO - Running pre-action listener: _resource_record_pre_action 02:54:54 INFO - Running main action method: install 02:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:54:54 INFO - Reading from file tmpfile_stdout 02:54:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:54:55 INFO - Reading from file tmpfile_stdout 02:54:55 INFO - Output received: 02:54:55 INFO - Usage: mozinstall [options] installer 02:54:55 INFO - Options: 02:54:55 INFO - -h, --help show this help message and exit 02:54:55 INFO - -d DEST, --destination=DEST 02:54:55 INFO - Directory to install application into. [default: 02:54:55 INFO - "/builds/slave/test"] 02:54:55 INFO - --app=APP Application being installed. [default: firefox] 02:54:55 INFO - mkdir: /builds/slave/test/build/application 02:54:55 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'] 02:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:55:11 INFO - Reading from file tmpfile_stdout 02:55:11 INFO - Output received: 02:55:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:55:11 INFO - Running post-action listener: _resource_record_post_action 02:55:11 INFO - [mozharness: 2017-05-30 09:55:11.947326Z] Finished install step (success) 02:55:11 INFO - [mozharness: 2017-05-30 09:55:11.947608Z] Running setup-mitmproxy step. 02:55:11 INFO - Running pre-action listener: _resource_record_pre_action 02:55:11 INFO - Running main action method: setup_mitmproxy 02:55:11 INFO - Skipping: mitmproxy is not required 02:55:11 INFO - Running post-action listener: _resource_record_post_action 02:55:11 INFO - [mozharness: 2017-05-30 09:55:11.948742Z] Finished setup-mitmproxy step (success) 02:55:11 INFO - [mozharness: 2017-05-30 09:55:11.949034Z] Running run-tests step. 02:55:11 INFO - Running pre-action listener: _resource_record_pre_action 02:55:11 INFO - Running main action method: run_tests 02:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:55:11 INFO - Python 2.7.3 02:55:11 INFO - Return code: 0 02:55:11 INFO - grabbing minidump binary from tooltool 02:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:11 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 0x229be40>, '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 0x229cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:55:11 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 02:55:11 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 02:55:11 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 02:55:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:55:12 INFO - Return code: 0 02:55:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:55:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:55:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:55:12 INFO - ENV: RUST_BACKTRACE is now 1 02:55:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:55:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:55:12 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/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:55:12 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/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 02:55:12 INFO - Using env: {'DISPLAY': ':0', 02:55:12 INFO - 'HOME': '/home/cltbld', 02:55:12 INFO - 'LANG': 'en_US.UTF-8', 02:55:12 INFO - 'LANGUAGE': 'en_US:en', 02:55:12 INFO - 'LOGNAME': 'cltbld', 02:55:12 INFO - 'MAIL': '/var/mail/cltbld', 02:55:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:55:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:12 INFO - 'MOZ_NO_REMOTE': '1', 02:55:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:55:12 INFO - 'NO_EM_RESTART': '1', 02:55:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:12 INFO - 'PWD': '/builds/slave/test', 02:55:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:55:12 INFO - 'RUST_BACKTRACE': '1', 02:55:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:55:12 INFO - 'SHELL': '/bin/bash', 02:55:12 INFO - 'SHLVL': '1', 02:55:12 INFO - 'TERM': 'linux', 02:55:12 INFO - 'TMOUT': '86400', 02:55:12 INFO - 'USER': 'cltbld', 02:55:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934', 02:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:12 INFO - '_': '/tools/buildbot/bin/python'} 02:55:12 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/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:55:12 INFO - mozversion application_buildid: 20170530091452 02:55:12 INFO - mozversion application_changeset: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 02:55:12 INFO - mozversion application_display_name: Nightly 02:55:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:55:12 INFO - mozversion application_name: Firefox 02:55:12 INFO - mozversion application_remotingname: firefox 02:55:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:55:12 INFO - mozversion application_vendor: Mozilla 02:55:12 INFO - mozversion application_version: 55.0a1 02:55:12 INFO - mozversion platform_buildid: 20170530091452 02:55:12 INFO - mozversion platform_changeset: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 02:55:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:55:12 INFO - mozversion platform_version: 55.0a1 02:55:12 INFO - using testdate: 1496138112 02:55:12 INFO - actual date: 1496138112 02:55:12 INFO - starting webserver on 'localhost:46469' 02:55:12 INFO - SUITE-START | Running 2 tests 02:55:12 INFO - TEST-START | dromaeo_css 02:55:12 INFO - operating with platform_type : linux_ 02:55:12 INFO - Initialising browser for dromaeo_css test... 02:55:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46469/getInfo.html -profile /tmp/tmpD5yHxR/profile 02:55:12 INFO - TEST-INFO | started process 32030 (/builds/slave/test/build/application/firefox/firefox http://localhost:46469/getInfo.html) 02:55:47 INFO - TEST-INFO | 32030: killed by SIGTERM 02:55:48 INFO - Browser initialized. 02:55:48 INFO - Running cycle 1/1 for dromaeo_css test... 02:55:48 INFO - TEST-INFO | started process 32252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD5yHxR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:00 INFO - PID 32252 | RSS: Main: 186372096 02:56:00 INFO - PID 32252 | 02:59:05 INFO - PID 32252 | Cycle 1(1): loaded http://localhost:46469/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46469/tests/dromaeo/cssquery-ext.html) 02:59:06 INFO - PID 32252 | RSS: Main: 183873536 02:59:06 INFO - PID 32252 | 03:02:08 INFO - PID 32252 | Cycle 1(1): loaded http://localhost:46469/tests/dromaeo/cssquery-ext.html (next: http://localhost:46469/tests/dromaeo/cssquery-jquery.html) 03:02:09 INFO - PID 32252 | RSS: Main: 186966016 03:02:09 INFO - PID 32252 | 03:05:11 INFO - PID 32252 | Cycle 1(1): loaded http://localhost:46469/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46469/tests/dromaeo/cssquery-mootools.html) 03:05:11 INFO - PID 32252 | RSS: Main: 184201216 03:05:11 INFO - PID 32252 | 03:08:13 INFO - PID 32252 | Cycle 1(1): loaded http://localhost:46469/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46469/tests/dromaeo/cssquery-prototype.html) 03:08:14 INFO - PID 32252 | RSS: Main: 188358656 03:08:14 INFO - PID 32252 | 03:11:17 INFO - PID 32252 | Cycle 1(1): loaded http://localhost:46469/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46469/tests/dromaeo/cssquery-yui.html) 03:11:17 INFO - PID 32252 | RSS: Main: 186753024 03:11:17 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | Cycle 1(1): loaded http://localhost:46469/tests/dromaeo/cssquery-yui.html (next: http://localhost:46469/tests/dromaeo/cssquery-dojo.html) 03:14:19 INFO - PID 32252 | RSS: Main: 186769408 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | __start_tp_report 03:14:19 INFO - PID 32252 | _x_x_mozilla_page_load 03:14:19 INFO - PID 32252 | _x_x_mozilla_page_load_details 03:14:19 INFO - PID 32252 | |i|pagename|runs| 03:14:19 INFO - PID 32252 | |0;dojo.html;2688.193541937419;2704.7295270472955;2716.076533978447;2733.835969841809;2760.4341110072437;5258.553022993041;5338.5996050296235;5342.118550439178;5345.438728933459;5371.57027437805;5280.498352656501;5320.095583750762;5326.786928522854;5332.706701131437;5339.5728341732665;4478.932816007747;4694.577762684105;4740.881477963053;4750.857474275777;4773.212419950704;4794.184988551937;4832.3717916670785;4859.684120532172;4864.878378040559;4896.608271338285;4655.953440465586;4693.436787585478;4720.905581888377;4769.99830035693;4781.402324709411;4761.166795810719;4787.904241915177;4801.687890287155;4821.300911367832;4839.685420447659;4691.7888695008805;4717.599004084657;4728.361671174416;4757.643176761757;4761.2382018876815;5148.819791307286;5227.47725227478;5382.569394448435;5383.67697938125;5403.243545903577;5666.631668941547;5745.88508229833;5755.021646320094;5756.5682573807135;5761.971190144022;5860.7948721794955;5872.618279811799;5888.411158884121;5892.852678683024;5899;5420.105682562333;5424.83725488236;5433.049216387117;5450.482204190595;5452.018636645442;5792.478676919013;5812.709364531756;5859.765609375577;5876.970615146983;5988.251468566429;5724.141378793214;5745.942540574624;5760.36635970043;5782.161586569924;5790.015697331463;5716.228309178207;5840.912386314209;5841.153032810219;5846.678432686158;5861.120831875252;5634.211210430543;5646.689432081275;5760.567957403127;5775.711214439261;5790.36306006339;5663.122216056436;5714.457126572969;5736.512396446349;5749.9937510935415;5760.251167348301;4888.437829649564;4888.608911287089;4897.4857639948;4918.778654960535;4931.112399768004;4150.605692459211;4165.500139983161;4176.728512646669;4214.683898707609;4242.893927651833;4726.314684370747;4811.518848115161;4834.347363106006;4869.488703686062;4874.317595536628;5777.942220577825;5798.130280457881;5803.361630220672;5820.970895145497;5844.15259787337;4806.44725856524;4809.110314591811;4834.661573689808;4845.733484658307;4870.756462176948;5031.52200540948;5101.387833459934;5121.820736274212;5133.666311689803;5136.049830781318;5295.099833028471;5310.8937821244135;5375.516203541543;5394.541463975449;5407.405185429679;5609.24275222856;5671.291088613923;5738.713064346849;5770.422957704196;5826.912596311144;5282.154855223146;5393.784248630011;5402.51377376038;5420.566354691694;5460.262864513399;5586.581006424616;5653.632513886584;5710.743016564347;5744.454276843693;5745.827625171251;5719.084946408555;5741.942580574141;5771.769129234952;5798.797042103506;5807.767689292381;5646.435356464321;5650.011248031496;5652.4064973178865;5657.349404818334;5676.489115979582;5426.810061647823;5617.241672374341;5624.550035997192;5645.971770141123;5651.124075768263;5453.536449401845;5495.697736624524;5569.303837020372;5572.4706152915405;5578.219049333015;5732.398098199629;5736.053551164011;5743.6840973745175;5748.080307150836;5778.913316300175;5571.637843540157;5574.9721251393485;5575.526080283222;5587.245721827501;5595.496405323541 03:14:19 INFO - PID 32252 | |1;ext.html;650.8372906773307;689.7447944260623;708.9999999999999;1210.6731182580704;1226.350034481724;33655.15862103448;34443.65556344436;34463.48304775427;34478.82760586194;34522.65477345226;33061.504077438854;33274;33304;33342.16644583887;33357;6343.555951083426;6590.670466476681;6760.864782704368;6761.797146085625;6766.15423072116;6694.83262918426;6814.727410903558;6827.692753826065;6828.044073829643;6837.48718846086;6758.918573028316;6781.830454238659;6843.794686159398;6846.828829279283;6850.040994260783;6803.455723542104;6815.454763618898;6824.829379265509;6831.69257383419;6836.418904393133;6676.365745254193;6736.427403670694;6742.662866856637;6744.7976560703255;6749.460043196533;31735.682643173503;31957.52063719046;32033.359332813445;32052.358952820814;32058.358832823214;3043.8782448702027;3046.8019578727312;3052.542118682193;3056.541518772202;3081.5223640335785;24507.877460612763;24819.62770558443;24853.130140445;24865.254042378758;24868.3782905427;2822.760065394444;2844.843533605651;2858.9285267868263;2864.269611249139;2877.323828900228;142178;142467;142745;154087;156703.99999999886;38490;38778;38978.41532377017;39371.40942885859;39390.60609393927;41251.793741031106;41305.173896521905;41329.38005929913;41498.585014149474;43957;12238.571649992207;12340.321282329378;12352.938235308766;12362.258264504158;12397.93801031007;9764.316497845224;9776.266779991529;9797.608095676236;9817.410955342702;9824.459654718916;12654.936725316315;12796.424160912595;12879.746044442372;12919.741605167845;13038.869611303955;5152.355955505562;5194.97402512985;5345.251664766935;5354.277172581729;5379.408265090837;856.9400141990126;899.2221728205055;899.2715900120922;903.3134817538718;922.3681777982104;20644.593642049193;21165;21522.677159842617;21615.67576486354;21845.890770546044;967.5259123029806;979.4955597867104;998.2164001258977;1003.4531180506641;1003.6988903328972;11040.503177357039;11360.772784544428;11415.543378264943;11440.313581185155;11556.768864622829;176649;177251;178685;179175;180103;41141.79429102835;41198.79400603038;41272.174556508704;41326.380104298456;41346;1181.3274670749795;1223.082687984012;1224.7611715715527;1230.969225769363;1236.8948639365574;19535.76796360969;19608.607827843647;20235.291764788162;21173.894130529865;21194.258200963508;29794.404111917207;38263.234735304584;38602.6139738599;38768;39068.413973789844;165662.17168914562;166364.16817915833;167179;167317;167714;29742.55386169166;30446.564274857516;30696;30905.227369315948;31031.84484077565;34976.475352869216;35737;35867.10332241715;36099.458508121876;36722.7147049852;27145.59281610738;27299.72700272972;27503.44993100167;28045.158645240674;28266.717332826407;27430.862845685642;27433.58849617297;27960.30099247535;28054;28778.28054298659;30724.692753072184;31005.379892401575;31099.222519437197;31117.688823112385;31256.37487250197;26171.869140654177;26670.466590668468;26864.194074177805;27607.03375381852;27626.171214863585;20138.89930550338;22621.43446413853;22629.660555092018;22664.773352266267;22675.782125269532 03:14:19 INFO - PID 32252 | |2;jquery.html;405.87620775663413;418.5736079328758;426.49247395599224;434.51768536924027;443.7892001299383;16802.243899024543;17737.113144342795;17808.109594520272;18791.436256912315;19317.323893663724;18152.36466723665;18415.72376414355;18455.446336609923;19113.52216194596;19512.609747805036;5510.476504732044;5533.557315414777;5585.385607583163;5586.832395028136;5710.200571919934;5518.6688798672;5561.082421400464;5579.414161513044;5602.579806514507;5610.074337734269;5324.467553244664;5462.754176062067;5500.22996780451;5501.779928802843;5547.417521160281;5405.270288511079;5411.891762164754;5419.566434685215;5446.537044351215;5449.237106805051;4924;4935.2350385689915;4962.801487940478;4968.080905032544;4975.577075948549;21991.230306939182;22488.775112248833;22679.77320226793;22708.77291227083;22947.541049178923;1637.7379619260862;1658.7263101588223;1671.0391524873125;1673.1299724143498;1675.6481138960833;14198.219097949608;14807.925960370238;15020.699586008328;15132.243387830564;15271.160086195256;2089.174775963501;2098.4858709616087;2110.5778844231213;2164.415607785889;2174.7390313162523;86354.56822715909;86451;91376;99376;100894.99105008929;18025.549361266072;18379.172937217856;18476.722849157275;18530;18617.81382186188;34104.54327307619;34233.144171395914;34235.97292081242;34275;34402.48396274058;9162.358634895494;9180.816383672289;9252.814943701089;9288.953555232316;9400;7346.889796653055;7392.889106663404;7528.021357223526;7554.43341749371;7592.772216833504;9567;9707;9732.270079743907;9760;10037.698869033795;3810.3141434541494;3833.21419109082;3861.435559548778;3895.6883449324555;3915.7650540967634;816.4366587055032;854.8632218844955;872.2536704852673;882.8101958078915;892.5983307511646;17250.309987600354;17297.91351043237;17298;17579.296828126986;18005.639887202182;848.5714714069479;855.9015713192938;860.7848037990502;867.7960679240374;886.3485338276362;9315.534223288809;9557.330986830993;9742.659006934724;9797.80404391908;9919.15687166599;339162;339605;345194.2065503773;345417;345702;68727;74398.62800685962;75145;77739.61130194426;78986.6050669743;1024.5645600619707;1039.4750650921085;1054.260470224121;1054.3989925742253;1066.109798318413;17221.483355499357;17614.559636009202;18098.54753631117;18159;18263.269469221083;37881.62118378781;38584.6141538581;39323;39333.80333098316;40043;47368.289475657206;47756.04487910292;48858.75570622124;48953;49581;11204.159688023594;11658.475368608602;11737.706557335794;11920.165588408729;12061.939690301493;12373.381330933596;12589.24464532131;12630.810537842124;12790.936045319713;13083.542076027674;10605.098566621924;10900.618478353219;10906.72733181645;11000.394978275952;11340.489677964346;9551.904480955101;9771.706848794547;9882.50587470638;9915.702528924145;9946.303758736818;10396.74008149772;10408.583656653649;10721.195910306602;11091.389973551532;11141.665750027512;10845.511951962339;10926;11184.72038199019;11194.272372295774;11261.66215013551;10236.590536378462;10250.487475626338;10286.845697314697;10421.895781042092;10555.894441055798 03:14:19 INFO - PID 32252 | |3;mootools.html;1277.8083287506877;1313.4746101559374;1315.9342032898353;1327.084311824841;1331.447449308537;10292.485375731212;10805.56777728892;10866.130709543228;10947.5620975161;11174.720631984184;10891.346519208853;11032.779344413128;11103.44482775862;11108.16688748343;11118.777624447506;2203.3389983005072;2226.2875879718495;2231.1967691631;2243.7868402501736;2259.7401298850596;2184.8252139828774;2194.7585765565773;2232.520008198237;2235.1282999630075;2237.6643503474447;2167.8482506224573;2212.9225477108303;2214.5792299463133;2224.077008041661;2237.641977283635;2078.3972647932083;2086.54096098858;2091.874487530753;2092.1213090502024;2096.3501314592527;1834.394649765574;1899.135893168605;2081.063521415354;2123.182574708733;2140.3044010696585;10707.732306692316;10743.462826858704;10755.247132700635;10762.300450470773;10776.245662803607;5530.889382212334;5709.8287051388525;5751.166080918285;5760.8271751847515;5772.769089236425;3278.8169237471952;3367.848446819899;3428.6914177723875;3429.3141371725505;3441.984614538717;1129.6836885672026;1130.3895896216034;1141.783061218374;1144.673767976131;1164.8078067118915;15359.078455292718;15438.150901700403;15483.303251353716;15564.299606517734;15603.843961560466;4517.6837621366185;4753.691010084333;4825.927611085836;4832.081904438216;4958.553730164303;11332.376719280519;11438.771224575628;11449.942750286194;11451.370174640308;11458.828117578243;5448.019356515865;5575.470330318613;5580.414056524088;5607.467290607386;5630.831075067755;5093.796248150033;5109.335786347751;5127.083032885975;5181.689098654093;5195.532402083831;3829.5596006459054;3852.8073596320073;3890.2997460456822;3946.072672921861;3975.1254723960683;1052.9894701053045;1058.8147074261974;1069.561479793281;1072.2762135558623;1073.350622873166;679.100192245277;712.2236761929419;714.9392301654418;730.0399974034234;730.466759265739;5506.944930550723;5559.8888022239325;5567.526760225345;5679.091345384719;5744.023516002289;515.4381723920944;546.8222827580972;546.8605505596048;848.240824462103;866.6056944090424;3789.5831458539537;3838.5393752749846;3882.301185786529;3931.4495970564144;4036.798160091984;13858.514951976633;14621.561353159423;14691.926540367444;14706.191159486118;14713.92643036778;13780.9999999998;14587.197704126163;14593;14600.269986500633;14604.707905842037;7610.353119984863;7782.105057918412;7845.764627061198;7870.094939081964;7881.763547093597;5674.74463649145;5685.180742162634;5744.253247077853;5905.5570832186895;6218.22272215973;12364.319962402154;12648.936755316532;12786.61640150797;12833.807492887427;12887.93556032214;12919.160254583421;13012.739745205232;13069.869301306866;13073;13292.468301267842;7964.522128672298;8114.797130071795;8147.75556733299;8294.958525207336;8673.34949878749;10142.695719128438;10190.286679932333;10310.175185984954;10314.845277320695;10314.845277320996;8522.48865068098;8786.25316848075;8850.64597416122;8929.419587726778;9008.819823603622;8232.588370581327;8300.70947516834;8317.875231871647;8393.370497212856;8404.369672274726;7349.522281051714;7428.814279643052;7488.775336739906;7507.249275072449;7541.095068591804;4738.147133516;5160.819371321985;5218.373795144607;5413.079776438094;5475.178723191394;5293.417724050274;5346.304980352529;5363.329583802025;5398.62209645321;5443.618946673695 03:14:19 INFO - PID 32252 | |4;prototype.html;373.87662071516405;376.55002272284634;381.20899134296343;386.5573917864046;386.75247841381537;5539.972300138499;5544.6118771686;5559.19391688205;5564.527015203707;5597.384287728347;5299.311089558352;5389.380221274555;5397.568194544437;5398.8920221595545;5418.756155972981;4221.430106935555;4225.154969006211;4240.194363071015;4252.744835309892;4271.273883439807;4240.681948853849;4242.83028678854;4246.490421149451;4250.638695710868;4259.297215959363;4136.172765446908;4213.47331583552;4216.789160541976;4217.15656868626;4240.872773816775;4202;4219.78901054946;4226.577342265779;4230.323148296273;4230.9537133264;3775.9993601695573;3784.8864534063746;3794.0894185395305;3803.448499967517;3811.904702382435;5220.634555581073;5331.706756128411;5364.892702145974;5368.141097424394;5369.731513424314;4961.255811628284;4982;4990.426100998396;4992.90156165643;4996.25056241563;5721.7711291548285;5742.827715168552;5755.568332375088;5765.549641402387;5776.826695199151;4136.710430269883;4236.385724070024;4237.851675191384;4254.212970600449;4262.552431994627;5991.850203744898;6012.729427175787;6019.765947980697;6038.456538911519;6211.484348838772;4101.974506373406;4109.301418758759;4114.588541145861;4124.443200167939;4128.91742165155;4184.832606695759;4192.853250136231;4194.622483976395;4204.180184863983;4205.516365617932;4964.702117872867;5094.337736094358;5103.362079740033;5161.66449180802;5168;5926.318473375531;5927.792527261525;5932.673702946293;5952.791652292149;5954.166416701665;1575.8896877218715;1594.4817934171208;1604.4143887480986;1612.3469994652185;1619.0852168524746;1137.3062431916524;1157.3923690062616;1171.3850228629867;1175.7001964498997;1177.181858608259;4994.278118425467;5001.324821149098;5024.748762561857;5048.67760830015;5057.443681195065;6009;6018.428249316308;6033.637981721111;6047.939520604826;6060.454559089703;4842.5157484251295;4976.800927962841;4983.9252411213865;4993.875153121128;5058.317127187856;3186.235303527183;3200.135963289899;3218.6620404857154;3227.2577307219003;3235.223546348859;5478.890422191534;5636.1827535008015;5651.124075768263;5651.9152212716845;5656.935218645165;6178.4439400453275;6201.720922558496;6202.813915582449;6230.408111229426;6239.844003899848;5635.605507614428;5646.407127251579;5653.858653533694;5654.773809047592;5667.971660141756;5957.4042595740075;6016.345504985989;6029.246344206974;6062.7271772769445;6070.544709146743;5759.481646651821;5979.402059793986;5980.521558275241;5989.251343582052;6009.158717779602;5618.073017951992;5620.213170156263;5624.29696287964;5648;5654.830355089354;4107.424960505472;4122.505299364096;4125.154343359664;4129.339305711072;4130.029443080934;5921.407859214217;6056.636601803906;6069.757209711739;6088.269407671108;6160.845978850564;5879.588428810113;5903.26209223847;5912.940870591411;5923.170756094064;5925.4370834770625;5724.041471924801;5870.647761134345;5871.6770577616935;5887.646741195542;5909.793157239648;5739.454751798572;5793.507551858139;5803.158542011301;5819;5840.094785308284;5920.467157955804;5931.822045338647;5946.286445626552;5948.702564871653;5957.3744756799915;5627.5497960162265;5726.854629074285;5728.198052272602;5745.396733342939;5777.7977770777825 03:14:19 INFO - PID 32252 | |5;yui.html;708.7165133946424;733.5928559649392;750.2909750285979;752.6537792615396;767.9040119985;11641.30152190867;12125.393730313494;13482.662933426669;14210.289485525722;14240.572782816505;14829.703405931901;15236.466723664675;15252.237388130605;15325.540233793005;15391;887.800244944887;909.440693973205;911.3984770051767;911.803962148138;915.5422288855572;904.606496174163;911.1435250864199;911.3711539038076;911.9042500537447;914.1863741270241;939.8872135343769;944.914957653811;945.8013817098383;948.6869333120088;949.7008442340675;930.2279108340095;935.672514619881;940.6613619097119;943.2454036770624;946.1484663802564;664.4916638771343;676.6582875647815;693.0955103589813;693.2893783871572;695.2977492732326;14356.425742970268;14470.565883023526;14597.562073137822;14601.561953141423;14637.780433293508;14760.335784889705;15650.608734781721;15711.685766284725;15731.764023539656;15735.606609834731;11998.940005300004;12793.232406055666;12868.09923305369;12917.935410322889;13022.739545209042;3099.5350697395347;3103.6275646922513;3108.4560201964564;3120.5163199704084;3121.3133110715607;74925;76445;77187.61406192933;78911;80101.59949200274;12927.15973461722;13374.33128343579;13443.193408395528;13464.259465729283;13493.122947008413;20075.196992120444;20463.28378506745;20539.075741591663;21748.89125554362;22035.66946495804;6333.746650134035;6409.423151916257;6472.579282346633;6488.67556622167;6512.153420055362;3038.483457812177;3105.534169874537;3109.300407408315;3111.23774675206;3114.5016797312323;3719.367707489733;3913.0608653922855;4017.9196416071513;4029.0531725044593;4034.415009823559;764.7055883484787;766.3562607409802;776.5573623034929;819.8647223208104;822.3092602214169;615.3538784276582;622.8411755002445;626.5739297277804;630.4294613374904;647.896336586144;9604.423734575948;9653.90346096544;10000.649977250761;10142;10305.969403059635;594.5719082260765;606.6360183889631;606.9302030266488;609.2567068176817;615.4061330815784;4463.2635615123145;4497.235469970047;4558.384618076583;4631.467381251132;4642.930356044662;74260;75483.62258188784;75951;82642.58678706568;83357.16642833494;63389.68305158537;63575.682121589096;63612.36387636157;67898.3210167892;68762.3123768766;57988.71005644945;58018;58443;58532;61393.38606613966;9774.266929980138;10342.948285258526;10450.68647940563;10680.359178449318;10725.41010244444;27985.160445186677;28607.570886437137;28618.57072143878;29237.7076229235;29281.707182927898;50285;52219.73890130525;53006;53767.73116134551;53859;13825.792613111013;13953.651158720708;14312.284385780462;14333.64165895861;14416.13503189812;16225.51323460298;16692.749608755636;17040.147992600072;17101.401450949157;17286.394976175772;14135.64660883486;14379.352929118006;14404.351804168627;14484.203368814395;14549;14120.50578229757;14573.489927852474;14625.414983400971;14634.707305854035;15154.621134471727;13532.729345413234;13697.383617737425;14214.715705686036;14971.101733896001;15239.466618668293;10865.728356790827;11244.26912250701;11519.136064795006;11610.245334053598;12205;11428;12020.879791201976;12035.819462707892;12172.817407738714;12366.443510042249 03:14:19 INFO - PID 32252 | __end_tp_report 03:14:19 INFO - PID 32252 | __start_cc_report 03:14:19 INFO - PID 32252 | _x_x_mozilla_cycle_collect,370 03:14:19 INFO - PID 32252 | __end_cc_report 03:14:19 INFO - PID 32252 | __startTimestamp1496139259825__endTimestamp 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | ------- Summary: start ------- 03:14:19 INFO - PID 32252 | Number of tests: 6 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | [#0] dojo.html Cycles:165 Average:5276.73 Median:5433.05 stddev:633.04 (11.7%) stddev-sans-first:601.53 03:14:19 INFO - PID 32252 | Values: 2688.2 2704.7 2716.1 2733.8 2760.4 5258.6 5338.6 5342.1 5345.4 5371.6 5280.5 5320.1 5326.8 5332.7 5339.6 4478.9 4694.6 4740.9 4750.9 4773.2 4794.2 4832.4 4859.7 4864.9 4896.6 4656.0 4693.4 4720.9 4770.0 4781.4 4761.2 4787.9 4801.7 4821.3 4839.7 4691.8 4717.6 4728.4 4757.6 4761.2 5148.8 5227.5 5382.6 5383.7 5403.2 5666.6 5745.9 5755.0 5756.6 5762.0 5860.8 5872.6 5888.4 5892.9 5899.0 5420.1 5424.8 5433.0 5450.5 5452.0 5792.5 5812.7 5859.8 5877.0 5988.3 5724.1 5745.9 5760.4 5782.2 5790.0 5716.2 5840.9 5841.2 5846.7 5861.1 5634.2 5646.7 5760.6 5775.7 5790.4 5663.1 5714.5 5736.5 5750.0 5760.3 4888.4 4888.6 4897.5 4918.8 4931.1 4150.6 4165.5 4176.7 4214.7 4242.9 4726.3 4811.5 4834.3 4869.5 4874.3 5777.9 5798.1 5803.4 5821.0 5844.2 4806.4 4809.1 4834.7 4845.7 4870.8 5031.5 5101.4 5121.8 5133.7 5136.0 5295.1 5310.9 5375.5 5394.5 5407.4 5609.2 5671.3 5738.7 5770.4 5826.9 5282.2 5393.8 5402.5 5420.6 5460.3 5586.6 5653.6 5710.7 5744.5 5745.8 5719.1 5741.9 5771.8 5798.8 5807.8 5646.4 5650.0 5652.4 5657.3 5676.5 5426.8 5617.2 5624.6 5646.0 5651.1 5453.5 5495.7 5569.3 5572.5 5578.2 5732.4 5736.1 5743.7 5748.1 5778.9 5571.6 5575.0 5575.5 5587.2 5595.5 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | [#1] ext.html Cycles:180 Average:30985.90 Median:31018.61 stddev:42559.46 (137.2%) stddev-sans-first:42617.89 03:14:19 INFO - PID 32252 | Values: 650.8 689.7 709.0 1210.7 1226.4 33655.2 34443.7 34463.5 34478.8 34522.7 33061.5 33274.0 33304.0 33342.2 33357.0 6343.6 6590.7 6760.9 6761.8 6766.2 6694.8 6814.7 6827.7 6828.0 6837.5 6758.9 6781.8 6843.8 6846.8 6850.0 6803.5 6815.5 6824.8 6831.7 6836.4 6676.4 6736.4 6742.7 6744.8 6749.5 31735.7 31957.5 32033.4 32052.4 32058.4 3043.9 3046.8 3052.5 3056.5 3081.5 24507.9 24819.6 24853.1 24865.3 24868.4 2822.8 2844.8 2858.9 2864.3 2877.3 142178.0 142467.0 142745.0 154087.0 156704.0 38490.0 38778.0 38978.4 39371.4 39390.6 41251.8 41305.2 41329.4 41498.6 43957.0 12238.6 12340.3 12352.9 12362.3 12397.9 9764.3 9776.3 9797.6 9817.4 9824.5 12654.9 12796.4 12879.7 12919.7 13038.9 5152.4 5195.0 5345.3 5354.3 5379.4 856.9 899.2 899.3 903.3 922.4 20644.6 21165.0 21522.7 21615.7 21845.9 967.5 979.5 998.2 1003.5 1003.7 11040.5 11360.8 11415.5 11440.3 11556.8 176649.0 177251.0 178685.0 179175.0 180103.0 41141.8 41198.8 41272.2 41326.4 41346.0 1181.3 1223.1 1224.8 1231.0 1236.9 19535.8 19608.6 20235.3 21173.9 21194.3 29794.4 38263.2 38602.6 38768.0 39068.4 165662.2 166364.2 167179.0 167317.0 167714.0 29742.6 30446.6 30696.0 30905.2 31031.8 34976.5 35737.0 35867.1 36099.5 36722.7 27145.6 27299.7 27503.4 28045.2 28266.7 27430.9 27433.6 27960.3 28054.0 28778.3 30724.7 31005.4 31099.2 31117.7 31256.4 26171.9 26670.5 26864.2 27607.0 27626.2 20138.9 22621.4 22629.7 22664.8 22675.8 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | [#2] jquery.html Cycles:180 Average:25336.53 Median:345559.50 stddev:57326.53 (16.6%) stddev-sans-first:57456.79 03:14:19 INFO - PID 32252 | Values: 405.9 418.6 426.5 434.5 443.8 16802.2 17737.1 17808.1 18791.4 19317.3 18152.4 18415.7 18455.4 19113.5 19512.6 5510.5 5533.6 5585.4 5586.8 5710.2 5518.7 5561.1 5579.4 5602.6 5610.1 5324.5 5462.8 5500.2 5501.8 5547.4 5405.3 5411.9 5419.6 5446.5 5449.2 4924.0 4935.2 4962.8 4968.1 4975.6 21991.2 22488.8 22679.8 22708.8 22947.5 1637.7 1658.7 1671.0 1673.1 1675.6 14198.2 14807.9 15020.7 15132.2 15271.2 2089.2 2098.5 2110.6 2164.4 2174.7 86354.6 86451.0 91376.0 99376.0 100895.0 18025.5 18379.2 18476.7 18530.0 18617.8 34104.5 34233.1 34236.0 34275.0 34402.5 9162.4 9180.8 9252.8 9289.0 9400.0 7346.9 7392.9 7528.0 7554.4 7592.8 9567.0 9707.0 9732.3 9760.0 10037.7 3810.3 3833.2 3861.4 3895.7 3915.8 816.4 854.9 872.3 882.8 892.6 17250.3 17297.9 17298.0 17579.3 18005.6 848.6 855.9 860.8 867.8 886.3 9315.5 9557.3 9742.7 9797.8 9919.2 339162.0 339605.0 345194.2 345417.0 345702.0 68727.0 74398.6 75145.0 77739.6 78986.6 1024.6 1039.5 1054.3 1054.4 1066.1 17221.5 17614.6 18098.5 18159.0 18263.3 37881.6 38584.6 39323.0 39333.8 40043.0 47368.3 47756.0 48858.8 48953.0 49581.0 11204.2 11658.5 11737.7 11920.2 12061.9 12373.4 12589.2 12630.8 12790.9 13083.5 10605.1 10900.6 10906.7 11000.4 11340.5 9551.9 9771.7 9882.5 9915.7 9946.3 10396.7 10408.6 10721.2 11091.4 11141.7 10845.5 10926.0 11184.7 11194.3 11261.7 10236.6 10250.5 10286.8 10421.9 10555.9 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | [#3] mootools.html Cycles:180 Average:6534.31 Median:3323.33 stddev:4362.87 (131.3%) stddev-sans-first:4357.24 03:14:19 INFO - PID 32252 | Values: 1277.8 1313.5 1315.9 1327.1 1331.4 10292.5 10805.6 10866.1 10947.6 11174.7 10891.3 11032.8 11103.4 11108.2 11118.8 2203.3 2226.3 2231.2 2243.8 2259.7 2184.8 2194.8 2232.5 2235.1 2237.7 2167.8 2212.9 2214.6 2224.1 2237.6 2078.4 2086.5 2091.9 2092.1 2096.4 1834.4 1899.1 2081.1 2123.2 2140.3 10707.7 10743.5 10755.2 10762.3 10776.2 5530.9 5709.8 5751.2 5760.8 5772.8 3278.8 3367.8 3428.7 3429.3 3442.0 1129.7 1130.4 1141.8 1144.7 1164.8 15359.1 15438.2 15483.3 15564.3 15603.8 4517.7 4753.7 4825.9 4832.1 4958.6 11332.4 11438.8 11449.9 11451.4 11458.8 5448.0 5575.5 5580.4 5607.5 5630.8 5093.8 5109.3 5127.1 5181.7 5195.5 3829.6 3852.8 3890.3 3946.1 3975.1 1053.0 1058.8 1069.6 1072.3 1073.4 679.1 712.2 714.9 730.0 730.5 5506.9 5559.9 5567.5 5679.1 5744.0 515.4 546.8 546.9 848.2 866.6 3789.6 3838.5 3882.3 3931.4 4036.8 13858.5 14621.6 14691.9 14706.2 14713.9 13781.0 14587.2 14593.0 14600.3 14604.7 7610.4 7782.1 7845.8 7870.1 7881.8 5674.7 5685.2 5744.3 5905.6 6218.2 12364.3 12648.9 12786.6 12833.8 12887.9 12919.2 13012.7 13069.9 13073.0 13292.5 7964.5 8114.8 8147.8 8295.0 8673.3 10142.7 10190.3 10310.2 10314.8 10314.8 8522.5 8786.3 8850.6 8929.4 9008.8 8232.6 8300.7 8317.9 8393.4 8404.4 7349.5 7428.8 7488.8 7507.2 7541.1 4738.1 5160.8 5218.4 5413.1 5475.2 5293.4 5346.3 5363.3 5398.6 5443.6 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | [#4] prototype.html Cycles:180 Average:4839.64 Median:5379.56 stddev:1399.33 (26.0%) stddev-sans-first:1362.52 03:14:19 INFO - PID 32252 | Values: 373.9 376.6 381.2 386.6 386.8 5540.0 5544.6 5559.2 5564.5 5597.4 5299.3 5389.4 5397.6 5398.9 5418.8 4221.4 4225.2 4240.2 4252.7 4271.3 4240.7 4242.8 4246.5 4250.6 4259.3 4136.2 4213.5 4216.8 4217.2 4240.9 4202.0 4219.8 4226.6 4230.3 4231.0 3776.0 3784.9 3794.1 3803.4 3811.9 5220.6 5331.7 5364.9 5368.1 5369.7 4961.3 4982.0 4990.4 4992.9 4996.3 5721.8 5742.8 5755.6 5765.5 5776.8 4136.7 4236.4 4237.9 4254.2 4262.6 5991.9 6012.7 6019.8 6038.5 6211.5 4102.0 4109.3 4114.6 4124.4 4128.9 4184.8 4192.9 4194.6 4204.2 4205.5 4964.7 5094.3 5103.4 5161.7 5168.0 5926.3 5927.8 5932.7 5952.8 5954.2 1575.9 1594.5 1604.4 1612.3 1619.1 1137.3 1157.4 1171.4 1175.7 1177.2 4994.3 5001.3 5024.7 5048.7 5057.4 6009.0 6018.4 6033.6 6047.9 6060.5 4842.5 4976.8 4983.9 4993.9 5058.3 3186.2 3200.1 3218.7 3227.3 3235.2 5478.9 5636.2 5651.1 5651.9 5656.9 6178.4 6201.7 6202.8 6230.4 6239.8 5635.6 5646.4 5653.9 5654.8 5668.0 5957.4 6016.3 6029.2 6062.7 6070.5 5759.5 5979.4 5980.5 5989.3 6009.2 5618.1 5620.2 5624.3 5648.0 5654.8 4107.4 4122.5 4125.2 4129.3 4130.0 5921.4 6056.6 6069.8 6088.3 6160.8 5879.6 5903.3 5912.9 5923.2 5925.4 5724.0 5870.6 5871.7 5887.6 5909.8 5739.5 5793.5 5803.2 5819.0 5840.1 5920.5 5931.8 5946.3 5948.7 5957.4 5627.5 5726.9 5728.2 5745.4 5777.8 03:14:19 INFO - PID 32252 | 03:14:19 INFO - PID 32252 | [#5] yui.html Cycles:180 Average:17041.59 Median:3120.91 stddev:21403.23 (685.8%) stddev-sans-first:21428.13 03:14:19 INFO - PID 32252 | Values: 708.7 733.6 750.3 752.7 767.9 11641.3 12125.4 13482.7 14210.3 14240.6 14829.7 15236.5 15252.2 15325.5 15391.0 887.8 909.4 911.4 911.8 915.5 904.6 911.1 911.4 911.9 914.2 939.9 944.9 945.8 948.7 949.7 930.2 935.7 940.7 943.2 946.1 664.5 676.7 693.1 693.3 695.3 14356.4 14470.6 14597.6 14601.6 14637.8 14760.3 15650.6 15711.7 15731.8 15735.6 11998.9 12793.2 12868.1 12917.9 13022.7 3099.5 3103.6 3108.5 3120.5 3121.3 74925.0 76445.0 77187.6 78911.0 80101.6 12927.2 13374.3 13443.2 13464.3 13493.1 20075.2 20463.3 20539.1 21748.9 22035.7 6333.7 6409.4 6472.6 6488.7 6512.2 3038.5 3105.5 3109.3 3111.2 3114.5 3719.4 3913.1 4017.9 4029.1 4034.4 764.7 766.4 776.6 819.9 822.3 615.4 622.8 626.6 630.4 647.9 9604.4 9653.9 10000.6 10142.0 10306.0 594.6 606.6 606.9 609.3 615.4 4463.3 4497.2 4558.4 4631.5 4642.9 74260.0 75483.6 75951.0 82642.6 83357.2 63389.7 63575.7 63612.4 67898.3 68762.3 57988.7 58018.0 58443.0 58532.0 61393.4 9774.3 10342.9 10450.7 10680.4 10725.4 27985.2 28607.6 28618.6 29237.7 29281.7 50285.0 52219.7 53006.0 53767.7 53859.0 13825.8 13953.7 14312.3 14333.6 14416.1 16225.5 16692.7 17040.1 17101.4 17286.4 14135.6 14379.4 14404.4 14484.2 14549.0 14120.5 14573.5 14625.4 14634.7 15154.6 13532.7 13697.4 14214.7 14971.1 15239.5 10865.7 11244.3 11519.1 11610.2 12205.0 11428.0 12020.9 12035.8 12172.8 12366.4 03:14:19 INFO - PID 32252 | -------- Summary: end -------- 03:14:19 INFO - PID 32252 | 03:14:20 INFO - TEST-INFO | 32252: exit 0 03:14:20 INFO - TEST-OK | dromaeo_css | took 1148540ms 03:14:20 INFO - TEST-START | kraken 03:14:20 INFO - operating with platform_type : linux_ 03:14:20 INFO - Initialising browser for kraken test... 03:14:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46469/getInfo.html -profile /tmp/tmpnuliSY/profile 03:14:20 INFO - TEST-INFO | started process 32678 (/builds/slave/test/build/application/firefox/firefox http://localhost:46469/getInfo.html) 03:14:56 INFO - TEST-INFO | 32678: killed by SIGTERM 03:14:56 INFO - Browser initialized. 03:14:56 INFO - Running cycle 1/1 for kraken test... 03:14:56 INFO - TEST-INFO | started process 436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnuliSY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:08 INFO - PID 436 | RSS: Main: 186568704 03:15:08 INFO - PID 436 | 03:15:11 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46469/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:12 INFO - PID 436 | RSS: Main: 190087168 03:15:12 INFO - PID 436 | 03:15:15 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46469/tests/kraken/driver.html?testName=audio-dft) 03:15:15 INFO - PID 436 | RSS: Main: 189304832 03:15:15 INFO - PID 436 | 03:15:18 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46469/tests/kraken/driver.html?testName=audio-fft) 03:15:19 INFO - PID 436 | RSS: Main: 185880576 03:15:19 INFO - PID 436 | 03:15:21 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46469/tests/kraken/driver.html?testName=audio-oscillator) 03:15:22 INFO - PID 436 | RSS: Main: 186220544 03:15:22 INFO - PID 436 | 03:15:24 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46469/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:24 INFO - PID 436 | RSS: Main: 185987072 03:15:24 INFO - PID 436 | 03:15:28 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46469/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:28 INFO - PID 436 | RSS: Main: 189956096 03:15:28 INFO - PID 436 | 03:15:32 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46469/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:32 INFO - PID 436 | RSS: Main: 186691584 03:15:32 INFO - PID 436 | 03:15:35 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46469/tests/kraken/driver.html?testName=json-parse-financial) 03:15:36 INFO - PID 436 | RSS: Main: 186793984 03:15:36 INFO - PID 436 | 03:15:38 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46469/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:15:38 INFO - PID 436 | RSS: Main: 187084800 03:15:38 INFO - PID 436 | 03:15:40 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:15:41 INFO - PID 436 | RSS: Main: 187482112 03:15:41 INFO - PID 436 | 03:15:43 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:15:44 INFO - PID 436 | RSS: Main: 187285504 03:15:44 INFO - PID 436 | 03:15:47 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:15:47 INFO - PID 436 | RSS: Main: 187408384 03:15:47 INFO - PID 436 | 03:15:50 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:15:51 INFO - PID 436 | RSS: Main: 187445248 03:15:51 INFO - PID 436 | 03:15:53 INFO - PID 436 | Cycle 1(1): loaded http://localhost:46469/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46469/tests/kraken/driver.html?testName=ai-astar) 03:15:53 INFO - PID 436 | RSS: Main: 188649472 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | __start_tp_report 03:15:53 INFO - PID 436 | _x_x_mozilla_page_load 03:15:53 INFO - PID 436 | _x_x_mozilla_page_load_details 03:15:53 INFO - PID 436 | |i|pagename|runs| 03:15:53 INFO - PID 436 | |0;ai-astar;104;112;111;110;110;110;109;111;112;110 03:15:53 INFO - PID 436 | |1;audio-beat-detection;148;125;126;174;125;127;124;128;162;126 03:15:53 INFO - PID 436 | |2;audio-dft;164;164;165;169;168;168;164;163;164;164 03:15:53 INFO - PID 436 | |3;audio-fft;76;74;76;102;74;75;75;75;93;74 03:15:53 INFO - PID 436 | |4;audio-oscillator;85;84;109;84;85;83;97;84;84;106 03:15:53 INFO - PID 436 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;113;114;114 03:15:53 INFO - PID 436 | |6;imaging-darkroom;150;151;151;151;150;156;153;153;153;153 03:15:53 INFO - PID 436 | |7;imaging-desaturate;95;95;95;105;95;95;95;94;95;94 03:15:53 INFO - PID 436 | |8;json-parse-financial;54;55;56;55;56;56;58;56;57;59 03:15:53 INFO - PID 436 | |9;json-stringify-tinderbox;57;57;56;62;59;58;58;58;57;57 03:15:53 INFO - PID 436 | |10;stanford-crypto-aes;86;85;97;87;87;88;88;88;130;86 03:15:53 INFO - PID 436 | |11;stanford-crypto-ccm;136;140;144;146;139;138;140;140;136;141 03:15:53 INFO - PID 436 | |12;stanford-crypto-pbkdf2;186;186;197;186;192;190;204;208;195;197 03:15:53 INFO - PID 436 | |13;stanford-crypto-sha256-iterative;75;73;72;76;76;76;72;74;75;75 03:15:53 INFO - PID 436 | __end_tp_report 03:15:53 INFO - PID 436 | __start_cc_report 03:15:53 INFO - PID 436 | _x_x_mozilla_cycle_collect,1028 03:15:53 INFO - PID 436 | __end_cc_report 03:15:53 INFO - PID 436 | __startTimestamp1496139353683__endTimestamp 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | ------- Summary: start ------- 03:15:53 INFO - PID 436 | Number of tests: 14 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.28 (2.1%) stddev-sans-first:1.01 03:15:53 INFO - PID 436 | Values: 104.0 112.0 111.0 110.0 110.0 110.0 109.0 111.0 112.0 110.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:127.50 stddev:18.23 (14.3%) stddev-sans-first:18.86 03:15:53 INFO - PID 436 | Values: 148.0 125.0 126.0 174.0 125.0 127.0 124.0 128.0 162.0 126.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:2.16 (1.3%) stddev-sans-first:2.24 03:15:53 INFO - PID 436 | Values: 164.0 164.0 165.0 169.0 168.0 168.0 164.0 163.0 164.0 164.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#3] audio-fft Cycles:10 Average:79.40 Median:75.00 stddev:9.80 (13.1%) stddev-sans-first:10.32 03:15:53 INFO - PID 436 | Values: 76.0 74.0 76.0 102.0 74.0 75.0 75.0 75.0 93.0 74.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:10.05 (12.0%) stddev-sans-first:10.49 03:15:53 INFO - PID 436 | Values: 85.0 84.0 109.0 84.0 85.0 83.0 97.0 84.0 84.0 106.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:15:53 INFO - PID 436 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:153.00 stddev:1.85 (1.2%) stddev-sans-first:1.80 03:15:53 INFO - PID 436 | Values: 150.0 151.0 151.0 151.0 150.0 156.0 153.0 153.0 153.0 153.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:3.26 (3.4%) stddev-sans-first:3.44 03:15:53 INFO - PID 436 | Values: 95.0 95.0 95.0 105.0 95.0 95.0 95.0 94.0 95.0 94.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.48 (2.6%) stddev-sans-first:1.33 03:15:53 INFO - PID 436 | Values: 54.0 55.0 56.0 55.0 56.0 56.0 58.0 56.0 57.0 59.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:1.66 (2.9%) stddev-sans-first:1.73 03:15:53 INFO - PID 436 | Values: 57.0 57.0 56.0 62.0 59.0 58.0 58.0 58.0 57.0 57.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:87.50 stddev:13.69 (15.6%) stddev-sans-first:14.34 03:15:53 INFO - PID 436 | Values: 86.0 85.0 97.0 87.0 87.0 88.0 88.0 88.0 130.0 86.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:140.00 stddev:3.16 (2.3%) stddev-sans-first:3.00 03:15:53 INFO - PID 436 | Values: 136.0 140.0 144.0 146.0 139.0 138.0 140.0 140.0 136.0 141.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:196.00 stddev:7.65 (3.9%) stddev-sans-first:7.53 03:15:53 INFO - PID 436 | Values: 186.0 186.0 197.0 186.0 192.0 190.0 204.0 208.0 195.0 197.0 03:15:53 INFO - PID 436 | 03:15:53 INFO - PID 436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:75.00 stddev:1.58 (2.1%) stddev-sans-first:1.66 03:15:53 INFO - PID 436 | Values: 75.0 73.0 72.0 76.0 76.0 76.0 72.0 74.0 75.0 75.0 03:15:53 INFO - PID 436 | -------- Summary: end -------- 03:15:53 INFO - PID 436 | 03:15:54 INFO - TEST-INFO | 436: exit 0 03:15:54 INFO - TEST-OK | kraken | took 94162ms 03:15:54 INFO - SUITE-END | took 1242s 03:15:55 INFO - Completed test suite (00:20:43) 03:15:55 INFO - javascript benchmark 03:15:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6949.059281765733, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2688.193541937419, 2704.7295270472955, 2716.076533978447, 2733.835969841809, 2760.4341110072437, 5258.553022993041, 5338.5996050296235, 5342.118550439178, 5345.438728933459, 5371.57027437805, 5280.498352656501, 5320.095583750762, 5326.786928522854, 5332.706701131437, 5339.5728341732665, 4478.932816007747, 4694.577762684105, 4740.881477963053, 4750.857474275777, 4773.212419950704, 4794.184988551937, 4832.3717916670785, 4859.684120532172, 4864.878378040559, 4896.608271338285, 4655.953440465586, 4693.436787585478, 4720.905581888377, 4769.99830035693, 4781.402324709411, 4761.166795810719, 4787.904241915177, 4801.687890287155, 4821.300911367832, 4839.685420447659, 4691.7888695008805, 4717.599004084657, 4728.361671174416, 4757.643176761757, 4761.2382018876815, 5148.819791307286, 5227.47725227478, 5382.569394448435, 5383.67697938125, 5403.243545903577, 5666.631668941547, 5745.88508229833, 5755.021646320094, 5756.5682573807135, 5761.971190144022, 5860.7948721794955, 5872.618279811799, 5888.411158884121, 5892.852678683024, 5899.0, 5420.105682562333, 5424.83725488236, 5433.049216387117, 5450.482204190595, 5452.018636645442, 5792.478676919013, 5812.709364531756, 5859.765609375577, 5876.970615146983, 5988.251468566429, 5724.141378793214, 5745.942540574624, 5760.36635970043, 5782.161586569924, 5790.015697331463, 5716.228309178207, 5840.912386314209, 5841.153032810219, 5846.678432686158, 5861.120831875252, 5634.211210430543, 5646.689432081275, 5760.567957403127, 5775.711214439261, 5790.36306006339, 5663.122216056436, 5714.457126572969, 5736.512396446349, 5749.9937510935415, 5760.251167348301, 4888.437829649564, 4888.608911287089, 4897.4857639948, 4918.778654960535, 4931.112399768004, 4150.605692459211, 4165.500139983161, 4176.728512646669, 4214.683898707609, 4242.893927651833, 4726.314684370747, 4811.518848115161, 4834.347363106006, 4869.488703686062, 4874.317595536628, 5777.942220577825, 5798.130280457881, 5803.361630220672, 5820.970895145497, 5844.15259787337, 4806.44725856524, 4809.110314591811, 4834.661573689808, 4845.733484658307, 4870.756462176948, 5031.52200540948, 5101.387833459934, 5121.820736274212, 5133.666311689803, 5136.049830781318, 5295.099833028471, 5310.8937821244135, 5375.516203541543, 5394.541463975449, 5407.405185429679, 5609.24275222856, 5671.291088613923, 5738.713064346849, 5770.422957704196, 5826.912596311144, 5282.154855223146, 5393.784248630011, 5402.51377376038, 5420.566354691694, 5460.262864513399, 5586.581006424616, 5653.632513886584, 5710.743016564347, 5744.454276843693, 5745.827625171251, 5719.084946408555, 5741.942580574141, 5771.769129234952, 5798.797042103506, 5807.767689292381, 5646.435356464321, 5650.011248031496, 5652.4064973178865, 5657.349404818334, 5676.489115979582, 5426.810061647823, 5617.241672374341, 5624.550035997192, 5645.971770141123, 5651.124075768263, 5453.536449401845, 5495.697736624524, 5569.303837020372, 5572.4706152915405, 5578.219049333015, 5732.398098199629, 5736.053551164011, 5743.6840973745175, 5748.080307150836, 5778.913316300175, 5571.637843540157, 5574.9721251393485, 5575.526080283222, 5587.245721827501, 5595.496405323541], "value": 5229.362479515309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.8372906773307, 689.7447944260623, 708.9999999999999, 1210.6731182580704, 1226.350034481724, 33655.15862103448, 34443.65556344436, 34463.48304775427, 34478.82760586194, 34522.65477345226, 33061.504077438854, 33274.0, 33304.0, 33342.16644583887, 33357.0, 6343.555951083426, 6590.670466476681, 6760.864782704368, 6761.797146085625, 6766.15423072116, 6694.83262918426, 6814.727410903558, 6827.692753826065, 6828.044073829643, 6837.48718846086, 6758.918573028316, 6781.830454238659, 6843.794686159398, 6846.828829279283, 6850.040994260783, 6803.455723542104, 6815.454763618898, 6824.829379265509, 6831.69257383419, 6836.418904393133, 6676.365745254193, 6736.427403670694, 6742.662866856637, 6744.7976560703255, 6749.460043196533, 31735.682643173503, 31957.52063719046, 32033.359332813445, 32052.358952820814, 32058.358832823214, 3043.8782448702027, 3046.8019578727312, 3052.542118682193, 3056.541518772202, 3081.5223640335785, 24507.877460612763, 24819.62770558443, 24853.130140445, 24865.254042378758, 24868.3782905427, 2822.760065394444, 2844.843533605651, 2858.9285267868263, 2864.269611249139, 2877.323828900228, 142178.0, 142467.0, 142745.0, 154087.0, 156703.99999999886, 38490.0, 38778.0, 38978.41532377017, 39371.40942885859, 39390.60609393927, 41251.793741031106, 41305.173896521905, 41329.38005929913, 41498.585014149474, 43957.0, 12238.571649992207, 12340.321282329378, 12352.938235308766, 12362.258264504158, 12397.93801031007, 9764.316497845224, 9776.266779991529, 9797.608095676236, 9817.410955342702, 9824.459654718916, 12654.936725316315, 12796.424160912595, 12879.746044442372, 12919.741605167845, 13038.869611303955, 5152.355955505562, 5194.97402512985, 5345.251664766935, 5354.277172581729, 5379.408265090837, 856.9400141990126, 899.2221728205055, 899.2715900120922, 903.3134817538718, 922.3681777982104, 20644.593642049193, 21165.0, 21522.677159842617, 21615.67576486354, 21845.890770546044, 967.5259123029806, 979.4955597867104, 998.2164001258977, 1003.4531180506641, 1003.6988903328972, 11040.503177357039, 11360.772784544428, 11415.543378264943, 11440.313581185155, 11556.768864622829, 176649.0, 177251.0, 178685.0, 179175.0, 180103.0, 41141.79429102835, 41198.79400603038, 41272.174556508704, 41326.380104298456, 41346.0, 1181.3274670749795, 1223.082687984012, 1224.7611715715527, 1230.969225769363, 1236.8948639365574, 19535.76796360969, 19608.607827843647, 20235.291764788162, 21173.894130529865, 21194.258200963508, 29794.404111917207, 38263.234735304584, 38602.6139738599, 38768.0, 39068.413973789844, 165662.17168914562, 166364.16817915833, 167179.0, 167317.0, 167714.0, 29742.55386169166, 30446.564274857516, 30696.0, 30905.227369315948, 31031.84484077565, 34976.475352869216, 35737.0, 35867.10332241715, 36099.458508121876, 36722.7147049852, 27145.59281610738, 27299.72700272972, 27503.44993100167, 28045.158645240674, 28266.717332826407, 27430.862845685642, 27433.58849617297, 27960.30099247535, 28054.0, 28778.28054298659, 30724.692753072184, 31005.379892401575, 31099.222519437197, 31117.688823112385, 31256.37487250197, 26171.869140654177, 26670.466590668468, 26864.194074177805, 27607.03375381852, 27626.171214863585, 20138.89930550338, 22621.43446413853, 22629.660555092018, 22664.773352266267, 22675.782125269532], "value": 14565.178516353406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.87620775663413, 418.5736079328758, 426.49247395599224, 434.51768536924027, 443.7892001299383, 16802.243899024543, 17737.113144342795, 17808.109594520272, 18791.436256912315, 19317.323893663724, 18152.36466723665, 18415.72376414355, 18455.446336609923, 19113.52216194596, 19512.609747805036, 5510.476504732044, 5533.557315414777, 5585.385607583163, 5586.832395028136, 5710.200571919934, 5518.6688798672, 5561.082421400464, 5579.414161513044, 5602.579806514507, 5610.074337734269, 5324.467553244664, 5462.754176062067, 5500.22996780451, 5501.779928802843, 5547.417521160281, 5405.270288511079, 5411.891762164754, 5419.566434685215, 5446.537044351215, 5449.237106805051, 4924.0, 4935.2350385689915, 4962.801487940478, 4968.080905032544, 4975.577075948549, 21991.230306939182, 22488.775112248833, 22679.77320226793, 22708.77291227083, 22947.541049178923, 1637.7379619260862, 1658.7263101588223, 1671.0391524873125, 1673.1299724143498, 1675.6481138960833, 14198.219097949608, 14807.925960370238, 15020.699586008328, 15132.243387830564, 15271.160086195256, 2089.174775963501, 2098.4858709616087, 2110.5778844231213, 2164.415607785889, 2174.7390313162523, 86354.56822715909, 86451.0, 91376.0, 99376.0, 100894.99105008929, 18025.549361266072, 18379.172937217856, 18476.722849157275, 18530.0, 18617.81382186188, 34104.54327307619, 34233.144171395914, 34235.97292081242, 34275.0, 34402.48396274058, 9162.358634895494, 9180.816383672289, 9252.814943701089, 9288.953555232316, 9400.0, 7346.889796653055, 7392.889106663404, 7528.021357223526, 7554.43341749371, 7592.772216833504, 9567.0, 9707.0, 9732.270079743907, 9760.0, 10037.698869033795, 3810.3141434541494, 3833.21419109082, 3861.435559548778, 3895.6883449324555, 3915.7650540967634, 816.4366587055032, 854.8632218844955, 872.2536704852673, 882.8101958078915, 892.5983307511646, 17250.309987600354, 17297.91351043237, 17298.0, 17579.296828126986, 18005.639887202182, 848.5714714069479, 855.9015713192938, 860.7848037990502, 867.7960679240374, 886.3485338276362, 9315.534223288809, 9557.330986830993, 9742.659006934724, 9797.80404391908, 9919.15687166599, 339162.0, 339605.0, 345194.2065503773, 345417.0, 345702.0, 68727.0, 74398.62800685962, 75145.0, 77739.61130194426, 78986.6050669743, 1024.5645600619707, 1039.4750650921085, 1054.260470224121, 1054.3989925742253, 1066.109798318413, 17221.483355499357, 17614.559636009202, 18098.54753631117, 18159.0, 18263.269469221083, 37881.62118378781, 38584.6141538581, 39323.0, 39333.80333098316, 40043.0, 47368.289475657206, 47756.04487910292, 48858.75570622124, 48953.0, 49581.0, 11204.159688023594, 11658.475368608602, 11737.706557335794, 11920.165588408729, 12061.939690301493, 12373.381330933596, 12589.24464532131, 12630.810537842124, 12790.936045319713, 13083.542076027674, 10605.098566621924, 10900.618478353219, 10906.72733181645, 11000.394978275952, 11340.489677964346, 9551.904480955101, 9771.706848794547, 9882.50587470638, 9915.702528924145, 9946.303758736818, 10396.74008149772, 10408.583656653649, 10721.195910306602, 11091.389973551532, 11141.665750027512, 10845.511951962339, 10926.0, 11184.72038199019, 11194.272372295774, 11261.66215013551, 10236.590536378462, 10250.487475626338, 10286.845697314697, 10421.895781042092, 10555.894441055798], "value": 9646.490993378833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.8083287506877, 1313.4746101559374, 1315.9342032898353, 1327.084311824841, 1331.447449308537, 10292.485375731212, 10805.56777728892, 10866.130709543228, 10947.5620975161, 11174.720631984184, 10891.346519208853, 11032.779344413128, 11103.44482775862, 11108.16688748343, 11118.777624447506, 2203.3389983005072, 2226.2875879718495, 2231.1967691631, 2243.7868402501736, 2259.7401298850596, 2184.8252139828774, 2194.7585765565773, 2232.520008198237, 2235.1282999630075, 2237.6643503474447, 2167.8482506224573, 2212.9225477108303, 2214.5792299463133, 2224.077008041661, 2237.641977283635, 2078.3972647932083, 2086.54096098858, 2091.874487530753, 2092.1213090502024, 2096.3501314592527, 1834.394649765574, 1899.135893168605, 2081.063521415354, 2123.182574708733, 2140.3044010696585, 10707.732306692316, 10743.462826858704, 10755.247132700635, 10762.300450470773, 10776.245662803607, 5530.889382212334, 5709.8287051388525, 5751.166080918285, 5760.8271751847515, 5772.769089236425, 3278.8169237471952, 3367.848446819899, 3428.6914177723875, 3429.3141371725505, 3441.984614538717, 1129.6836885672026, 1130.3895896216034, 1141.783061218374, 1144.673767976131, 1164.8078067118915, 15359.078455292718, 15438.150901700403, 15483.303251353716, 15564.299606517734, 15603.843961560466, 4517.6837621366185, 4753.691010084333, 4825.927611085836, 4832.081904438216, 4958.553730164303, 11332.376719280519, 11438.771224575628, 11449.942750286194, 11451.370174640308, 11458.828117578243, 5448.019356515865, 5575.470330318613, 5580.414056524088, 5607.467290607386, 5630.831075067755, 5093.796248150033, 5109.335786347751, 5127.083032885975, 5181.689098654093, 5195.532402083831, 3829.5596006459054, 3852.8073596320073, 3890.2997460456822, 3946.072672921861, 3975.1254723960683, 1052.9894701053045, 1058.8147074261974, 1069.561479793281, 1072.2762135558623, 1073.350622873166, 679.100192245277, 712.2236761929419, 714.9392301654418, 730.0399974034234, 730.466759265739, 5506.944930550723, 5559.8888022239325, 5567.526760225345, 5679.091345384719, 5744.023516002289, 515.4381723920944, 546.8222827580972, 546.8605505596048, 848.240824462103, 866.6056944090424, 3789.5831458539537, 3838.5393752749846, 3882.301185786529, 3931.4495970564144, 4036.798160091984, 13858.514951976633, 14621.561353159423, 14691.926540367444, 14706.191159486118, 14713.92643036778, 13780.9999999998, 14587.197704126163, 14593.0, 14600.269986500633, 14604.707905842037, 7610.353119984863, 7782.105057918412, 7845.764627061198, 7870.094939081964, 7881.763547093597, 5674.74463649145, 5685.180742162634, 5744.253247077853, 5905.5570832186895, 6218.22272215973, 12364.319962402154, 12648.936755316532, 12786.61640150797, 12833.807492887427, 12887.93556032214, 12919.160254583421, 13012.739745205232, 13069.869301306866, 13073.0, 13292.468301267842, 7964.522128672298, 8114.797130071795, 8147.75556733299, 8294.958525207336, 8673.34949878749, 10142.695719128438, 10190.286679932333, 10310.175185984954, 10314.845277320695, 10314.845277320996, 8522.48865068098, 8786.25316848075, 8850.64597416122, 8929.419587726778, 9008.819823603622, 8232.588370581327, 8300.70947516834, 8317.875231871647, 8393.370497212856, 8404.369672274726, 7349.522281051714, 7428.814279643052, 7488.775336739906, 7507.249275072449, 7541.095068591804, 4738.147133516, 5160.819371321985, 5218.373795144607, 5413.079776438094, 5475.178723191394, 5293.417724050274, 5346.304980352529, 5363.329583802025, 5398.62209645321, 5443.618946673695], "value": 4813.028208980154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.87662071516405, 376.55002272284634, 381.20899134296343, 386.5573917864046, 386.75247841381537, 5539.972300138499, 5544.6118771686, 5559.19391688205, 5564.527015203707, 5597.384287728347, 5299.311089558352, 5389.380221274555, 5397.568194544437, 5398.8920221595545, 5418.756155972981, 4221.430106935555, 4225.154969006211, 4240.194363071015, 4252.744835309892, 4271.273883439807, 4240.681948853849, 4242.83028678854, 4246.490421149451, 4250.638695710868, 4259.297215959363, 4136.172765446908, 4213.47331583552, 4216.789160541976, 4217.15656868626, 4240.872773816775, 4202.0, 4219.78901054946, 4226.577342265779, 4230.323148296273, 4230.9537133264, 3775.9993601695573, 3784.8864534063746, 3794.0894185395305, 3803.448499967517, 3811.904702382435, 5220.634555581073, 5331.706756128411, 5364.892702145974, 5368.141097424394, 5369.731513424314, 4961.255811628284, 4982.0, 4990.426100998396, 4992.90156165643, 4996.25056241563, 5721.7711291548285, 5742.827715168552, 5755.568332375088, 5765.549641402387, 5776.826695199151, 4136.710430269883, 4236.385724070024, 4237.851675191384, 4254.212970600449, 4262.552431994627, 5991.850203744898, 6012.729427175787, 6019.765947980697, 6038.456538911519, 6211.484348838772, 4101.974506373406, 4109.301418758759, 4114.588541145861, 4124.443200167939, 4128.91742165155, 4184.832606695759, 4192.853250136231, 4194.622483976395, 4204.180184863983, 4205.516365617932, 4964.702117872867, 5094.337736094358, 5103.362079740033, 5161.66449180802, 5168.0, 5926.318473375531, 5927.792527261525, 5932.673702946293, 5952.791652292149, 5954.166416701665, 1575.8896877218715, 1594.4817934171208, 1604.4143887480986, 1612.3469994652185, 1619.0852168524746, 1137.3062431916524, 1157.3923690062616, 1171.3850228629867, 1175.7001964498997, 1177.181858608259, 4994.278118425467, 5001.324821149098, 5024.748762561857, 5048.67760830015, 5057.443681195065, 6009.0, 6018.428249316308, 6033.637981721111, 6047.939520604826, 6060.454559089703, 4842.5157484251295, 4976.800927962841, 4983.9252411213865, 4993.875153121128, 5058.317127187856, 3186.235303527183, 3200.135963289899, 3218.6620404857154, 3227.2577307219003, 3235.223546348859, 5478.890422191534, 5636.1827535008015, 5651.124075768263, 5651.9152212716845, 5656.935218645165, 6178.4439400453275, 6201.720922558496, 6202.813915582449, 6230.408111229426, 6239.844003899848, 5635.605507614428, 5646.407127251579, 5653.858653533694, 5654.773809047592, 5667.971660141756, 5957.4042595740075, 6016.345504985989, 6029.246344206974, 6062.7271772769445, 6070.544709146743, 5759.481646651821, 5979.402059793986, 5980.521558275241, 5989.251343582052, 6009.158717779602, 5618.073017951992, 5620.213170156263, 5624.29696287964, 5648.0, 5654.830355089354, 4107.424960505472, 4122.505299364096, 4125.154343359664, 4129.339305711072, 4130.029443080934, 5921.407859214217, 6056.636601803906, 6069.757209711739, 6088.269407671108, 6160.845978850564, 5879.588428810113, 5903.26209223847, 5912.940870591411, 5923.170756094064, 5925.4370834770625, 5724.041471924801, 5870.647761134345, 5871.6770577616935, 5887.646741195542, 5909.793157239648, 5739.454751798572, 5793.507551858139, 5803.158542011301, 5819.0, 5840.094785308284, 5920.467157955804, 5931.822045338647, 5946.286445626552, 5948.702564871653, 5957.3744756799915, 5627.5497960162265, 5726.854629074285, 5728.198052272602, 5745.396733342939, 5777.7977770777825], "value": 4421.129415090399, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.7165133946424, 733.5928559649392, 750.2909750285979, 752.6537792615396, 767.9040119985, 11641.30152190867, 12125.393730313494, 13482.662933426669, 14210.289485525722, 14240.572782816505, 14829.703405931901, 15236.466723664675, 15252.237388130605, 15325.540233793005, 15391.0, 887.800244944887, 909.440693973205, 911.3984770051767, 911.803962148138, 915.5422288855572, 904.606496174163, 911.1435250864199, 911.3711539038076, 911.9042500537447, 914.1863741270241, 939.8872135343769, 944.914957653811, 945.8013817098383, 948.6869333120088, 949.7008442340675, 930.2279108340095, 935.672514619881, 940.6613619097119, 943.2454036770624, 946.1484663802564, 664.4916638771343, 676.6582875647815, 693.0955103589813, 693.2893783871572, 695.2977492732326, 14356.425742970268, 14470.565883023526, 14597.562073137822, 14601.561953141423, 14637.780433293508, 14760.335784889705, 15650.608734781721, 15711.685766284725, 15731.764023539656, 15735.606609834731, 11998.940005300004, 12793.232406055666, 12868.09923305369, 12917.935410322889, 13022.739545209042, 3099.5350697395347, 3103.6275646922513, 3108.4560201964564, 3120.5163199704084, 3121.3133110715607, 74925.0, 76445.0, 77187.61406192933, 78911.0, 80101.59949200274, 12927.15973461722, 13374.33128343579, 13443.193408395528, 13464.259465729283, 13493.122947008413, 20075.196992120444, 20463.28378506745, 20539.075741591663, 21748.89125554362, 22035.66946495804, 6333.746650134035, 6409.423151916257, 6472.579282346633, 6488.67556622167, 6512.153420055362, 3038.483457812177, 3105.534169874537, 3109.300407408315, 3111.23774675206, 3114.5016797312323, 3719.367707489733, 3913.0608653922855, 4017.9196416071513, 4029.0531725044593, 4034.415009823559, 764.7055883484787, 766.3562607409802, 776.5573623034929, 819.8647223208104, 822.3092602214169, 615.3538784276582, 622.8411755002445, 626.5739297277804, 630.4294613374904, 647.896336586144, 9604.423734575948, 9653.90346096544, 10000.649977250761, 10142.0, 10305.969403059635, 594.5719082260765, 606.6360183889631, 606.9302030266488, 609.2567068176817, 615.4061330815784, 4463.2635615123145, 4497.235469970047, 4558.384618076583, 4631.467381251132, 4642.930356044662, 74260.0, 75483.62258188784, 75951.0, 82642.58678706568, 83357.16642833494, 63389.68305158537, 63575.682121589096, 63612.36387636157, 67898.3210167892, 68762.3123768766, 57988.71005644945, 58018.0, 58443.0, 58532.0, 61393.38606613966, 9774.266929980138, 10342.948285258526, 10450.68647940563, 10680.359178449318, 10725.41010244444, 27985.160445186677, 28607.570886437137, 28618.57072143878, 29237.7076229235, 29281.707182927898, 50285.0, 52219.73890130525, 53006.0, 53767.73116134551, 53859.0, 13825.792613111013, 13953.651158720708, 14312.284385780462, 14333.64165895861, 14416.13503189812, 16225.51323460298, 16692.749608755636, 17040.147992600072, 17101.401450949157, 17286.394976175772, 14135.64660883486, 14379.352929118006, 14404.351804168627, 14484.203368814395, 14549.0, 14120.50578229757, 14573.489927852474, 14625.414983400971, 14634.707305854035, 15154.621134471727, 13532.729345413234, 13697.383617737425, 14214.715705686036, 14971.101733896001, 15239.466618668293, 10865.728356790827, 11244.26912250701, 11519.136064795006, 11610.245334053598, 12205.0, 11428.0, 12020.879791201976, 12035.819462707892, 12172.817407738714, 12366.443510042249], "value": 7201.763866682557, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 110.0, 110.0, 110.0, 109.0, 111.0, 112.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 126.0, 174.0, 125.0, 127.0, 124.0, 128.0, 162.0, 126.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 169.0, 168.0, 168.0, 164.0, 163.0, 164.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 102.0, 74.0, 75.0, 75.0, 75.0, 93.0, 74.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 84.0, 85.0, 83.0, 97.0, 84.0, 84.0, 106.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 151.0, 150.0, 156.0, 153.0, 153.0, 153.0, 153.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 105.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 55.0, 56.0, 56.0, 58.0, 56.0, 57.0, 59.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 62.0, 59.0, 58.0, 58.0, 58.0, 57.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 97.0, 87.0, 87.0, 88.0, 88.0, 88.0, 130.0, 86.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 144.0, 146.0, 139.0, 138.0, 140.0, 140.0, 136.0, 141.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 197.0, 186.0, 192.0, 190.0, 204.0, 208.0, 195.0, 197.0], "value": 194.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 76.0, 76.0, 76.0, 72.0, 74.0, 75.0, 75.0], "value": 74.4, "unit": "score"}]}]} 03:15:55 INFO - Return code: 0 03:15:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:15:55 INFO - # TBPL SUCCESS # 03:15:55 INFO - Running post-action listener: _resource_record_post_action 03:15:55 INFO - [mozharness: 2017-05-30 10:15:55.501059Z] Finished run-tests step (success) 03:15:55 INFO - Running post-run listener: _resource_record_post_run 03:15:55 INFO - Total resource usage - Wall time: 1260s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432467968; Read time: 136; Write time: 737912 03:15:55 INFO - TinderboxPrint: CPU usage
12.8% 03:15:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 136 03:15:55 INFO - TinderboxPrint: I/O write bytes / time
432,467,968 / 737,912 03:15:55 INFO - TinderboxPrint: CPU idle
8,773.5 (87.2%) 03:15:55 INFO - TinderboxPrint: CPU user
1,223.1 (12.2%) 03:15:55 INFO - TinderboxPrint: Swap in / out
0 / 0 03:15:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 111894528; Read time: 0; Write time: 246064 03:15:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:15:55 INFO - run-tests - Wall time: 1244s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320573440; Read time: 120; Write time: 491848 03:15:56 INFO - Running post-run listener: _upload_blobber_files 03:15:56 INFO - Blob upload gear active. 03:15:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:15:56 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 03:15:56 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'] 03:15:56 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 03:15:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:15:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:15:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:15:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:15:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:15:57 INFO - (blobuploader) - INFO - Done attempting. 03:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:01 INFO - (blobuploader) - INFO - Done attempting. 03:16:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:02 INFO - (blobuploader) - INFO - Done attempting. 03:16:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:16:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:16:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:03 INFO - (blobuploader) - INFO - Done attempting. 03:16:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:03 INFO - Return code: 0 03:16:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/867c5b90a3cce7aa3671355a1749e359b165aa869b383fd02b8a9bd6c20577b89c5ea538ef321c1b2f3264dc952a09d420487b9ca1ed6dcff2c47960074d2432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a1654205bf62307d810b652317c2da9e69ca6c82b5d5264f0d3f0273b1bc160c7206f07104b65b29d5450e247105c704a5382b06391131679c66e257475ab5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5216b8e88e73538261448a6abb07269178cdccca95600286b878b2723835e5ebfe3907cbcd5b38e7a9a00a38cc62d34ff5db9c00c1f1a13ca6357a755514ff8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c685189bd93e2997192647464e234c52f3d986e35f8877139aaca300b45fd31ea78f686bbde1b615374fc56399910d2a89766253474362f5baf68d1b3539fa8"} 03:16:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:03 INFO - Contents: 03:16:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/867c5b90a3cce7aa3671355a1749e359b165aa869b383fd02b8a9bd6c20577b89c5ea538ef321c1b2f3264dc952a09d420487b9ca1ed6dcff2c47960074d2432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a1654205bf62307d810b652317c2da9e69ca6c82b5d5264f0d3f0273b1bc160c7206f07104b65b29d5450e247105c704a5382b06391131679c66e257475ab5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5216b8e88e73538261448a6abb07269178cdccca95600286b878b2723835e5ebfe3907cbcd5b38e7a9a00a38cc62d34ff5db9c00c1f1a13ca6357a755514ff8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c685189bd93e2997192647464e234c52f3d986e35f8877139aaca300b45fd31ea78f686bbde1b615374fc56399910d2a89766253474362f5baf68d1b3539fa8"} 03:16:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:03 INFO - Copying logs to upload dir... 03:16:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1326.629533 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2017-05-30 03:16:03.509747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 03:16:03.512784) ========= 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=8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/867c5b90a3cce7aa3671355a1749e359b165aa869b383fd02b8a9bd6c20577b89c5ea538ef321c1b2f3264dc952a09d420487b9ca1ed6dcff2c47960074d2432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a1654205bf62307d810b652317c2da9e69ca6c82b5d5264f0d3f0273b1bc160c7206f07104b65b29d5450e247105c704a5382b06391131679c66e257475ab5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5216b8e88e73538261448a6abb07269178cdccca95600286b878b2723835e5ebfe3907cbcd5b38e7a9a00a38cc62d34ff5db9c00c1f1a13ca6357a755514ff8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c685189bd93e2997192647464e234c52f3d986e35f8877139aaca300b45fd31ea78f686bbde1b615374fc56399910d2a89766253474362f5baf68d1b3539fa8"} build_url:https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/AA8B3mXORxmPMa2Whv_bfw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/867c5b90a3cce7aa3671355a1749e359b165aa869b383fd02b8a9bd6c20577b89c5ea538ef321c1b2f3264dc952a09d420487b9ca1ed6dcff2c47960074d2432", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2a1654205bf62307d810b652317c2da9e69ca6c82b5d5264f0d3f0273b1bc160c7206f07104b65b29d5450e247105c704a5382b06391131679c66e257475ab5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5216b8e88e73538261448a6abb07269178cdccca95600286b878b2723835e5ebfe3907cbcd5b38e7a9a00a38cc62d34ff5db9c00c1f1a13ca6357a755514ff8b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c685189bd93e2997192647464e234c52f3d986e35f8877139aaca300b45fd31ea78f686bbde1b615374fc56399910d2a89766253474362f5baf68d1b3539fa8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 03:16:03.539877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:16:03.540172) ========= 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=8783db0840cc980e80bb0bd400000236-1496135930.605471-1786205934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:16:03.622286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 03:16:03.625664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 03:16:03.625952) ========= ========= Total master_lag: 0.18 =========