builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1496837727.0 results: success (0) revision: f6320f91851c2cede08b0fb54a6d0525b870310e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:26.999099) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:26.999758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.000036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.055511) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.055994) ========= 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=199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-07 05:15:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-06-07 05:15:27 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.373713 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.466025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.466317) ========= 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=199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014025 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.515386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.515685) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6320f91851c2cede08b0fb54a6d0525b870310e --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 f6320f91851c2cede08b0fb54a6d0525b870310e --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=199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-07 05:15:27,665 truncating revision to first 12 chars 2017-06-07 05:15:27,665 Setting DEBUG logging. 2017-06-07 05:15:27,665 attempt 1/10 2017-06-07 05:15:27,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6320f91851c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-07 05:15:28,229 unpacking tar archive at: mozilla-central-f6320f91851c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.862667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.392081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.392602) ========= script_repo_revision: f6320f91851c2cede08b0fb54a6d0525b870310e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.393227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.393678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.406851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-07 05:15:28.407191) ========= /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=199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:28 INFO - MultiFileLogger online at 20170607 05:15:28 in /builds/slave/test 05:15:28 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 05:15:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:28 INFO - {'append_to_log': False, 05:15:28 INFO - 'base_work_dir': '/builds/slave/test', 05:15:28 INFO - 'blob_upload_branch': 'Firefox', 05:15:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:28 INFO - 'branch': 'Firefox', 05:15:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:28 INFO - 'config_files': ('talos/linux_config.py',), 05:15:28 INFO - 'default_actions': ('clobber', 05:15:28 INFO - 'read-buildbot-config', 05:15:28 INFO - 'download-and-extract', 05:15:28 INFO - 'populate-webroot', 05:15:28 INFO - 'create-virtualenv', 05:15:28 INFO - 'install', 05:15:28 INFO - 'setup-mitmproxy', 05:15:28 INFO - 'run-tests'), 05:15:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:28 INFO - 'download_minidump_stackwalk': True, 05:15:28 INFO - 'download_symbols': 'ondemand', 05:15:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:28 INFO - 'gecko_profile': False, 05:15:28 INFO - 'gecko_profile_interval': 0, 05:15:28 INFO - 'installer_path': 'installer.exe', 05:15:28 INFO - 'log_level': 'info', 05:15:28 INFO - 'log_name': 'talos', 05:15:28 INFO - 'log_to_console': True, 05:15:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:28 INFO - 'opt_config_files': (), 05:15:28 INFO - 'pip_index': False, 05:15:28 INFO - 'suite': 'dromaeojs-e10s', 05:15:28 INFO - 'system_bits': '32', 05:15:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:28 INFO - 'title': 'talos-linux64-ix-072', 05:15:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:28 INFO - 'use_talos_json': True, 05:15:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:28 INFO - 'work_dir': 'build'} 05:15:28 INFO - [mozharness: 2017-06-07 12:15:28.785134Z] Running clobber step. 05:15:28 INFO - Running pre-action listener: _resource_record_pre_action 05:15:28 INFO - Running main action method: clobber 05:15:28 INFO - rmtree: /builds/slave/test/build 05:15:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:29 INFO - Running post-action listener: _resource_record_post_action 05:15:29 INFO - [mozharness: 2017-06-07 12:15:29.773440Z] Finished clobber step (success) 05:15:29 INFO - [mozharness: 2017-06-07 12:15:29.773542Z] Running read-buildbot-config step. 05:15:29 INFO - Running pre-action listener: _resource_record_pre_action 05:15:29 INFO - Running main action method: read_buildbot_config 05:15:29 INFO - Using buildbot properties: 05:15:29 INFO - { 05:15:29 INFO - "project": "", 05:15:29 INFO - "product": "firefox", 05:15:29 INFO - "who": "cbook@mozilla.com", 05:15:29 INFO - "installer_path": "public/build/target.tar.bz2", 05:15:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:15:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:15:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:15:29 INFO - "stage_platform": "linux64-stylo", 05:15:29 INFO - "basedir": "/builds/slave/test", 05:15:29 INFO - "buildnumber": 141, 05:15:29 INFO - "platform": "ubuntu64_hw_stylo", 05:15:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:29 INFO - "slavebuilddir": "test", 05:15:29 INFO - "taskId": "MXxNQKMbTmC-WMv6K-WDtA", 05:15:29 INFO - "branch": "mozilla-central", 05:15:29 INFO - "script_repo_revision": "production", 05:15:29 INFO - "revision": "f6320f91851c2cede08b0fb54a6d0525b870310e", 05:15:29 INFO - "slavename": "talos-linux64-ix-072", 05:15:29 INFO - "repo_path": "mozilla-central" 05:15:29 INFO - } 05:15:29 INFO - Finding installer, test and symbols from parent task. 05:15:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXxNQKMbTmC-WMv6K-WDtA'}, attempt #1 05:15:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXxNQKMbTmC-WMv6K-WDtA'}, attempt #1 05:15:30 INFO - Task dependencies: EsjSzTmcTRGF966pkkVXsQ 05:15:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ'}, attempt #1 05:15:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 05:15:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/test_packages.json 05:15:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.crashreporter-symbols.zip 05:15:31 INFO - Running post-action listener: _resource_record_post_action 05:15:31 INFO - [mozharness: 2017-06-07 12:15:31.172241Z] Finished read-buildbot-config step (success) 05:15:31 INFO - [mozharness: 2017-06-07 12:15:31.172462Z] Running download-and-extract step. 05:15:31 INFO - Running pre-action listener: _resource_record_pre_action 05:15:31 INFO - Running main action method: download_and_extract 05:15:31 INFO - mkdir: /builds/slave/test/build/tests 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:31 INFO - trying https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.test_packages.json 05:15:31 INFO - Downloading https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:15:31 INFO - Downloaded 989 bytes. 05:15:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:15:31 INFO - Using the following test package requirements: 05:15:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:15:31 INFO - u'common': [u'target.common.tests.zip'], 05:15:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:15:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:15:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:15:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:15:31 INFO - u'mozbase': [u'target.common.tests.zip'], 05:15:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:15:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:15:31 INFO - u'web-platform': [u'target.common.tests.zip', 05:15:31 INFO - u'target.web-platform.tests.tar.gz'], 05:15:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:15:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:15:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip 05:15:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:15:31 INFO - Fetch https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip into memory 05:15:34 INFO - Content-Length response header: 65117446 05:15:34 INFO - Bytes received: 65117446 05:15:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:15:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip 05:15:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:15:45 INFO - Fetch https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip into memory 05:15:48 INFO - Content-Length response header: 65117446 05:15:48 INFO - Bytes received: 65117446 05:16:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.talos.tests.zip 05:16:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:16:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.talos.tests.zip into memory 05:16:02 INFO - Content-Length response header: 14447563 05:16:02 INFO - Bytes received: 14447563 05:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:02 INFO - trying https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 05:16:02 INFO - Downloading https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:16:03 INFO - Downloaded 60572388 bytes. 05:16:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 05:16:03 INFO - mkdir: /builds/slave/test/properties 05:16:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:03 INFO - Contents: 05:16:03 INFO - build_url:https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 05:16:03 INFO - Running post-action listener: _resource_record_post_action 05:16:03 INFO - Running post-action listener: set_extra_try_arguments 05:16:03 INFO - [mozharness: 2017-06-07 12:16:03.726866Z] Finished download-and-extract step (success) 05:16:03 INFO - [mozharness: 2017-06-07 12:16:03.726964Z] Running populate-webroot step. 05:16:03 INFO - Running pre-action listener: _resource_record_pre_action 05:16:03 INFO - Running main action method: populate_webroot 05:16:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:03 INFO - '--tppagecycles', 05:16:03 INFO - '7'], 05:16:03 INFO - 'tests': ['tsvgm']}}, 05:16:03 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['damp', 'tps']}, 05:16:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'tests': ['damp', 'tps']}, 05:16:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['dromaeo_dom']}, 05:16:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:16:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:16:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:16:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['a11yr', 05:16:03 INFO - 'ts_paint', 05:16:03 INFO - 'tpaint', 05:16:03 INFO - 'sessionrestore', 05:16:03 INFO - 'sessionrestore_no_auto_restore', 05:16:03 INFO - 'tabpaint']}, 05:16:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:03 INFO - 'ts_paint', 05:16:03 INFO - 'tpaint', 05:16:03 INFO - 'sessionrestore', 05:16:03 INFO - 'sessionrestore_no_auto_restore', 05:16:03 INFO - 'tabpaint']}, 05:16:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:03 INFO - 'ts_paint', 05:16:03 INFO - 'tpaint', 05:16:03 INFO - 'sessionrestore', 05:16:03 INFO - 'sessionrestore_no_auto_restore', 05:16:03 INFO - 'tabpaint']}, 05:16:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:03 INFO - 'ts_paint', 05:16:03 INFO - 'tpaint', 05:16:03 INFO - 'sessionrestore', 05:16:03 INFO - 'sessionrestore_no_auto_restore', 05:16:03 INFO - 'tabpaint']}, 05:16:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['a11yr', 05:16:03 INFO - 'ts_paint', 05:16:03 INFO - 'tpaint', 05:16:03 INFO - 'sessionrestore', 05:16:03 INFO - 'sessionrestore_no_auto_restore', 05:16:03 INFO - 'tabpaint']}, 05:16:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['a11yr', 05:16:03 INFO - 'ts_paint', 05:16:03 INFO - 'tpaint', 05:16:03 INFO - 'sessionrestore', 05:16:03 INFO - 'sessionrestore_no_auto_restore', 05:16:03 INFO - 'tabpaint']}, 05:16:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:16:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:16:03 INFO - 'bloom_basic_ref']}, 05:16:03 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 05:16:03 INFO - 'talos_options': ['--mitmproxy', 05:16:03 INFO - 'mitmproxy-recording-1.mp', 05:16:03 INFO - '--firstNonBlankPaint'], 05:16:03 INFO - 'tests': ['Quantum_1']}, 05:16:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['tsvgx', 05:16:03 INFO - 'tsvgr_opacity', 05:16:03 INFO - 'tart', 05:16:03 INFO - 'tscrollx', 05:16:03 INFO - 'cart', 05:16:03 INFO - 'tsvg_static']}, 05:16:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:03 INFO - 'tsvgr_opacity', 05:16:03 INFO - 'tart', 05:16:03 INFO - 'tscrollx', 05:16:03 INFO - 'cart', 05:16:03 INFO - 'tsvg_static']}, 05:16:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'talos_options': ['--disable-e10s'], 05:16:03 INFO - 'tests': ['tp5o']}, 05:16:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:16:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'talos_options': ['--disable-e10s', 05:16:03 INFO - '--xperf_path', 05:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:03 INFO - 'tests': ['tp5n']}, 05:16:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:16:03 INFO - 'talos_options': ['--xperf_path', 05:16:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:03 INFO - 'tests': ['tp5n']}}, 05:16:03 INFO - 'talos.zip': {'path': '', 05:16:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:03 INFO - Running post-action listener: _resource_record_post_action 05:16:03 INFO - [mozharness: 2017-06-07 12:16:03.741288Z] Finished populate-webroot step (success) 05:16:03 INFO - [mozharness: 2017-06-07 12:16:03.741384Z] Running create-virtualenv step. 05:16:03 INFO - Running pre-action listener: _resource_record_pre_action 05:16:03 INFO - Running main action method: create_virtualenv 05:16:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:03 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 05:16:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:16:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:03 INFO - Using real prefix '/usr' 05:16:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:06 INFO - Installing pip.................done. 05:16:06 INFO - Return code: 0 05:16:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:16:06 INFO - Reading from file tmpfile_stdout 05:16:06 INFO - Output received: 05:16:06 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) 05:16:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:06 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')]} 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:06 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')]} 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:06 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:06 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 05:16:06 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 05:16:06 INFO - Using env: {'DISPLAY': ':0', 05:16:06 INFO - 'HOME': '/home/cltbld', 05:16:06 INFO - 'LANG': 'en_US.UTF-8', 05:16:06 INFO - 'LANGUAGE': 'en_US:en', 05:16:06 INFO - 'LOGNAME': 'cltbld', 05:16:06 INFO - 'MAIL': '/var/mail/cltbld', 05:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:06 INFO - 'MOZ_NO_REMOTE': '1', 05:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:06 INFO - 'NO_EM_RESTART': '1', 05:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:06 INFO - 'PWD': '/builds/slave/test', 05:16:06 INFO - 'SHELL': '/bin/bash', 05:16:06 INFO - 'SHLVL': '1', 05:16:06 INFO - 'TERM': 'linux', 05:16:06 INFO - 'TMOUT': '86400', 05:16:06 INFO - 'USER': 'cltbld', 05:16:06 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:06 INFO - '_': '/tools/buildbot/bin/python'} 05:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:06 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 05:16:06 INFO - Cleaning up... 05:16:06 INFO - Return code: 0 05:16:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16:06 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')]} 05:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:06 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')]} 05:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:06 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:06 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 05:16:06 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 05:16:06 INFO - Using env: {'DISPLAY': ':0', 05:16:06 INFO - 'HOME': '/home/cltbld', 05:16:06 INFO - 'LANG': 'en_US.UTF-8', 05:16:06 INFO - 'LANGUAGE': 'en_US:en', 05:16:06 INFO - 'LOGNAME': 'cltbld', 05:16:06 INFO - 'MAIL': '/var/mail/cltbld', 05:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:06 INFO - 'MOZ_NO_REMOTE': '1', 05:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:06 INFO - 'NO_EM_RESTART': '1', 05:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:06 INFO - 'PWD': '/builds/slave/test', 05:16:06 INFO - 'SHELL': '/bin/bash', 05:16:06 INFO - 'SHLVL': '1', 05:16:06 INFO - 'TERM': 'linux', 05:16:06 INFO - 'TMOUT': '86400', 05:16:06 INFO - 'USER': 'cltbld', 05:16:06 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:06 INFO - '_': '/tools/buildbot/bin/python'} 05:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:07 INFO - Downloading/unpacking psutil>=3.1.1 05:16:07 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 05:16:07 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 05:16:07 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 05:16:07 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 05:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:08 INFO - Installing collected packages: psutil 05:16:08 INFO - Running setup.py install for psutil 05:16:08 INFO - building 'psutil._psutil_linux' extension 05:16:08 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 05:16:09 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 05:16:09 INFO - building 'psutil._psutil_posix' extension 05:16:09 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 05:16:09 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 05:16:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:09 INFO - Successfully installed psutil 05:16:09 INFO - Cleaning up... 05:16:09 INFO - Return code: 0 05:16:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:09 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')]} 05:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:09 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')]} 05:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:09 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:09 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 05:16:09 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 05:16:09 INFO - Using env: {'DISPLAY': ':0', 05:16:09 INFO - 'HOME': '/home/cltbld', 05:16:09 INFO - 'LANG': 'en_US.UTF-8', 05:16:09 INFO - 'LANGUAGE': 'en_US:en', 05:16:09 INFO - 'LOGNAME': 'cltbld', 05:16:09 INFO - 'MAIL': '/var/mail/cltbld', 05:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:09 INFO - 'MOZ_NO_REMOTE': '1', 05:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:09 INFO - 'NO_EM_RESTART': '1', 05:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:09 INFO - 'PWD': '/builds/slave/test', 05:16:09 INFO - 'SHELL': '/bin/bash', 05:16:09 INFO - 'SHLVL': '1', 05:16:09 INFO - 'TERM': 'linux', 05:16:09 INFO - 'TMOUT': '86400', 05:16:09 INFO - 'USER': 'cltbld', 05:16:09 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:09 INFO - '_': '/tools/buildbot/bin/python'} 05:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:09 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 05:16:09 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 05:16:09 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 05:16:09 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 05:16:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:11 INFO - Installing collected packages: mozsystemmonitor 05:16:11 INFO - Running setup.py install for mozsystemmonitor 05:16:11 INFO - Successfully installed mozsystemmonitor 05:16:11 INFO - Cleaning up... 05:16:11 INFO - Return code: 0 05:16:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16: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')]} 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:16:11 INFO - Using env: {'DISPLAY': ':0', 05:16:11 INFO - 'HOME': '/home/cltbld', 05:16:11 INFO - 'LANG': 'en_US.UTF-8', 05:16:11 INFO - 'LANGUAGE': 'en_US:en', 05:16:11 INFO - 'LOGNAME': 'cltbld', 05:16:11 INFO - 'MAIL': '/var/mail/cltbld', 05:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:11 INFO - 'MOZ_NO_REMOTE': '1', 05:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:11 INFO - 'NO_EM_RESTART': '1', 05:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:11 INFO - 'PWD': '/builds/slave/test', 05:16:11 INFO - 'SHELL': '/bin/bash', 05:16:11 INFO - 'SHLVL': '1', 05:16:11 INFO - 'TERM': 'linux', 05:16:11 INFO - 'TMOUT': '86400', 05:16:11 INFO - 'USER': 'cltbld', 05:16:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - '_': '/tools/buildbot/bin/python'} 05:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:12 INFO - warning: no files found matching '*.txt' 05:16:12 INFO - no previously-included directories found matching 'build' 05:16:12 INFO - no previously-included directories found matching 'dist' 05:16:12 INFO - no previously-included directories found matching '.git*' 05:16:12 INFO - Installing collected packages: jsonschema, functools32 05:16:12 INFO - Running setup.py install for functools32 05:16:12 INFO - warning: no files found matching '*.txt' 05:16:12 INFO - no previously-included directories found matching 'build' 05:16:12 INFO - no previously-included directories found matching 'dist' 05:16:12 INFO - no previously-included directories found matching '.git*' 05:16:12 INFO - Successfully installed jsonschema functools32 05:16:12 INFO - Cleaning up... 05:16:12 INFO - Return code: 0 05:16:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:16:12 INFO - Using env: {'DISPLAY': ':0', 05:16:12 INFO - 'HOME': '/home/cltbld', 05:16:12 INFO - 'LANG': 'en_US.UTF-8', 05:16:12 INFO - 'LANGUAGE': 'en_US:en', 05:16:12 INFO - 'LOGNAME': 'cltbld', 05:16:12 INFO - 'MAIL': '/var/mail/cltbld', 05:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:12 INFO - 'MOZ_NO_REMOTE': '1', 05:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:12 INFO - 'NO_EM_RESTART': '1', 05:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:12 INFO - 'PWD': '/builds/slave/test', 05:16:12 INFO - 'SHELL': '/bin/bash', 05:16:12 INFO - 'SHLVL': '1', 05:16:12 INFO - 'TERM': 'linux', 05:16:12 INFO - 'TMOUT': '86400', 05:16:12 INFO - 'USER': 'cltbld', 05:16:12 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:12 INFO - '_': '/tools/buildbot/bin/python'} 05:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:13 INFO - Cleaning up... 05:16:13 INFO - Return code: 0 05:16:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:13 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')]} 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:13 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')]} 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:13 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:13 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 05:16:13 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 05:16:13 INFO - Using env: {'DISPLAY': ':0', 05:16:13 INFO - 'HOME': '/home/cltbld', 05:16:13 INFO - 'LANG': 'en_US.UTF-8', 05:16:13 INFO - 'LANGUAGE': 'en_US:en', 05:16:13 INFO - 'LOGNAME': 'cltbld', 05:16:13 INFO - 'MAIL': '/var/mail/cltbld', 05:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:13 INFO - 'MOZ_NO_REMOTE': '1', 05:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:13 INFO - 'NO_EM_RESTART': '1', 05:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:13 INFO - 'PWD': '/builds/slave/test', 05:16:13 INFO - 'SHELL': '/bin/bash', 05:16:13 INFO - 'SHLVL': '1', 05:16:13 INFO - 'TERM': 'linux', 05:16:13 INFO - 'TMOUT': '86400', 05:16:13 INFO - 'USER': 'cltbld', 05:16:13 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:13 INFO - '_': '/tools/buildbot/bin/python'} 05:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:14 INFO - Downloading docopt-0.6.1.tar.gz 05:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:14 INFO - Running setup.py install for blobuploader 05:16:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:15 INFO - Running setup.py install for requests 05:16:15 INFO - Running setup.py install for docopt 05:16:15 INFO - Successfully installed blobuploader requests docopt 05:16:15 INFO - Cleaning up... 05:16:15 INFO - Return code: 0 05:16:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:15 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:15 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 05:16:15 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 05:16:15 INFO - Using env: {'DISPLAY': ':0', 05:16:15 INFO - 'HOME': '/home/cltbld', 05:16:15 INFO - 'LANG': 'en_US.UTF-8', 05:16:15 INFO - 'LANGUAGE': 'en_US:en', 05:16:15 INFO - 'LOGNAME': 'cltbld', 05:16:15 INFO - 'MAIL': '/var/mail/cltbld', 05:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:15 INFO - 'MOZ_NO_REMOTE': '1', 05:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:15 INFO - 'NO_EM_RESTART': '1', 05:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:15 INFO - 'PWD': '/builds/slave/test', 05:16:15 INFO - 'SHELL': '/bin/bash', 05:16:15 INFO - 'SHLVL': '1', 05:16:15 INFO - 'TERM': 'linux', 05:16:15 INFO - 'TMOUT': '86400', 05:16:15 INFO - 'USER': 'cltbld', 05:16:15 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:15 INFO - '_': '/tools/buildbot/bin/python'} 05:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:15 INFO - Running setup.py (path:/tmp/pip-BVxl_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:15 INFO - Running setup.py (path:/tmp/pip-yDCSBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:15 INFO - Running setup.py (path:/tmp/pip-5T5vGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:15 INFO - Running setup.py (path:/tmp/pip-CpnwnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:16 INFO - Running setup.py (path:/tmp/pip-HBMruX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:16 INFO - Running setup.py (path:/tmp/pip-eWZTFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:16 INFO - Running setup.py (path:/tmp/pip-UBecmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:16 INFO - Running setup.py (path:/tmp/pip-YldDDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:16 INFO - Running setup.py (path:/tmp/pip-mq3JhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:16 INFO - Running setup.py (path:/tmp/pip-sT5fv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:16 INFO - Running setup.py (path:/tmp/pip-F5zuqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:16 INFO - Running setup.py (path:/tmp/pip-qs9Ula-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:16 INFO - Running setup.py (path:/tmp/pip-4RgXpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:16 INFO - Running setup.py (path:/tmp/pip-6O_ZP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:16 INFO - Running setup.py (path:/tmp/pip-b0m1gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:16 INFO - Running setup.py (path:/tmp/pip-i4F7pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:16 INFO - Running setup.py (path:/tmp/pip-MeRMTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:16 INFO - Running setup.py install for manifestparser 05:16:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozcrash 05:16:17 INFO - Running setup.py install for mozdebug 05:16:17 INFO - Running setup.py install for mozdevice 05:16:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozfile 05:16:17 INFO - Running setup.py install for mozhttpd 05:16:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozinfo 05:16:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozInstall 05:16:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozleak 05:16:17 INFO - Running setup.py install for mozlog 05:16:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for moznetwork 05:16:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozprocess 05:16:18 INFO - Running setup.py install for mozprofile 05:16:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozrunner 05:16:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Running setup.py install for mozscreenshot 05:16:18 INFO - Running setup.py install for moztest 05:16:18 INFO - Running setup.py install for mozversion 05:16:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:18 INFO - Cleaning up... 05:16:18 INFO - Return code: 0 05:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:18 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')]} 05:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:18 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')]} 05:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:18 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:18 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 05:16:18 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 05:16:18 INFO - Using env: {'DISPLAY': ':0', 05:16:18 INFO - 'HOME': '/home/cltbld', 05:16:18 INFO - 'LANG': 'en_US.UTF-8', 05:16:18 INFO - 'LANGUAGE': 'en_US:en', 05:16:18 INFO - 'LOGNAME': 'cltbld', 05:16:18 INFO - 'MAIL': '/var/mail/cltbld', 05:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:18 INFO - 'MOZ_NO_REMOTE': '1', 05:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:18 INFO - 'NO_EM_RESTART': '1', 05:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:18 INFO - 'PWD': '/builds/slave/test', 05:16:18 INFO - 'SHELL': '/bin/bash', 05:16:18 INFO - 'SHLVL': '1', 05:16:18 INFO - 'TERM': 'linux', 05:16:18 INFO - 'TMOUT': '86400', 05:16:18 INFO - 'USER': 'cltbld', 05:16:18 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:18 INFO - '_': '/tools/buildbot/bin/python'} 05:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:18 INFO - Running setup.py (path:/tmp/pip-LHKfbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:19 INFO - Running setup.py (path:/tmp/pip-_yic21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:19 INFO - Running setup.py (path:/tmp/pip-pQJ_HX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:19 INFO - Running setup.py (path:/tmp/pip-Sg6Pj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:19 INFO - Running setup.py (path:/tmp/pip-ljncP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:19 INFO - Running setup.py (path:/tmp/pip-hlr6Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:19 INFO - Running setup.py (path:/tmp/pip-h4Qajm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:19 INFO - Running setup.py (path:/tmp/pip-tHZsjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:19 INFO - Running setup.py (path:/tmp/pip-d2yMqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:19 INFO - Running setup.py (path:/tmp/pip-qHt5Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:19 INFO - Running setup.py (path:/tmp/pip-sfGr9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:19 INFO - Running setup.py (path:/tmp/pip-Wjcnnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:19 INFO - Running setup.py (path:/tmp/pip-qedrQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:19 INFO - Running setup.py (path:/tmp/pip-iukNAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:19 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)) 05:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:20 INFO - Running setup.py (path:/tmp/pip-W72wUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:20 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)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:20 INFO - Running setup.py (path:/tmp/pip-JN5Emv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:20 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)) 05:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:20 INFO - Running setup.py (path:/tmp/pip-6SmqUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:20 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)) 05:16:20 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)) 05:16:20 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)) 05:16:20 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)) 05:16:20 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)) 05:16:20 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)) 05:16:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:21 INFO - Downloading blessings-1.6.tar.gz 05:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:21 INFO - Installing collected packages: blessings 05:16:21 INFO - Running setup.py install for blessings 05:16:21 INFO - Successfully installed blessings 05:16:21 INFO - Cleaning up... 05:16:21 INFO - Return code: 0 05:16:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:21 INFO - Reading from file tmpfile_stdout 05:16:21 INFO - Current package versions: 05:16:21 INFO - argparse == 1.2.1 05:16:21 INFO - blessings == 1.6 05:16:21 INFO - blobuploader == 1.2.4 05:16:21 INFO - docopt == 0.6.1 05:16:21 INFO - functools32 == 3.2.3-2 05:16:21 INFO - jsonschema == 2.5.1 05:16:21 INFO - manifestparser == 1.1 05:16:21 INFO - mozInstall == 1.12 05:16:21 INFO - mozcrash == 1.0 05:16:21 INFO - mozdebug == 0.1 05:16:21 INFO - mozdevice == 0.51 05:16:21 INFO - mozfile == 1.2 05:16:21 INFO - mozhttpd == 0.7 05:16:21 INFO - mozinfo == 0.10 05:16:21 INFO - mozleak == 0.1 05:16:21 INFO - mozlog == 3.4 05:16:21 INFO - moznetwork == 0.27 05:16:21 INFO - mozprocess == 0.25 05:16:21 INFO - mozprofile == 0.28 05:16:21 INFO - mozrunner == 6.13 05:16:21 INFO - mozscreenshot == 0.1 05:16:21 INFO - mozsystemmonitor == 0.3 05:16:21 INFO - moztest == 0.8 05:16:21 INFO - mozversion == 1.4 05:16:21 INFO - psutil == 3.1.1 05:16:21 INFO - requests == 1.2.3 05:16:21 INFO - wsgiref == 0.1.2 05:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:21 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 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:21 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 05:16:21 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 05:16:21 INFO - Using env: {'DISPLAY': ':0', 05:16:21 INFO - 'HOME': '/home/cltbld', 05:16:21 INFO - 'LANG': 'en_US.UTF-8', 05:16:21 INFO - 'LANGUAGE': 'en_US:en', 05:16:21 INFO - 'LOGNAME': 'cltbld', 05:16:21 INFO - 'MAIL': '/var/mail/cltbld', 05:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:21 INFO - 'MOZ_NO_REMOTE': '1', 05:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:21 INFO - 'NO_EM_RESTART': '1', 05:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:21 INFO - 'PWD': '/builds/slave/test', 05:16:21 INFO - 'SHELL': '/bin/bash', 05:16:21 INFO - 'SHLVL': '1', 05:16:21 INFO - 'TERM': 'linux', 05:16:21 INFO - 'TMOUT': '86400', 05:16:21 INFO - 'USER': 'cltbld', 05:16:21 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:21 INFO - '_': '/tools/buildbot/bin/python'} 05:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:21 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)) 05:16:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:23 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:16:23 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)) 05:16:23 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)) 05:16:23 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)) 05:16:23 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)) 05:16:23 INFO - Installing collected packages: marionette-driver 05:16:23 INFO - Running setup.py install for marionette-driver 05:16:23 INFO - Successfully installed marionette-driver 05:16:23 INFO - Cleaning up... 05:16:23 INFO - Return code: 0 05:16:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe753b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f39a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, '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': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', '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 05:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:16:23 INFO - Using env: {'DISPLAY': ':0', 05:16:23 INFO - 'HOME': '/home/cltbld', 05:16:23 INFO - 'LANG': 'en_US.UTF-8', 05:16:23 INFO - 'LANGUAGE': 'en_US:en', 05:16:23 INFO - 'LOGNAME': 'cltbld', 05:16:23 INFO - 'MAIL': '/var/mail/cltbld', 05:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:23 INFO - 'MOZ_NO_REMOTE': '1', 05:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:23 INFO - 'NO_EM_RESTART': '1', 05:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:23 INFO - 'PWD': '/builds/slave/test', 05:16:23 INFO - 'SHELL': '/bin/bash', 05:16:23 INFO - 'SHLVL': '1', 05:16:23 INFO - 'TERM': 'linux', 05:16:23 INFO - 'TMOUT': '86400', 05:16:23 INFO - 'USER': 'cltbld', 05:16:23 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:23 INFO - '_': '/tools/buildbot/bin/python'} 05:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:23 INFO - Cleaning up... 05:16:23 INFO - Return code: 0 05:16:23 INFO - Running post-action listener: _resource_record_post_action 05:16:23 INFO - Running post-action listener: _start_resource_monitoring 05:16:23 INFO - Starting resource monitoring. 05:16:23 INFO - [mozharness: 2017-06-07 12:16:23.581043Z] Finished create-virtualenv step (success) 05:16:23 INFO - [mozharness: 2017-06-07 12:16:23.581967Z] Running install step. 05:16:23 INFO - Running pre-action listener: _resource_record_pre_action 05:16:23 INFO - Running main action method: install 05:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:23 INFO - Reading from file tmpfile_stdout 05:16:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:23 INFO - Reading from file tmpfile_stdout 05:16:23 INFO - Output received: 05:16:23 INFO - Usage: mozinstall [options] installer 05:16:23 INFO - Options: 05:16:23 INFO - -h, --help show this help message and exit 05:16:23 INFO - -d DEST, --destination=DEST 05:16:23 INFO - Directory to install application into. [default: 05:16:23 INFO - "/builds/slave/test"] 05:16:23 INFO - --app=APP Application being installed. [default: firefox] 05:16:23 INFO - mkdir: /builds/slave/test/build/application 05:16:23 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'] 05:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:16:41 INFO - Reading from file tmpfile_stdout 05:16:41 INFO - Output received: 05:16:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:41 INFO - Running post-action listener: _resource_record_post_action 05:16:41 INFO - [mozharness: 2017-06-07 12:16:41.349943Z] Finished install step (success) 05:16:41 INFO - [mozharness: 2017-06-07 12:16:41.350224Z] Running setup-mitmproxy step. 05:16:41 INFO - Running pre-action listener: _resource_record_pre_action 05:16:41 INFO - Running main action method: setup_mitmproxy 05:16:41 INFO - Skipping: mitmproxy is not required 05:16:41 INFO - Running post-action listener: _resource_record_post_action 05:16:41 INFO - [mozharness: 2017-06-07 12:16:41.351419Z] Finished setup-mitmproxy step (success) 05:16:41 INFO - [mozharness: 2017-06-07 12:16:41.351652Z] Running run-tests step. 05:16:41 INFO - Running pre-action listener: _resource_record_pre_action 05:16:41 INFO - Running main action method: run_tests 05:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:41 INFO - Python 2.7.3 05:16:41 INFO - Return code: 0 05:16:41 INFO - grabbing minidump binary from tooltool 05:16:41 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')]} 05:16:41 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 0x11f1140>, '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 0x11f1a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f1ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:41 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 05:16:41 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 05:16:41 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 05:16:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:41 INFO - Return code: 0 05:16:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:41 INFO - ENV: RUST_BACKTRACE is now 1 05:16:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:41 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/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 05:16:41 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/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 05:16:41 INFO - Using env: {'DISPLAY': ':0', 05:16:41 INFO - 'HOME': '/home/cltbld', 05:16:41 INFO - 'LANG': 'en_US.UTF-8', 05:16:41 INFO - 'LANGUAGE': 'en_US:en', 05:16:41 INFO - 'LOGNAME': 'cltbld', 05:16:41 INFO - 'MAIL': '/var/mail/cltbld', 05:16:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:41 INFO - 'MOZ_NO_REMOTE': '1', 05:16:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:41 INFO - 'NO_EM_RESTART': '1', 05:16:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:41 INFO - 'PWD': '/builds/slave/test', 05:16:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:41 INFO - 'RUST_BACKTRACE': '1', 05:16:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:41 INFO - 'SHELL': '/bin/bash', 05:16:41 INFO - 'SHLVL': '1', 05:16:41 INFO - 'TERM': 'linux', 05:16:41 INFO - 'TMOUT': '86400', 05:16:41 INFO - 'USER': 'cltbld', 05:16:41 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015', 05:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:41 INFO - '_': '/tools/buildbot/bin/python'} 05:16:41 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/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 05:16:41 INFO - mozversion application_buildid: 20170607113307 05:16:41 INFO - mozversion application_changeset: f6320f91851c2cede08b0fb54a6d0525b870310e 05:16:41 INFO - mozversion application_display_name: Nightly 05:16:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:41 INFO - mozversion application_name: Firefox 05:16:41 INFO - mozversion application_remotingname: firefox 05:16:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:41 INFO - mozversion application_vendor: Mozilla 05:16:41 INFO - mozversion application_version: 55.0a1 05:16:41 INFO - mozversion platform_buildid: 20170607113307 05:16:41 INFO - mozversion platform_changeset: f6320f91851c2cede08b0fb54a6d0525b870310e 05:16:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:41 INFO - mozversion platform_version: 55.0a1 05:16:41 INFO - using testdate: 1496837801 05:16:41 INFO - actual date: 1496837801 05:16:41 INFO - starting webserver on 'localhost:51962' 05:16:41 INFO - SUITE-START | Running 2 tests 05:16:41 INFO - TEST-START | dromaeo_css 05:16:41 INFO - operating with platform_type : linux_ 05:16:41 INFO - Initialising browser for dromaeo_css test... 05:16:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51962/getInfo.html -profile /tmp/tmprhR4_z/profile 05:16:41 INFO - TEST-INFO | started process 3372 (/builds/slave/test/build/application/firefox/firefox http://localhost:51962/getInfo.html) 05:17:18 INFO - TEST-INFO | 3372: killed by SIGTERM 05:17:18 INFO - Browser initialized. 05:17:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:18 INFO - TEST-INFO | started process 3606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprhR4_z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:30 INFO - PID 3606 | RSS: Main: 187543552 05:17:30 INFO - PID 3606 | 05:20:31 INFO - PID 3606 | Cycle 1(1): loaded http://localhost:51962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51962/tests/dromaeo/cssquery-ext.html) 05:20:32 INFO - PID 3606 | RSS: Main: 186494976 05:20:32 INFO - PID 3606 | 05:23:34 INFO - PID 3606 | Cycle 1(1): loaded http://localhost:51962/tests/dromaeo/cssquery-ext.html (next: http://localhost:51962/tests/dromaeo/cssquery-jquery.html) 05:23:35 INFO - PID 3606 | RSS: Main: 189599744 05:23:35 INFO - PID 3606 | 05:26:36 INFO - PID 3606 | Cycle 1(1): loaded http://localhost:51962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51962/tests/dromaeo/cssquery-mootools.html) 05:26:37 INFO - PID 3606 | RSS: Main: 189046784 05:26:37 INFO - PID 3606 | 05:29:39 INFO - PID 3606 | Cycle 1(1): loaded http://localhost:51962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51962/tests/dromaeo/cssquery-prototype.html) 05:29:40 INFO - PID 3606 | RSS: Main: 192131072 05:29:40 INFO - PID 3606 | 05:32:42 INFO - PID 3606 | Cycle 1(1): loaded http://localhost:51962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51962/tests/dromaeo/cssquery-yui.html) 05:32:43 INFO - PID 3606 | RSS: Main: 190984192 05:32:43 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | Cycle 1(1): loaded http://localhost:51962/tests/dromaeo/cssquery-yui.html (next: http://localhost:51962/tests/dromaeo/cssquery-dojo.html) 05:35:45 INFO - PID 3606 | RSS: Main: 190926848 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | __start_tp_report 05:35:45 INFO - PID 3606 | _x_x_mozilla_page_load 05:35:45 INFO - PID 3606 | _x_x_mozilla_page_load_details 05:35:45 INFO - PID 3606 | |i|pagename|runs| 05:35:45 INFO - PID 3606 | |0;dojo.html;3062.9693703062976;3066.8466576671167;3073.323868748875;3073.538969154628;3102.8448577571116;5863.76544938203;5923.526117910562;5936.198613187218;5946.643201407918;5995.100734889768;5860.560457965659;5954.642721436717;5974.55190860685;5987;6105.511559075275;5447.101228297326;5538.529225015878;5565.469495888622;5593.636413633121;5630.493255606994;5654.547636189095;5683.801066962657;5686.3744988051285;5690.089585666295;5695.45893140151;5348.5186333230195;5438.374586922476;5498.340199176085;5530.5022547970675;5539;5574.1917421973585;5584.5253153482;5603.187537807036;5608.5793565482345;5633.32400111985;5542.806001789958;5544.1960915667405;5576;5581.916271255935;5586.441355864381;5932.406759324076;6023.066424704134;6032.788852390146;6050.878982420327;6071.483923866476;6403.679816009228;6449.742010319582;6510.93489065108;6518.608883467007;6555.410013098844;6539.901901471481;6542;6546.770863019771;6548.607083575001;6551.410373066399;6055.6063855849225;6066.241719785027;6084.756609735649;6094.841980023782;6101.054336577793;6520.413162815369;6561.1470508833545;6604.438622717027;6628.96685516579;6657.234418041987;6179.814605561751;6249.500039996789;6277.52918531112;6278.843028924313;6291.622502649856;6417.454516366068;6496.545241833026;6508.707108180143;6528.21661400635;6534.575252608565;6501.187351581052;6510.023496475472;6514.218293804774;6519.967400162969;6522.804315870531;6274.403931626488;6363.9045414318825;6413.326600706859;6517.4460170886005;6535.901961470582;5242.370915490089;5249.42256351801;5256.684598924076;5258.39528454225;5275.393329767049;4492.685512014193;4493.618042466362;4497.527759585262;4504.81980720774;4538.1831270370985;5560.749766260528;5625.493705566519;5634.352049514277;5694.174344719992;5746.396628354046;6573.408393244631;6575.44108750752;6576.76981305652;6582.572132811352;6594;5661.858453538612;5710.200571919934;5722.685252311079;5734.799282025109;5772.913406298909;5567.777288908398;5711.942880571141;5716.885662286731;5719.971400143056;5729.1119876419225;6212.844678882973;6217.782377616762;6324.114623952651;6336;6339.270983836734;6490.643014634241;6495;6498.090267362668;6498.545101842826;6504.38208370204;6184.969075154595;6234;6234.314225435108;6236.376362363727;6240;6158;6221.813345599639;6294.8111556653375;6375.458086062737;6379.106925030592;6427.453666438405;6428.6785660717715;6430.967845160744;6437.710303036468;6445.16212892321;6151;6225.844353891189;6243.250809902841;6255.53083518747;6267.811965641038;6224.9377506224355;6245.406686364788;6320.209973753281;6326.2092238470195;6340.080688300079;6198.380161983766;6238.095476155841;6279.1209230708655;6300.905486417616;6303.1175635412;6234.251889773256;6405.231372235362;6417.711202995783;6422.9036564450635;6442.516811239082;6041.305249896318;6110.480609148272;6117.84705382369;6125.081237814185;6129.295131059986 05:35:45 INFO - PID 3606 | |1;ext.html;725.8258018075663;781.8319061401799;802.3701394405391;1142.069213590924;1144.8797876223002;36759.08102297444;38368.424473632884;38436.42345364822;38442.807785961064;38496.42255366165;40240.798796005976;40865.18269634613;40869.38695919564;40874.38688419668;40920;7194.7122115115335;7422.072240969879;7426.368758655521;7538.208488108725;7580.999999999973;7390.778276651709;7453.291937265951;7464.701411943516;7472.738454154106;7491.962540187292;7463.477556571042;7516.173220945691;7527.849443011164;7540.698372065111;7566.470347075707;7424.517406368623;7431.219721929174;7439.776806695835;7477.887831682529;7490.6629201686055;7366.889496657554;7418.295261950106;7426.480146389755;7433.814154646123;7450.441216908754;36719.81640091782;36868.446973295424;36929.630703692885;36971.630283697086;37169.44245836315;3528.7177025837873;3551.058969373118;3574.392353299945;3575.66031227033;3587.7309201809967;28117.57823632647;28193;28204.717952820414;28263;28278.15165545037;3518.48981897626;3549.0240183949363;3559.715222782171;3565.3404120237838;3568.9107772305642;137735.31132344273;140243;154342.22828885785;167919;168782;44780.55219447829;44940.77529612331;44969.55030449719;45040;45101.323480147825;47612.28581571279;47746.5225347749;47761.5223847764;47843.521564784605;47944.28083578749;15175.696486070217;15263.542093737206;15271.312790924436;15312.081275123528;15328.923355383375;12402.19385739924;12426.068044896669;12452.439640216213;12456.501739930483;12502.437390317276;14099.78850317246;14269.78595321071;14271.714565708628;14286.85713142876;14475.855241447662;5733.971330143323;5770.682612456271;5807.738651760681;5872.911906321323;5931.559695376671;1010.5654568535454;1020.168562621476;1024.90263424976;1030.4126647810826;1040.5109598488698;22695;26938.86530567374;29825.552616710767;30006.549901751056;30337;1062.389126252408;1074.4788777442934;1103.8178700514325;1119.3004372267333;1122.4780477078034;12484.87515124837;13441.932790335986;13492.460301587827;13499.122557033761;13606.727865442635;207405;209084;209263;209622;209664;46337.30494042592;46862.5313746865;47210.763946180734;47213;47227;1418.4822539773115;1439.0789894467548;1454.8836093112525;1464.1581090872792;1485.717713634406;22497.88751056234;23241.535169296858;23708.88145559261;23972.40068998219;24166;37265.25469490649;37523.06192345104;37671.246575067795;37718;37725.62274377221;182965;183764;183901;184999;185025;34207.315853683285;34703.65296347004;35275.29449411049;35425.645743542234;35467;41346.79326603348;42112.789436052626;43070;43253.56746432495;43269.78365108154;30566.235844104074;30672.386552269276;31179.376412472076;31327.37345253128;32709;30603.387932240785;31429.8428507856;31486.212844679067;32380;32904;34088;35348.82325588356;35533.466997995565;35769.1057723559;35856;30531.847340763154;31454.37091258208;31955.520667189547;32240.19399515031;33473.330533389686;24859.378515537257;25103.497930040932;25226.117085901904;25678.871605641853;25727.871360643076 05:35:45 INFO - PID 3606 | |2;jquery.html;406.8372650939624;416.0721590852401;421.2859203649814;424.54573606241325;436.5459921681451;14753;15463.84536154638;20411.897940510295;21005.159793608258;21010.264640737576;22119.778802211975;22833.429164270903;23010.539789204206;23071;23110.422239444022;5888.882222355551;6085.300190478108;6088.086786981966;6099.268087829467;6102.847428814271;5979.431953964367;6062.120992456091;6079.270487541501;6085.634861908277;6085.665288409135;5980.611260268069;6012.609180403259;6372.171617689693;6653;6714.328567143295;6626.5030122740745;6658.76694315699;6671.066050752898;6676.732930682767;6685.465162786965;6531.542792004561;6543.541952063358;6546.247181574132;6558.2458017328145;6567.638779867106;26899;27015.86492067527;27619.585706214424;27631.861840690868;27754.722452775415;1938.9709154362695;1976.3082920977686;1993.132987150594;1997.3808119483008;2000.1399398258743;18092.095395230317;18622.25510979559;18631.720524192147;18655.90672046631;18656.16047277862;2206.6359050756764;2259.5651761131635;2262.1403866530613;2269.6368581026954;2375.9287221383215;117354;118540.40729796381;120288.39855800752;121565;121728;18749.437516874517;19261.422157335302;20021;20860.478488037617;21083.15377424059;38305;38515.807420962716;38536;38544.42183367252;38628.420573691415;10690.41202733857;10690.893091069145;10826.18803589734;10996.560137594566;11052.336859788438;7455.515391499644;7879.487833290817;8876.156765107304;9034.774130646787;9056.366054376262;7346.33882950537;9780;10292;10751.237067026634;10934.289271197347;2095.549456866781;2100.779418161071;2167.7181966344588;2170.869747815136;2204.867707937529;958.6740508227097;966.429806414219;967.8016006718606;1011.3881101933224;1014.1555071521773;18528.907355463405;19081.809181908004;19547.315843945395;19727.901360493106;19868.70196947047;1002.1381611813835;1020.5203554329453;1037.7768779712399;1041;1049.3074570783247;9800.65697700577;10469.267151299337;10535.209859260585;10737.826388507707;10966.342019478856;438217;446618;449479;450970;451749;98543.50728246314;99796.5010174959;100472;100579.49710251403;100775;1171.2796630072614;1188.7622475504934;1196.6350263169816;1200.2318516149671;1202.7353982123918;16409.67180656404;16437.342506300094;16631.168441578116;17106.230219640394;17212.74180887313;48888.2666760006;49424;49672;50485.242721359944;51003.74498127485;61154.69422652858;61223.38776612177;61728.69135654293;61887.381126188164;61899.69050154721;10015.899841001497;10233.43716095592;10249.077583017564;10307.536160872929;10312.690619281133;12141.453634586289;12787.74424511486;17009.659806803546;17641.647167056843;17729.11354432299;13569.86430135686;13919.956003299996;13929.651758705708;13954.09298395601;13963.93018034944;12429.813552796535;12890.871091288967;12908.548200812926;13155.934220328838;13162.60512184636;14572.781408279096;15347.232638367814;15474.84525154734;15481;15490.612734681272;10165.72928383952;10271.332363396356;10343.741406464898;10354.17166626653;10406.635767748396;14745;14814.25928703539;14881.925590371979;14900.850991489946;14999.700006000037 05:35:45 INFO - PID 3606 | |3;mootools.html;1284.813702013208;1342.610642913555;1346.4816045822356;1353.2692346133088;1365.6858922447836;10652.201084918643;10678.946605266972;11008.449577521133;11163.051140653044;11176.664700059002;10917.890821091807;11112.277701949388;11114.944425277863;11116.444177791098;11133.777324453506;2333.8249631277636;2376.8455050421753;2378.1319818266293;2379.821513386503;2382.118616112041;2277.464795772992;2355.8927304167014;2356.163561935514;2369.7511761265077;2381.38084098134;2337.9883100584475;2354.2584086012853;2381.714194296687;2382.5354055959097;2390.0678735293163;2255.909763609454;2279.042802023146;2281.646344816556;2283.6003699352545;2292.1519037955895;2211.226070875197;2232.441889527618;2237.060434617448;2237.55248950209;2243.876586787726;10767.676969690843;10970.670879873616;11043.392613406259;11053.944730276378;11057.944710276397;6054.485368743618;6205.782797602107;6264.5301602380005;6266.4360207581085;6275.399773057887;3523.6300188480095;3626.3653860574295;3654.6162652921325;3663.6153203913736;3665.065408320888;1237.975240495185;1274.7004453953314;1299.6555912683148;1307.274462673216;1307.8169056332122;14509.201993890438;15066.472673456376;15783;15917.681646367007;15963.84036159635;5027.547520723079;5153.123968925292;5244.003639308519;5269.578433725293;5289.735513224324;12002.879971200351;12026.218295810744;12069.215500992408;12082.516699331929;12108.334041627619;6016.789412370546;6159.84600384985;6185.876282474325;6221.968890155611;6222;5593.692346920877;5763.567732420001;5763.625364351304;5788.131780232999;5818.185454036438;4109.155221219065;4170.812313445902;4185.476815398075;4191.622753952098;4237.427947227146;1171.1333613126226;1174.900133488646;1184.6386852010048;1187.0681515010674;1198.5026214121042;780.9687612495436;802.3380710913519;806.4838503357855;811.3387589114852;825.7110011496048;6279.586895290859;6350.682465876687;6399.488040956712;6568.1789776277965;6710.966445167743;913.9451632902047;958.3998888811651;963.4604621412032;974.3666616699061;984.4487087231173;3594.928101438009;3642.763220390666;3737.32728108943;3783.39465685489;4512.503624601291;13542.25517596522;14059.156450612996;14171.85828141726;14226.217558034408;14243.64390890236;13781.586552403443;13876.306184690726;13891.235982021086;14042.929785351007;14062.648433789032;8214.4660597061;8311.875321870177;8421.873671894926;8440.662373505114;8466.534340611326;5813;6434.967825160844;6548.8035358939305;6569;6768.932310676831;11690.47392867306;11813.291202527877;11850.170488065753;11898.22661526998;12613.810792838298;12777.55278565283;12780.872191277967;12792.552260670831;12830.101892867782;12915.741685166431;8218.917810821815;8237.711680091168;8399.496030238206;8407.789805254673;8411.83176336482;9732.221422286058;9745.951270243604;9840.507974601098;9846.753831154278;9850.802983940424;8748.69379571712;8763.167499087576;8905.154010369004;8914.86627700598;8943.552822358726;8403.70587029451;8454.619542120496;8480.91519084826;8669.479831210148;8805.779855503664;7392.371648409945;7412.851742965003;7415.888761668687;7435.070616172979;7436.330730234305;5600.04625748079;5883.235179426818;5914.733836977261;5926.377730338252;6020;5793.594448388572;5811.389804070681;5833.649981001154;5983.9401605983385;6050.364711705208 05:35:45 INFO - PID 3606 | |4;prototype.html;391.2331829613957;396.82936337374935;398.94414781930556;401.15756910487977;402.3200790663779;6131.3868613138775;6233.189685340905;6267.686615669221;6290.18227630408;6340.904886426707;5999.160117583542;6131.785387511438;6134;6142.8464288392815;6162;4658.90682186356;4804.543568361;4809.134355815961;4811.7594120294025;4816.157172494817;4802.9039419211595;4810.542998415145;4810.63920205986;4819.759012049383;4836.492168322328;4730.97634511827;4754.78603462845;4776.546228108324;4790.712557246577;4791.137595232856;4774.427068751737;4782.545658162469;4786.425628924517;4788.162071637449;4792.353032340659;4164.60436258558;4172.70791044627;4174.958250417518;4178.22702799983;4179.665626749883;6057.848553786146;6061.575689701723;6069.696515174268;6088.4215999479975;6106.267247930276;5441.020616289066;5451.291332126838;5461.508464238238;5479.479449452296;5487.176923461513;6586.209654841402;6589.868202635968;6592.17597800275;6598.637074960875;6610.867782644368;4579.809249595096;4580.5190455002075;4587.197240482902;4591.058832939273;4597.793099310539;6549.836254093638;6932.23745388007;6997.965010174968;7010.509264351497;7014.719411223545;4629.51390104041;4636.281376386665;4657.906841863211;4665.230237010923;4674.368960190399;4705.411823522059;4721.126591580569;4724.976375118103;4729.55069268419;4732.597729193058;5301.946980530145;5451.536619387317;5468.589855760833;5471.863203419946;5482.4101010707245;6602.966985165043;6609.801705948829;6612.933870661328;6621;6631.33686631333;1625.3986025170761;1639.5901024743814;1639.9344026239055;1640.967180656404;1647.8846480746472;1045.3675526306627;1073.592035026685;1095.1950316517352;1102.8400881872083;1107.6732363952653;5818.7672493100645;5838.985549985248;5859.531237501075;5877.4122587740885;5906.8818623627285;6745.3591908768585;6850.4862135340045;6871.385224472245;6880.65596720172;6881.931180688129;5821.27234095738;5842.328132264759;5855.795047173328;5866.794662186803;5872.207252021008;3585.995921142084;3643.3441980443245;3655.451682247684;3655.7989310588173;3657.012606596204;6463.676816159267;6595;6605.174353205849;6613.140291762136;6627.668616569153;6937.791866244021;6953;6979.7195318200365;7027.929720702829;7041.929580704127;6526.5105117117355;6559.7376104955265;6632.204135503771;6660.167479065117;6665.700043498055;6784.76253331131;6789.898151527632;6798.660066996532;6823.454123669995;6851.417629501549;6758.797236082925;6762.594244345355;6766.526343156129;6767.560108592926;6767.763128290486;6205.81382558524;6505.479561635152;6572.737090516517;6626.204855417381;6653.567518111307;4612.723236605814;4665.6967297125575;4667.8599642010795;4685.344051832678;4689.273162659793;6665.866682666417;6865.862682746417;6871.175458944958;6900.413464855343;6906.447484201151;6636;6667.366600172976;6670.39966403026;6681.164854393201;6696.7656132035145;6686.06395104676;6686.3313668632745;6692.564983276072;6710.765123220664;6715.086200433048;6512.934870651233;6545.869082618226;6565.835854103495;6570.704318305592;6572.333643113443;6573.276939536551;6666.166729158856;6675.766348177791;6691.464682825265;6714.362135597111;6450.516211284079;6466.676666166579;6482.967585162044;6493.7727179550375;6510.804675859732 05:35:45 INFO - PID 3606 | |5;yui.html;786.9842603147937;789.7117552093488;814.8876783190942;848.2196379331015;869.578254546545;14213;14758.040727352714;16370.099644519547;16611.91694041531;16789.1605419729;16731.16344182792;17706.557336066606;17825.46523604294;17837.91081044593;17885.28458861644;978.7699890525721;997.5311603546321;1000.7648202672366;1002.6691191906654;1002.7392877851738;909.6315992023241;1003.658756022952;1010.1867996263042;1010.3887148275298;1013.4375421640987;1049.5696764326628;1064;1064.5688496159069;1065.9680209593726;1066.5200659703125;1057.2863317260894;1057.7514284143258;1058.5554067291716;1060.8514807926858;1061.3790932304612;779.2324560308092;779.3609240422855;780.4068907630242;782.1005843280217;783.4241832253289;17461.126943652765;17558.648827023517;17910.820891791045;18188.27246910122;18202.362917297964;17612.559686007953;17703.822961770347;17925.551861203443;17930.820691793044;17943.641127177383;14609.342579583945;15197.164155971417;15207.163606001775;15220.619484512865;15270.31283592241;3416.4192087344964;3420.7776494527775;3431.7769344992494;3434.690877821008;3437.8281085945605;96319.51840240824;96650;96760;96844;99189;15001.399944002118;15169.924150379178;15286;15325.386984520494;15420.92289538545;26944.865275673495;27341.316467088083;27374.726252737615;27619.723802762117;27660.308492287855;7309.671064801991;7681;7762.7671169865;7802.414818888606;7934.880976785353;3585.46218067292;3637.94543081854;3639.94540081899;3661.103029757673;3663.5970043295215;4278.657707383401;4393.604575588212;4402.603765661106;4406.735595864195;4424.070945101565;844.1811442900377;847.3433089355675;863.4085651328734;864.2912811494514;867.128535821508;649.8310439285725;665.490899461912;666.9266380698119;673.5487223560128;687.4706476013441;11288.153388495895;11780.410979450993;12594.685132871751;12730.618081457571;12775.233485990684;680.3604611665019;692.4045321023915;697.6093387702801;701.8771714949863;710.2435905760349;5065.746712664352;5075.264086707407;5086.264844275197;5165.251038599382;5300.178472336794;79842;81878.18121818824;82436;84243.15756842353;84246;71466.28533714596;72252;72486.63756681183;73418;73756.63121684357;63204;63445.04832427517;65522.67238663872;65588;66840.33159668438;10567.841482377924;11238.269512481662;11743.76512469763;11784.823227651763;11801.881981180422;28517.287067823472;28519.28701782472;28770.85614571914;29203.269918252212;29780.106596802132;36577.71977980758;36714.44928326024;36889.63110368862;37726.245475090895;37956;16622.50132496027;16727.163641818104;16974.49076527706;17165.65668686644;17363.2186551608;16862.494125176265;18083;18805.529861753566;19640.41078767582;19898.104585293986;16145.434909778101;16228.51314460568;16657.83342166563;17811.10944452746;18173.18220680099;16363.836361636231;17034.914825425793;17752;17948.82051179524;18059.54851128732;17244;17415.129243537518;17581.736273956158;17712.91143544274;17948.461546153638;11351.602693905674;12392.938035309766;12562.497500100259;12987.480500779862;13004.674883127618;12953.611391658265;12974.610761677164;13327.200367977952;13596.59210223695;13722.725545489235 05:35:45 INFO - PID 3606 | __end_tp_report 05:35:45 INFO - PID 3606 | __start_cc_report 05:35:45 INFO - PID 3606 | _x_x_mozilla_cycle_collect,362 05:35:45 INFO - PID 3606 | __end_cc_report 05:35:45 INFO - PID 3606 | __startTimestamp1496838945617__endTimestamp 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | ------- Summary: start ------- 05:35:45 INFO - PID 3606 | Number of tests: 6 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | [#0] dojo.html Cycles:165 Average:5960.14 Median:6179.81 stddev:689.34 (11.2%) stddev-sans-first:652.91 05:35:45 INFO - PID 3606 | Values: 3063.0 3066.8 3073.3 3073.5 3102.8 5863.8 5923.5 5936.2 5946.6 5995.1 5860.6 5954.6 5974.6 5987.0 6105.5 5447.1 5538.5 5565.5 5593.6 5630.5 5654.5 5683.8 5686.4 5690.1 5695.5 5348.5 5438.4 5498.3 5530.5 5539.0 5574.2 5584.5 5603.2 5608.6 5633.3 5542.8 5544.2 5576.0 5581.9 5586.4 5932.4 6023.1 6032.8 6050.9 6071.5 6403.7 6449.7 6510.9 6518.6 6555.4 6539.9 6542.0 6546.8 6548.6 6551.4 6055.6 6066.2 6084.8 6094.8 6101.1 6520.4 6561.1 6604.4 6629.0 6657.2 6179.8 6249.5 6277.5 6278.8 6291.6 6417.5 6496.5 6508.7 6528.2 6534.6 6501.2 6510.0 6514.2 6520.0 6522.8 6274.4 6363.9 6413.3 6517.4 6535.9 5242.4 5249.4 5256.7 5258.4 5275.4 4492.7 4493.6 4497.5 4504.8 4538.2 5560.7 5625.5 5634.4 5694.2 5746.4 6573.4 6575.4 6576.8 6582.6 6594.0 5661.9 5710.2 5722.7 5734.8 5772.9 5567.8 5711.9 5716.9 5720.0 5729.1 6212.8 6217.8 6324.1 6336.0 6339.3 6490.6 6495.0 6498.1 6498.5 6504.4 6185.0 6234.0 6234.3 6236.4 6240.0 6158.0 6221.8 6294.8 6375.5 6379.1 6427.5 6428.7 6431.0 6437.7 6445.2 6151.0 6225.8 6243.3 6255.5 6267.8 6224.9 6245.4 6320.2 6326.2 6340.1 6198.4 6238.1 6279.1 6300.9 6303.1 6234.3 6405.2 6417.7 6422.9 6442.5 6041.3 6110.5 6117.8 6125.1 6129.3 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | [#1] ext.html Cycles:180 Average:35082.87 Median:19396.89 stddev:47479.14 (244.8%) stddev-sans-first:47542.24 05:35:45 INFO - PID 3606 | Values: 725.8 781.8 802.4 1142.1 1144.9 36759.1 38368.4 38436.4 38442.8 38496.4 40240.8 40865.2 40869.4 40874.4 40920.0 7194.7 7422.1 7426.4 7538.2 7581.0 7390.8 7453.3 7464.7 7472.7 7492.0 7463.5 7516.2 7527.8 7540.7 7566.5 7424.5 7431.2 7439.8 7477.9 7490.7 7366.9 7418.3 7426.5 7433.8 7450.4 36719.8 36868.4 36929.6 36971.6 37169.4 3528.7 3551.1 3574.4 3575.7 3587.7 28117.6 28193.0 28204.7 28263.0 28278.2 3518.5 3549.0 3559.7 3565.3 3568.9 137735.3 140243.0 154342.2 167919.0 168782.0 44780.6 44940.8 44969.6 45040.0 45101.3 47612.3 47746.5 47761.5 47843.5 47944.3 15175.7 15263.5 15271.3 15312.1 15328.9 12402.2 12426.1 12452.4 12456.5 12502.4 14099.8 14269.8 14271.7 14286.9 14475.9 5734.0 5770.7 5807.7 5872.9 5931.6 1010.6 1020.2 1024.9 1030.4 1040.5 22695.0 26938.9 29825.6 30006.5 30337.0 1062.4 1074.5 1103.8 1119.3 1122.5 12484.9 13441.9 13492.5 13499.1 13606.7 207405.0 209084.0 209263.0 209622.0 209664.0 46337.3 46862.5 47210.8 47213.0 47227.0 1418.5 1439.1 1454.9 1464.2 1485.7 22497.9 23241.5 23708.9 23972.4 24166.0 37265.3 37523.1 37671.2 37718.0 37725.6 182965.0 183764.0 183901.0 184999.0 185025.0 34207.3 34703.7 35275.3 35425.6 35467.0 41346.8 42112.8 43070.0 43253.6 43269.8 30566.2 30672.4 31179.4 31327.4 32709.0 30603.4 31429.8 31486.2 32380.0 32904.0 34088.0 35348.8 35533.5 35769.1 35856.0 30531.8 31454.4 31955.5 32240.2 33473.3 24859.4 25103.5 25226.1 25678.9 25727.9 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | [#2] jquery.html Cycles:180 Average:31526.18 Median:11010.57 stddev:75018.60 (681.3%) stddev-sans-first:75192.66 05:35:45 INFO - PID 3606 | Values: 406.8 416.1 421.3 424.5 436.5 14753.0 15463.8 20411.9 21005.2 21010.3 22119.8 22833.4 23010.5 23071.0 23110.4 5888.9 6085.3 6088.1 6099.3 6102.8 5979.4 6062.1 6079.3 6085.6 6085.7 5980.6 6012.6 6372.2 6653.0 6714.3 6626.5 6658.8 6671.1 6676.7 6685.5 6531.5 6543.5 6546.2 6558.2 6567.6 26899.0 27015.9 27619.6 27631.9 27754.7 1939.0 1976.3 1993.1 1997.4 2000.1 18092.1 18622.3 18631.7 18655.9 18656.2 2206.6 2259.6 2262.1 2269.6 2375.9 117354.0 118540.4 120288.4 121565.0 121728.0 18749.4 19261.4 20021.0 20860.5 21083.2 38305.0 38515.8 38536.0 38544.4 38628.4 10690.4 10690.9 10826.2 10996.6 11052.3 7455.5 7879.5 8876.2 9034.8 9056.4 7346.3 9780.0 10292.0 10751.2 10934.3 2095.5 2100.8 2167.7 2170.9 2204.9 958.7 966.4 967.8 1011.4 1014.2 18528.9 19081.8 19547.3 19727.9 19868.7 1002.1 1020.5 1037.8 1041.0 1049.3 9800.7 10469.3 10535.2 10737.8 10966.3 438217.0 446618.0 449479.0 450970.0 451749.0 98543.5 99796.5 100472.0 100579.5 100775.0 1171.3 1188.8 1196.6 1200.2 1202.7 16409.7 16437.3 16631.2 17106.2 17212.7 48888.3 49424.0 49672.0 50485.2 51003.7 61154.7 61223.4 61728.7 61887.4 61899.7 10015.9 10233.4 10249.1 10307.5 10312.7 12141.5 12787.7 17009.7 17641.6 17729.1 13569.9 13920.0 13929.7 13954.1 13963.9 12429.8 12890.9 12908.5 13155.9 13162.6 14572.8 15347.2 15474.8 15481.0 15490.6 10165.7 10271.3 10343.7 10354.2 10406.6 14745.0 14814.3 14881.9 14900.9 14999.7 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | [#3] mootools.html Cycles:180 Average:6706.01 Median:3664.34 stddev:4221.85 (115.2%) stddev-sans-first:4214.04 05:35:45 INFO - PID 3606 | Values: 1284.8 1342.6 1346.5 1353.3 1365.7 10652.2 10678.9 11008.4 11163.1 11176.7 10917.9 11112.3 11114.9 11116.4 11133.8 2333.8 2376.8 2378.1 2379.8 2382.1 2277.5 2355.9 2356.2 2369.8 2381.4 2338.0 2354.3 2381.7 2382.5 2390.1 2255.9 2279.0 2281.6 2283.6 2292.2 2211.2 2232.4 2237.1 2237.6 2243.9 10767.7 10970.7 11043.4 11053.9 11057.9 6054.5 6205.8 6264.5 6266.4 6275.4 3523.6 3626.4 3654.6 3663.6 3665.1 1238.0 1274.7 1299.7 1307.3 1307.8 14509.2 15066.5 15783.0 15917.7 15963.8 5027.5 5153.1 5244.0 5269.6 5289.7 12002.9 12026.2 12069.2 12082.5 12108.3 6016.8 6159.8 6185.9 6222.0 6222.0 5593.7 5763.6 5763.6 5788.1 5818.2 4109.2 4170.8 4185.5 4191.6 4237.4 1171.1 1174.9 1184.6 1187.1 1198.5 781.0 802.3 806.5 811.3 825.7 6279.6 6350.7 6399.5 6568.2 6711.0 913.9 958.4 963.5 974.4 984.4 3594.9 3642.8 3737.3 3783.4 4512.5 13542.3 14059.2 14171.9 14226.2 14243.6 13781.6 13876.3 13891.2 14042.9 14062.6 8214.5 8311.9 8421.9 8440.7 8466.5 5813.0 6435.0 6548.8 6569.0 6768.9 11690.5 11813.3 11850.2 11898.2 12613.8 12777.6 12780.9 12792.6 12830.1 12915.7 8218.9 8237.7 8399.5 8407.8 8411.8 9732.2 9746.0 9840.5 9846.8 9850.8 8748.7 8763.2 8905.2 8914.9 8943.6 8403.7 8454.6 8480.9 8669.5 8805.8 7392.4 7412.9 7415.9 7435.1 7436.3 5600.0 5883.2 5914.7 5926.4 6020.0 5793.6 5811.4 5833.6 5983.9 6050.4 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | [#4] prototype.html Cycles:180 Average:5469.42 Median:6118.83 stddev:1631.97 (26.7%) stddev-sans-first:1591.42 05:35:45 INFO - PID 3606 | Values: 391.2 396.8 398.9 401.2 402.3 6131.4 6233.2 6267.7 6290.2 6340.9 5999.2 6131.8 6134.0 6142.8 6162.0 4658.9 4804.5 4809.1 4811.8 4816.2 4802.9 4810.5 4810.6 4819.8 4836.5 4731.0 4754.8 4776.5 4790.7 4791.1 4774.4 4782.5 4786.4 4788.2 4792.4 4164.6 4172.7 4175.0 4178.2 4179.7 6057.8 6061.6 6069.7 6088.4 6106.3 5441.0 5451.3 5461.5 5479.5 5487.2 6586.2 6589.9 6592.2 6598.6 6610.9 4579.8 4580.5 4587.2 4591.1 4597.8 6549.8 6932.2 6998.0 7010.5 7014.7 4629.5 4636.3 4657.9 4665.2 4674.4 4705.4 4721.1 4725.0 4729.6 4732.6 5301.9 5451.5 5468.6 5471.9 5482.4 6603.0 6609.8 6612.9 6621.0 6631.3 1625.4 1639.6 1639.9 1641.0 1647.9 1045.4 1073.6 1095.2 1102.8 1107.7 5818.8 5839.0 5859.5 5877.4 5906.9 6745.4 6850.5 6871.4 6880.7 6881.9 5821.3 5842.3 5855.8 5866.8 5872.2 3586.0 3643.3 3655.5 3655.8 3657.0 6463.7 6595.0 6605.2 6613.1 6627.7 6937.8 6953.0 6979.7 7027.9 7041.9 6526.5 6559.7 6632.2 6660.2 6665.7 6784.8 6789.9 6798.7 6823.5 6851.4 6758.8 6762.6 6766.5 6767.6 6767.8 6205.8 6505.5 6572.7 6626.2 6653.6 4612.7 4665.7 4667.9 4685.3 4689.3 6665.9 6865.9 6871.2 6900.4 6906.4 6636.0 6667.4 6670.4 6681.2 6696.8 6686.1 6686.3 6692.6 6710.8 6715.1 6512.9 6545.9 6565.8 6570.7 6572.3 6573.3 6666.2 6675.8 6691.5 6714.4 6450.5 6466.7 6483.0 6493.8 6510.8 05:35:45 INFO - PID 3606 | 05:35:45 INFO - PID 3606 | [#5] yui.html Cycles:180 Average:18874.10 Median:19769.26 stddev:23545.41 (119.1%) stddev-sans-first:23572.29 05:35:45 INFO - PID 3606 | Values: 787.0 789.7 814.9 848.2 869.6 14213.0 14758.0 16370.1 16611.9 16789.2 16731.2 17706.6 17825.5 17837.9 17885.3 978.8 997.5 1000.8 1002.7 1002.7 909.6 1003.7 1010.2 1010.4 1013.4 1049.6 1064.0 1064.6 1066.0 1066.5 1057.3 1057.8 1058.6 1060.9 1061.4 779.2 779.4 780.4 782.1 783.4 17461.1 17558.6 17910.8 18188.3 18202.4 17612.6 17703.8 17925.6 17930.8 17943.6 14609.3 15197.2 15207.2 15220.6 15270.3 3416.4 3420.8 3431.8 3434.7 3437.8 96319.5 96650.0 96760.0 96844.0 99189.0 15001.4 15169.9 15286.0 15325.4 15420.9 26944.9 27341.3 27374.7 27619.7 27660.3 7309.7 7681.0 7762.8 7802.4 7934.9 3585.5 3637.9 3639.9 3661.1 3663.6 4278.7 4393.6 4402.6 4406.7 4424.1 844.2 847.3 863.4 864.3 867.1 649.8 665.5 666.9 673.5 687.5 11288.2 11780.4 12594.7 12730.6 12775.2 680.4 692.4 697.6 701.9 710.2 5065.7 5075.3 5086.3 5165.3 5300.2 79842.0 81878.2 82436.0 84243.2 84246.0 71466.3 72252.0 72486.6 73418.0 73756.6 63204.0 63445.0 65522.7 65588.0 66840.3 10567.8 11238.3 11743.8 11784.8 11801.9 28517.3 28519.3 28770.9 29203.3 29780.1 36577.7 36714.4 36889.6 37726.2 37956.0 16622.5 16727.2 16974.5 17165.7 17363.2 16862.5 18083.0 18805.5 19640.4 19898.1 16145.4 16228.5 16657.8 17811.1 18173.2 16363.8 17034.9 17752.0 17948.8 18059.5 17244.0 17415.1 17581.7 17712.9 17948.5 11351.6 12392.9 12562.5 12987.5 13004.7 12953.6 12974.6 13327.2 13596.6 13722.7 05:35:45 INFO - PID 3606 | -------- Summary: end -------- 05:35:45 INFO - PID 3606 | 05:35:46 INFO - TEST-INFO | 3606: exit 0 05:35:46 INFO - TEST-OK | dromaeo_css | took 1144757ms 05:35:46 INFO - TEST-START | kraken 05:35:46 INFO - operating with platform_type : linux_ 05:35:46 INFO - Initialising browser for kraken test... 05:35:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51962/getInfo.html -profile /tmp/tmpiwWXpY/profile 05:35:46 INFO - TEST-INFO | started process 4023 (/builds/slave/test/build/application/firefox/firefox http://localhost:51962/getInfo.html) 05:36:21 INFO - TEST-INFO | 4023: killed by SIGTERM 05:36:21 INFO - Browser initialized. 05:36:21 INFO - Running cycle 1/1 for kraken test... 05:36:21 INFO - TEST-INFO | started process 4250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiwWXpY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:33 INFO - PID 4250 | RSS: Main: 187846656 05:36:33 INFO - PID 4250 | 05:36:36 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51962/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:37 INFO - PID 4250 | RSS: Main: 193396736 05:36:37 INFO - PID 4250 | 05:36:39 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51962/tests/kraken/driver.html?testName=audio-dft) 05:36:40 INFO - PID 4250 | RSS: Main: 191213568 05:36:40 INFO - PID 4250 | 05:36:43 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51962/tests/kraken/driver.html?testName=audio-fft) 05:36:43 INFO - PID 4250 | RSS: Main: 187920384 05:36:43 INFO - PID 4250 | 05:36:46 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51962/tests/kraken/driver.html?testName=audio-oscillator) 05:36:46 INFO - PID 4250 | RSS: Main: 188301312 05:36:46 INFO - PID 4250 | 05:36:48 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:49 INFO - PID 4250 | RSS: Main: 188346368 05:36:49 INFO - PID 4250 | 05:36:52 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51962/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:53 INFO - PID 4250 | RSS: Main: 189497344 05:36:53 INFO - PID 4250 | 05:36:56 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51962/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:57 INFO - PID 4250 | RSS: Main: 188837888 05:36:57 INFO - PID 4250 | 05:37:00 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51962/tests/kraken/driver.html?testName=json-parse-financial) 05:37:00 INFO - PID 4250 | RSS: Main: 189702144 05:37:00 INFO - PID 4250 | 05:37:02 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:03 INFO - PID 4250 | RSS: Main: 189800448 05:37:03 INFO - PID 4250 | 05:37:04 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:05 INFO - PID 4250 | RSS: Main: 189575168 05:37:05 INFO - PID 4250 | 05:37:07 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:08 INFO - PID 4250 | RSS: Main: 190308352 05:37:08 INFO - PID 4250 | 05:37:11 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:11 INFO - PID 4250 | RSS: Main: 189890560 05:37:11 INFO - PID 4250 | 05:37:14 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:15 INFO - PID 4250 | RSS: Main: 189870080 05:37:15 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | Cycle 1(1): loaded http://localhost:51962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51962/tests/kraken/driver.html?testName=ai-astar) 05:37:17 INFO - PID 4250 | RSS: Main: 191717376 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | __start_tp_report 05:37:17 INFO - PID 4250 | _x_x_mozilla_page_load 05:37:17 INFO - PID 4250 | _x_x_mozilla_page_load_details 05:37:17 INFO - PID 4250 | |i|pagename|runs| 05:37:17 INFO - PID 4250 | |0;ai-astar;100;109;110;113;110;112;110;109;108;111 05:37:17 INFO - PID 4250 | |1;audio-beat-detection;148;122;121;170;126;130;122;133;144;129 05:37:17 INFO - PID 4250 | |2;audio-dft;162;167;162;162;164;174;171;169;168;163 05:37:17 INFO - PID 4250 | |3;audio-fft;76;73;74;117;74;77;74;73;101;74 05:37:17 INFO - PID 4250 | |4;audio-oscillator;83;85;108;82;84;84;98;81;81;102 05:37:17 INFO - PID 4250 | |5;imaging-gaussian-blur;114;120;117;117;114;114;114;113;113;115 05:37:17 INFO - PID 4250 | |6;imaging-darkroom;151;150;151;150;151;151;149;150;153;152 05:37:17 INFO - PID 4250 | |7;imaging-desaturate;94;95;95;94;94;94;94;95;94;95 05:37:17 INFO - PID 4250 | |8;json-parse-financial;57;56;56;60;55;56;53;55;54;53 05:37:17 INFO - PID 4250 | |9;json-stringify-tinderbox;58;56;56;55;59;55;59;55;55;55 05:37:17 INFO - PID 4250 | |10;stanford-crypto-aes;82;84;84;85;84;92;95;84;103;86 05:37:17 INFO - PID 4250 | |11;stanford-crypto-ccm;129;131;130;140;131;131;129;129;128;137 05:37:17 INFO - PID 4250 | |12;stanford-crypto-pbkdf2;181;200;194;198;194;189;191;180;185;195 05:37:17 INFO - PID 4250 | |13;stanford-crypto-sha256-iterative;79;78;74;75;76;72;71;71;70;73 05:37:17 INFO - PID 4250 | __end_tp_report 05:37:17 INFO - PID 4250 | __start_cc_report 05:37:17 INFO - PID 4250 | _x_x_mozilla_cycle_collect,996 05:37:17 INFO - PID 4250 | __end_cc_report 05:37:17 INFO - PID 4250 | __startTimestamp1496839037505__endTimestamp 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | ------- Summary: start ------- 05:37:17 INFO - PID 4250 | Number of tests: 14 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:3.55 (3.2%) stddev-sans-first:1.56 05:37:17 INFO - PID 4250 | Values: 100.0 109.0 110.0 113.0 110.0 112.0 110.0 109.0 108.0 111.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:131.50 stddev:15.47 (11.8%) stddev-sans-first:15.61 05:37:17 INFO - PID 4250 | Values: 148.0 122.0 121.0 170.0 126.0 130.0 122.0 133.0 144.0 129.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#2] audio-dft Cycles:10 Average:166.20 Median:167.50 stddev:4.26 (2.5%) stddev-sans-first:4.24 05:37:17 INFO - PID 4250 | Values: 162.0 167.0 162.0 162.0 164.0 174.0 171.0 169.0 168.0 163.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:15.13 (20.4%) stddev-sans-first:15.93 05:37:17 INFO - PID 4250 | Values: 76.0 73.0 74.0 117.0 74.0 77.0 74.0 73.0 101.0 74.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:83.50 stddev:9.94 (11.9%) stddev-sans-first:10.32 05:37:17 INFO - PID 4250 | Values: 83.0 85.0 108.0 82.0 84.0 84.0 98.0 81.0 81.0 102.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.50 stddev:2.23 (2.0%) stddev-sans-first:2.33 05:37:17 INFO - PID 4250 | Values: 114.0 120.0 117.0 117.0 114.0 114.0 114.0 113.0 113.0 115.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 05:37:17 INFO - PID 4250 | Values: 151.0 150.0 151.0 150.0 151.0 151.0 149.0 150.0 153.0 152.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:37:17 INFO - PID 4250 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:2.07 (3.7%) stddev-sans-first:2.12 05:37:17 INFO - PID 4250 | Values: 57.0 56.0 56.0 60.0 55.0 56.0 53.0 55.0 54.0 53.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:1.70 (3.0%) stddev-sans-first:1.69 05:37:17 INFO - PID 4250 | Values: 58.0 56.0 56.0 55.0 59.0 55.0 59.0 55.0 55.0 55.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:84.50 stddev:6.69 (7.9%) stddev-sans-first:6.75 05:37:17 INFO - PID 4250 | Values: 82.0 84.0 84.0 85.0 84.0 92.0 95.0 84.0 103.0 86.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:131.00 stddev:3.89 (3.0%) stddev-sans-first:4.02 05:37:17 INFO - PID 4250 | Values: 129.0 131.0 130.0 140.0 131.0 131.0 129.0 129.0 128.0 137.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.70 Median:194.00 stddev:6.86 (3.5%) stddev-sans-first:6.32 05:37:17 INFO - PID 4250 | Values: 181.0 200.0 194.0 198.0 194.0 189.0 191.0 180.0 185.0 195.0 05:37:17 INFO - PID 4250 | 05:37:17 INFO - PID 4250 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.50 stddev:3.07 (4.1%) stddev-sans-first:2.65 05:37:17 INFO - PID 4250 | Values: 79.0 78.0 74.0 75.0 76.0 72.0 71.0 71.0 70.0 73.0 05:37:17 INFO - PID 4250 | -------- Summary: end -------- 05:37:17 INFO - PID 4250 | 05:37:18 INFO - TEST-INFO | 4250: exit 0 05:37:18 INFO - TEST-OK | kraken | took 92219ms 05:37:18 INFO - SUITE-END | took 1236s 05:37:19 INFO - Completed test suite (00:20:37) 05:37:19 INFO - javascript benchmark 05:37:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7775.371972226189, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3062.9693703062976, 3066.8466576671167, 3073.323868748875, 3073.538969154628, 3102.8448577571116, 5863.76544938203, 5923.526117910562, 5936.198613187218, 5946.643201407918, 5995.100734889768, 5860.560457965659, 5954.642721436717, 5974.55190860685, 5987.0, 6105.511559075275, 5447.101228297326, 5538.529225015878, 5565.469495888622, 5593.636413633121, 5630.493255606994, 5654.547636189095, 5683.801066962657, 5686.3744988051285, 5690.089585666295, 5695.45893140151, 5348.5186333230195, 5438.374586922476, 5498.340199176085, 5530.5022547970675, 5539.0, 5574.1917421973585, 5584.5253153482, 5603.187537807036, 5608.5793565482345, 5633.32400111985, 5542.806001789958, 5544.1960915667405, 5576.0, 5581.916271255935, 5586.441355864381, 5932.406759324076, 6023.066424704134, 6032.788852390146, 6050.878982420327, 6071.483923866476, 6403.679816009228, 6449.742010319582, 6510.93489065108, 6518.608883467007, 6555.410013098844, 6539.901901471481, 6542.0, 6546.770863019771, 6548.607083575001, 6551.410373066399, 6055.6063855849225, 6066.241719785027, 6084.756609735649, 6094.841980023782, 6101.054336577793, 6520.413162815369, 6561.1470508833545, 6604.438622717027, 6628.96685516579, 6657.234418041987, 6179.814605561751, 6249.500039996789, 6277.52918531112, 6278.843028924313, 6291.622502649856, 6417.454516366068, 6496.545241833026, 6508.707108180143, 6528.21661400635, 6534.575252608565, 6501.187351581052, 6510.023496475472, 6514.218293804774, 6519.967400162969, 6522.804315870531, 6274.403931626488, 6363.9045414318825, 6413.326600706859, 6517.4460170886005, 6535.901961470582, 5242.370915490089, 5249.42256351801, 5256.684598924076, 5258.39528454225, 5275.393329767049, 4492.685512014193, 4493.618042466362, 4497.527759585262, 4504.81980720774, 4538.1831270370985, 5560.749766260528, 5625.493705566519, 5634.352049514277, 5694.174344719992, 5746.396628354046, 6573.408393244631, 6575.44108750752, 6576.76981305652, 6582.572132811352, 6594.0, 5661.858453538612, 5710.200571919934, 5722.685252311079, 5734.799282025109, 5772.913406298909, 5567.777288908398, 5711.942880571141, 5716.885662286731, 5719.971400143056, 5729.1119876419225, 6212.844678882973, 6217.782377616762, 6324.114623952651, 6336.0, 6339.270983836734, 6490.643014634241, 6495.0, 6498.090267362668, 6498.545101842826, 6504.38208370204, 6184.969075154595, 6234.0, 6234.314225435108, 6236.376362363727, 6240.0, 6158.0, 6221.813345599639, 6294.8111556653375, 6375.458086062737, 6379.106925030592, 6427.453666438405, 6428.6785660717715, 6430.967845160744, 6437.710303036468, 6445.16212892321, 6151.0, 6225.844353891189, 6243.250809902841, 6255.53083518747, 6267.811965641038, 6224.9377506224355, 6245.406686364788, 6320.209973753281, 6326.2092238470195, 6340.080688300079, 6198.380161983766, 6238.095476155841, 6279.1209230708655, 6300.905486417616, 6303.1175635412, 6234.251889773256, 6405.231372235362, 6417.711202995783, 6422.9036564450635, 6442.516811239082, 6041.305249896318, 6110.480609148272, 6117.84705382369, 6125.081237814185, 6129.295131059986], "value": 5909.194326005912, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.8258018075663, 781.8319061401799, 802.3701394405391, 1142.069213590924, 1144.8797876223002, 36759.08102297444, 38368.424473632884, 38436.42345364822, 38442.807785961064, 38496.42255366165, 40240.798796005976, 40865.18269634613, 40869.38695919564, 40874.38688419668, 40920.0, 7194.7122115115335, 7422.072240969879, 7426.368758655521, 7538.208488108725, 7580.999999999973, 7390.778276651709, 7453.291937265951, 7464.701411943516, 7472.738454154106, 7491.962540187292, 7463.477556571042, 7516.173220945691, 7527.849443011164, 7540.698372065111, 7566.470347075707, 7424.517406368623, 7431.219721929174, 7439.776806695835, 7477.887831682529, 7490.6629201686055, 7366.889496657554, 7418.295261950106, 7426.480146389755, 7433.814154646123, 7450.441216908754, 36719.81640091782, 36868.446973295424, 36929.630703692885, 36971.630283697086, 37169.44245836315, 3528.7177025837873, 3551.058969373118, 3574.392353299945, 3575.66031227033, 3587.7309201809967, 28117.57823632647, 28193.0, 28204.717952820414, 28263.0, 28278.15165545037, 3518.48981897626, 3549.0240183949363, 3559.715222782171, 3565.3404120237838, 3568.9107772305642, 137735.31132344273, 140243.0, 154342.22828885785, 167919.0, 168782.0, 44780.55219447829, 44940.77529612331, 44969.55030449719, 45040.0, 45101.323480147825, 47612.28581571279, 47746.5225347749, 47761.5223847764, 47843.521564784605, 47944.28083578749, 15175.696486070217, 15263.542093737206, 15271.312790924436, 15312.081275123528, 15328.923355383375, 12402.19385739924, 12426.068044896669, 12452.439640216213, 12456.501739930483, 12502.437390317276, 14099.78850317246, 14269.78595321071, 14271.714565708628, 14286.85713142876, 14475.855241447662, 5733.971330143323, 5770.682612456271, 5807.738651760681, 5872.911906321323, 5931.559695376671, 1010.5654568535454, 1020.168562621476, 1024.90263424976, 1030.4126647810826, 1040.5109598488698, 22695.0, 26938.86530567374, 29825.552616710767, 30006.549901751056, 30337.0, 1062.389126252408, 1074.4788777442934, 1103.8178700514325, 1119.3004372267333, 1122.4780477078034, 12484.87515124837, 13441.932790335986, 13492.460301587827, 13499.122557033761, 13606.727865442635, 207405.0, 209084.0, 209263.0, 209622.0, 209664.0, 46337.30494042592, 46862.5313746865, 47210.763946180734, 47213.0, 47227.0, 1418.4822539773115, 1439.0789894467548, 1454.8836093112525, 1464.1581090872792, 1485.717713634406, 22497.88751056234, 23241.535169296858, 23708.88145559261, 23972.40068998219, 24166.0, 37265.25469490649, 37523.06192345104, 37671.246575067795, 37718.0, 37725.62274377221, 182965.0, 183764.0, 183901.0, 184999.0, 185025.0, 34207.315853683285, 34703.65296347004, 35275.29449411049, 35425.645743542234, 35467.0, 41346.79326603348, 42112.789436052626, 43070.0, 43253.56746432495, 43269.78365108154, 30566.235844104074, 30672.386552269276, 31179.376412472076, 31327.37345253128, 32709.0, 30603.387932240785, 31429.8428507856, 31486.212844679067, 32380.0, 32904.0, 34088.0, 35348.82325588356, 35533.466997995565, 35769.1057723559, 35856.0, 30531.847340763154, 31454.37091258208, 31955.520667189547, 32240.19399515031, 33473.330533389686, 24859.378515537257, 25103.497930040932, 25226.117085901904, 25678.871605641853, 25727.871360643076], "value": 16649.874798670033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.8372650939624, 416.0721590852401, 421.2859203649814, 424.54573606241325, 436.5459921681451, 14753.0, 15463.84536154638, 20411.897940510295, 21005.159793608258, 21010.264640737576, 22119.778802211975, 22833.429164270903, 23010.539789204206, 23071.0, 23110.422239444022, 5888.882222355551, 6085.300190478108, 6088.086786981966, 6099.268087829467, 6102.847428814271, 5979.431953964367, 6062.120992456091, 6079.270487541501, 6085.634861908277, 6085.665288409135, 5980.611260268069, 6012.609180403259, 6372.171617689693, 6653.0, 6714.328567143295, 6626.5030122740745, 6658.76694315699, 6671.066050752898, 6676.732930682767, 6685.465162786965, 6531.542792004561, 6543.541952063358, 6546.247181574132, 6558.2458017328145, 6567.638779867106, 26899.0, 27015.86492067527, 27619.585706214424, 27631.861840690868, 27754.722452775415, 1938.9709154362695, 1976.3082920977686, 1993.132987150594, 1997.3808119483008, 2000.1399398258743, 18092.095395230317, 18622.25510979559, 18631.720524192147, 18655.90672046631, 18656.16047277862, 2206.6359050756764, 2259.5651761131635, 2262.1403866530613, 2269.6368581026954, 2375.9287221383215, 117354.0, 118540.40729796381, 120288.39855800752, 121565.0, 121728.0, 18749.437516874517, 19261.422157335302, 20021.0, 20860.478488037617, 21083.15377424059, 38305.0, 38515.807420962716, 38536.0, 38544.42183367252, 38628.420573691415, 10690.41202733857, 10690.893091069145, 10826.18803589734, 10996.560137594566, 11052.336859788438, 7455.515391499644, 7879.487833290817, 8876.156765107304, 9034.774130646787, 9056.366054376262, 7346.33882950537, 9780.0, 10292.0, 10751.237067026634, 10934.289271197347, 2095.549456866781, 2100.779418161071, 2167.7181966344588, 2170.869747815136, 2204.867707937529, 958.6740508227097, 966.429806414219, 967.8016006718606, 1011.3881101933224, 1014.1555071521773, 18528.907355463405, 19081.809181908004, 19547.315843945395, 19727.901360493106, 19868.70196947047, 1002.1381611813835, 1020.5203554329453, 1037.7768779712399, 1041.0, 1049.3074570783247, 9800.65697700577, 10469.267151299337, 10535.209859260585, 10737.826388507707, 10966.342019478856, 438217.0, 446618.0, 449479.0, 450970.0, 451749.0, 98543.50728246314, 99796.5010174959, 100472.0, 100579.49710251403, 100775.0, 1171.2796630072614, 1188.7622475504934, 1196.6350263169816, 1200.2318516149671, 1202.7353982123918, 16409.67180656404, 16437.342506300094, 16631.168441578116, 17106.230219640394, 17212.74180887313, 48888.2666760006, 49424.0, 49672.0, 50485.242721359944, 51003.74498127485, 61154.69422652858, 61223.38776612177, 61728.69135654293, 61887.381126188164, 61899.69050154721, 10015.899841001497, 10233.43716095592, 10249.077583017564, 10307.536160872929, 10312.690619281133, 12141.453634586289, 12787.74424511486, 17009.659806803546, 17641.647167056843, 17729.11354432299, 13569.86430135686, 13919.956003299996, 13929.651758705708, 13954.09298395601, 13963.93018034944, 12429.813552796535, 12890.871091288967, 12908.548200812926, 13155.934220328838, 13162.60512184636, 14572.781408279096, 15347.232638367814, 15474.84525154734, 15481.0, 15490.612734681272, 10165.72928383952, 10271.332363396356, 10343.741406464898, 10354.17166626653, 10406.635767748396, 14745.0, 14814.25928703539, 14881.925590371979, 14900.850991489946, 14999.700006000037], "value": 10968.39731177386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.813702013208, 1342.610642913555, 1346.4816045822356, 1353.2692346133088, 1365.6858922447836, 10652.201084918643, 10678.946605266972, 11008.449577521133, 11163.051140653044, 11176.664700059002, 10917.890821091807, 11112.277701949388, 11114.944425277863, 11116.444177791098, 11133.777324453506, 2333.8249631277636, 2376.8455050421753, 2378.1319818266293, 2379.821513386503, 2382.118616112041, 2277.464795772992, 2355.8927304167014, 2356.163561935514, 2369.7511761265077, 2381.38084098134, 2337.9883100584475, 2354.2584086012853, 2381.714194296687, 2382.5354055959097, 2390.0678735293163, 2255.909763609454, 2279.042802023146, 2281.646344816556, 2283.6003699352545, 2292.1519037955895, 2211.226070875197, 2232.441889527618, 2237.060434617448, 2237.55248950209, 2243.876586787726, 10767.676969690843, 10970.670879873616, 11043.392613406259, 11053.944730276378, 11057.944710276397, 6054.485368743618, 6205.782797602107, 6264.5301602380005, 6266.4360207581085, 6275.399773057887, 3523.6300188480095, 3626.3653860574295, 3654.6162652921325, 3663.6153203913736, 3665.065408320888, 1237.975240495185, 1274.7004453953314, 1299.6555912683148, 1307.274462673216, 1307.8169056332122, 14509.201993890438, 15066.472673456376, 15783.0, 15917.681646367007, 15963.84036159635, 5027.547520723079, 5153.123968925292, 5244.003639308519, 5269.578433725293, 5289.735513224324, 12002.879971200351, 12026.218295810744, 12069.215500992408, 12082.516699331929, 12108.334041627619, 6016.789412370546, 6159.84600384985, 6185.876282474325, 6221.968890155611, 6222.0, 5593.692346920877, 5763.567732420001, 5763.625364351304, 5788.131780232999, 5818.185454036438, 4109.155221219065, 4170.812313445902, 4185.476815398075, 4191.622753952098, 4237.427947227146, 1171.1333613126226, 1174.900133488646, 1184.6386852010048, 1187.0681515010674, 1198.5026214121042, 780.9687612495436, 802.3380710913519, 806.4838503357855, 811.3387589114852, 825.7110011496048, 6279.586895290859, 6350.682465876687, 6399.488040956712, 6568.1789776277965, 6710.966445167743, 913.9451632902047, 958.3998888811651, 963.4604621412032, 974.3666616699061, 984.4487087231173, 3594.928101438009, 3642.763220390666, 3737.32728108943, 3783.39465685489, 4512.503624601291, 13542.25517596522, 14059.156450612996, 14171.85828141726, 14226.217558034408, 14243.64390890236, 13781.586552403443, 13876.306184690726, 13891.235982021086, 14042.929785351007, 14062.648433789032, 8214.4660597061, 8311.875321870177, 8421.873671894926, 8440.662373505114, 8466.534340611326, 5813.0, 6434.967825160844, 6548.8035358939305, 6569.0, 6768.932310676831, 11690.47392867306, 11813.291202527877, 11850.170488065753, 11898.22661526998, 12613.810792838298, 12777.55278565283, 12780.872191277967, 12792.552260670831, 12830.101892867782, 12915.741685166431, 8218.917810821815, 8237.711680091168, 8399.496030238206, 8407.789805254673, 8411.83176336482, 9732.221422286058, 9745.951270243604, 9840.507974601098, 9846.753831154278, 9850.802983940424, 8748.69379571712, 8763.167499087576, 8905.154010369004, 8914.86627700598, 8943.552822358726, 8403.70587029451, 8454.619542120496, 8480.91519084826, 8669.479831210148, 8805.779855503664, 7392.371648409945, 7412.851742965003, 7415.888761668687, 7435.070616172979, 7436.330730234305, 5600.04625748079, 5883.235179426818, 5914.733836977261, 5926.377730338252, 6020.0, 5793.594448388572, 5811.389804070681, 5833.649981001154, 5983.9401605983385, 6050.364711705208], "value": 5097.021435807625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.2331829613957, 396.82936337374935, 398.94414781930556, 401.15756910487977, 402.3200790663779, 6131.3868613138775, 6233.189685340905, 6267.686615669221, 6290.18227630408, 6340.904886426707, 5999.160117583542, 6131.785387511438, 6134.0, 6142.8464288392815, 6162.0, 4658.90682186356, 4804.543568361, 4809.134355815961, 4811.7594120294025, 4816.157172494817, 4802.9039419211595, 4810.542998415145, 4810.63920205986, 4819.759012049383, 4836.492168322328, 4730.97634511827, 4754.78603462845, 4776.546228108324, 4790.712557246577, 4791.137595232856, 4774.427068751737, 4782.545658162469, 4786.425628924517, 4788.162071637449, 4792.353032340659, 4164.60436258558, 4172.70791044627, 4174.958250417518, 4178.22702799983, 4179.665626749883, 6057.848553786146, 6061.575689701723, 6069.696515174268, 6088.4215999479975, 6106.267247930276, 5441.020616289066, 5451.291332126838, 5461.508464238238, 5479.479449452296, 5487.176923461513, 6586.209654841402, 6589.868202635968, 6592.17597800275, 6598.637074960875, 6610.867782644368, 4579.809249595096, 4580.5190455002075, 4587.197240482902, 4591.058832939273, 4597.793099310539, 6549.836254093638, 6932.23745388007, 6997.965010174968, 7010.509264351497, 7014.719411223545, 4629.51390104041, 4636.281376386665, 4657.906841863211, 4665.230237010923, 4674.368960190399, 4705.411823522059, 4721.126591580569, 4724.976375118103, 4729.55069268419, 4732.597729193058, 5301.946980530145, 5451.536619387317, 5468.589855760833, 5471.863203419946, 5482.4101010707245, 6602.966985165043, 6609.801705948829, 6612.933870661328, 6621.0, 6631.33686631333, 1625.3986025170761, 1639.5901024743814, 1639.9344026239055, 1640.967180656404, 1647.8846480746472, 1045.3675526306627, 1073.592035026685, 1095.1950316517352, 1102.8400881872083, 1107.6732363952653, 5818.7672493100645, 5838.985549985248, 5859.531237501075, 5877.4122587740885, 5906.8818623627285, 6745.3591908768585, 6850.4862135340045, 6871.385224472245, 6880.65596720172, 6881.931180688129, 5821.27234095738, 5842.328132264759, 5855.795047173328, 5866.794662186803, 5872.207252021008, 3585.995921142084, 3643.3441980443245, 3655.451682247684, 3655.7989310588173, 3657.012606596204, 6463.676816159267, 6595.0, 6605.174353205849, 6613.140291762136, 6627.668616569153, 6937.791866244021, 6953.0, 6979.7195318200365, 7027.929720702829, 7041.929580704127, 6526.5105117117355, 6559.7376104955265, 6632.204135503771, 6660.167479065117, 6665.700043498055, 6784.76253331131, 6789.898151527632, 6798.660066996532, 6823.454123669995, 6851.417629501549, 6758.797236082925, 6762.594244345355, 6766.526343156129, 6767.560108592926, 6767.763128290486, 6205.81382558524, 6505.479561635152, 6572.737090516517, 6626.204855417381, 6653.567518111307, 4612.723236605814, 4665.6967297125575, 4667.8599642010795, 4685.344051832678, 4689.273162659793, 6665.866682666417, 6865.862682746417, 6871.175458944958, 6900.413464855343, 6906.447484201151, 6636.0, 6667.366600172976, 6670.39966403026, 6681.164854393201, 6696.7656132035145, 6686.06395104676, 6686.3313668632745, 6692.564983276072, 6710.765123220664, 6715.086200433048, 6512.934870651233, 6545.869082618226, 6565.835854103495, 6570.704318305592, 6572.333643113443, 6573.276939536551, 6666.166729158856, 6675.766348177791, 6691.464682825265, 6714.362135597111, 6450.516211284079, 6466.676666166579, 6482.967585162044, 6493.7727179550375, 6510.804675859732], "value": 4951.483891806628, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.9842603147937, 789.7117552093488, 814.8876783190942, 848.2196379331015, 869.578254546545, 14213.0, 14758.040727352714, 16370.099644519547, 16611.91694041531, 16789.1605419729, 16731.16344182792, 17706.557336066606, 17825.46523604294, 17837.91081044593, 17885.28458861644, 978.7699890525721, 997.5311603546321, 1000.7648202672366, 1002.6691191906654, 1002.7392877851738, 909.6315992023241, 1003.658756022952, 1010.1867996263042, 1010.3887148275298, 1013.4375421640987, 1049.5696764326628, 1064.0, 1064.5688496159069, 1065.9680209593726, 1066.5200659703125, 1057.2863317260894, 1057.7514284143258, 1058.5554067291716, 1060.8514807926858, 1061.3790932304612, 779.2324560308092, 779.3609240422855, 780.4068907630242, 782.1005843280217, 783.4241832253289, 17461.126943652765, 17558.648827023517, 17910.820891791045, 18188.27246910122, 18202.362917297964, 17612.559686007953, 17703.822961770347, 17925.551861203443, 17930.820691793044, 17943.641127177383, 14609.342579583945, 15197.164155971417, 15207.163606001775, 15220.619484512865, 15270.31283592241, 3416.4192087344964, 3420.7776494527775, 3431.7769344992494, 3434.690877821008, 3437.8281085945605, 96319.51840240824, 96650.0, 96760.0, 96844.0, 99189.0, 15001.399944002118, 15169.924150379178, 15286.0, 15325.386984520494, 15420.92289538545, 26944.865275673495, 27341.316467088083, 27374.726252737615, 27619.723802762117, 27660.308492287855, 7309.671064801991, 7681.0, 7762.7671169865, 7802.414818888606, 7934.880976785353, 3585.46218067292, 3637.94543081854, 3639.94540081899, 3661.103029757673, 3663.5970043295215, 4278.657707383401, 4393.604575588212, 4402.603765661106, 4406.735595864195, 4424.070945101565, 844.1811442900377, 847.3433089355675, 863.4085651328734, 864.2912811494514, 867.128535821508, 649.8310439285725, 665.490899461912, 666.9266380698119, 673.5487223560128, 687.4706476013441, 11288.153388495895, 11780.410979450993, 12594.685132871751, 12730.618081457571, 12775.233485990684, 680.3604611665019, 692.4045321023915, 697.6093387702801, 701.8771714949863, 710.2435905760349, 5065.746712664352, 5075.264086707407, 5086.264844275197, 5165.251038599382, 5300.178472336794, 79842.0, 81878.18121818824, 82436.0, 84243.15756842353, 84246.0, 71466.28533714596, 72252.0, 72486.63756681183, 73418.0, 73756.63121684357, 63204.0, 63445.04832427517, 65522.67238663872, 65588.0, 66840.33159668438, 10567.841482377924, 11238.269512481662, 11743.76512469763, 11784.823227651763, 11801.881981180422, 28517.287067823472, 28519.28701782472, 28770.85614571914, 29203.269918252212, 29780.106596802132, 36577.71977980758, 36714.44928326024, 36889.63110368862, 37726.245475090895, 37956.0, 16622.50132496027, 16727.163641818104, 16974.49076527706, 17165.65668686644, 17363.2186551608, 16862.494125176265, 18083.0, 18805.529861753566, 19640.41078767582, 19898.104585293986, 16145.434909778101, 16228.51314460568, 16657.83342166563, 17811.10944452746, 18173.18220680099, 16363.836361636231, 17034.914825425793, 17752.0, 17948.82051179524, 18059.54851128732, 17244.0, 17415.129243537518, 17581.736273956158, 17712.91143544274, 17948.461546153638, 11351.602693905674, 12392.938035309766, 12562.497500100259, 12987.480500779862, 13004.674883127618, 12953.611391658265, 12974.610761677164, 13327.200367977952, 13596.59210223695, 13722.725545489235], "value": 8112.642089589931, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 110.0, 113.0, 110.0, 112.0, 110.0, 109.0, 108.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 121.0, 170.0, 126.0, 130.0, 122.0, 133.0, 144.0, 129.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 162.0, 162.0, 164.0, 174.0, 171.0, 169.0, 168.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 117.0, 74.0, 77.0, 74.0, 73.0, 101.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 108.0, 82.0, 84.0, 84.0, 98.0, 81.0, 81.0, 102.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 117.0, 117.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 151.0, 151.0, 149.0, 150.0, 153.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 60.0, 55.0, 56.0, 53.0, 55.0, 54.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 55.0, 59.0, 55.0, 59.0, 55.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 85.0, 84.0, 92.0, 95.0, 84.0, 103.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 130.0, 140.0, 131.0, 131.0, 129.0, 129.0, 128.0, 137.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 200.0, 194.0, 198.0, 194.0, 189.0, 191.0, 180.0, 185.0, 195.0], "value": 190.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 74.0, 75.0, 76.0, 72.0, 71.0, 71.0, 70.0, 73.0], "value": 73.9, "unit": "score"}]}]} 05:37:19 INFO - Return code: 0 05:37:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:19 INFO - # TBPL SUCCESS # 05:37:19 INFO - Running post-action listener: _resource_record_post_action 05:37:19 INFO - [mozharness: 2017-06-07 12:37:19.415589Z] Finished run-tests step (success) 05:37:19 INFO - Running post-run listener: _resource_record_post_run 05:37:19 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 8724480; Write bytes: 445517824; Read time: 2484; Write time: 357536 05:37:19 INFO - TinderboxPrint: CPU usage
12.7% 05:37:19 INFO - TinderboxPrint: I/O read bytes / time
8,724,480 / 2,484 05:37:19 INFO - TinderboxPrint: I/O write bytes / time
445,517,824 / 357,536 05:37:19 INFO - TinderboxPrint: CPU idle
8,745.6 (87.3%) 05:37:19 INFO - TinderboxPrint: CPU user
1,210.8 (12.1%) 05:37:19 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117354496; Read time: 48; Write time: 80896 05:37:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:37:19 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 6688768; Write bytes: 328163328; Read time: 2364; Write time: 276640 05:37:20 INFO - Running post-run listener: _upload_blobber_files 05:37:20 INFO - Blob upload gear active. 05:37:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:27 INFO - (blobuploader) - INFO - Done attempting. 05:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:28 INFO - (blobuploader) - INFO - Done attempting. 05:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:37:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:29 INFO - (blobuploader) - INFO - Done attempting. 05:37:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:37:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:30 INFO - (blobuploader) - INFO - Done attempting. 05:37:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:30 INFO - Return code: 0 05:37:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8307b843f26052f962e7270996cd23a57f8a606edda3b8cc62d4f599b15354dc6d285ebb8af45457e4cc372d2ed6b1fbbebeb20b213a9c9718386406ee634c62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf5cc35303f4bc715452d96fddb32704f4ef927a381dd6ec0b0f9b5a3c204716f799e8f9f37a2607a956cc31d84b1f1f8eb2d2716f38cf4dc3f16e19ab884a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e08f988f4db6fb2e0f38ab5ad87419dd1888b060f978749bd61fe55ffc0467c903c0a2564b2b23f1a1f03df74f033effb6d60aa1dc04349f350cd29f88d9a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87ee63ac8ca76160b5a0aa6284c3cd77413d5943d05417e4503b6aa1cd07232e1c2c3928e4ed9ce1a43446a4a4b2746604048c9180849d353257890f9138800"} 05:37:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:30 INFO - Contents: 05:37:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8307b843f26052f962e7270996cd23a57f8a606edda3b8cc62d4f599b15354dc6d285ebb8af45457e4cc372d2ed6b1fbbebeb20b213a9c9718386406ee634c62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf5cc35303f4bc715452d96fddb32704f4ef927a381dd6ec0b0f9b5a3c204716f799e8f9f37a2607a956cc31d84b1f1f8eb2d2716f38cf4dc3f16e19ab884a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e08f988f4db6fb2e0f38ab5ad87419dd1888b060f978749bd61fe55ffc0467c903c0a2564b2b23f1a1f03df74f033effb6d60aa1dc04349f350cd29f88d9a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87ee63ac8ca76160b5a0aa6284c3cd77413d5943d05417e4503b6aa1cd07232e1c2c3928e4ed9ce1a43446a4a4b2746604048c9180849d353257890f9138800"} 05:37:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:30 INFO - Copying logs to upload dir... 05:37:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1321.560436 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-07 05:37:29.965665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:29.969479) ========= 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=199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015 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/8307b843f26052f962e7270996cd23a57f8a606edda3b8cc62d4f599b15354dc6d285ebb8af45457e4cc372d2ed6b1fbbebeb20b213a9c9718386406ee634c62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf5cc35303f4bc715452d96fddb32704f4ef927a381dd6ec0b0f9b5a3c204716f799e8f9f37a2607a956cc31d84b1f1f8eb2d2716f38cf4dc3f16e19ab884a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e08f988f4db6fb2e0f38ab5ad87419dd1888b060f978749bd61fe55ffc0467c903c0a2564b2b23f1a1f03df74f033effb6d60aa1dc04349f350cd29f88d9a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87ee63ac8ca76160b5a0aa6284c3cd77413d5943d05417e4503b6aa1cd07232e1c2c3928e4ed9ce1a43446a4a4b2746604048c9180849d353257890f9138800"} build_url:https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8307b843f26052f962e7270996cd23a57f8a606edda3b8cc62d4f599b15354dc6d285ebb8af45457e4cc372d2ed6b1fbbebeb20b213a9c9718386406ee634c62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdf5cc35303f4bc715452d96fddb32704f4ef927a381dd6ec0b0f9b5a3c204716f799e8f9f37a2607a956cc31d84b1f1f8eb2d2716f38cf4dc3f16e19ab884a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4e08f988f4db6fb2e0f38ab5ad87419dd1888b060f978749bd61fe55ffc0467c903c0a2564b2b23f1a1f03df74f033effb6d60aa1dc04349f350cd29f88d9a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e87ee63ac8ca76160b5a0aa6284c3cd77413d5943d05417e4503b6aa1cd07232e1c2c3928e4ed9ce1a43446a4a4b2746604048c9180849d353257890f9138800"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:29.994277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:29.994643) ========= 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=199fb4c72b90437b990b419b000001c5-1496833675.995828-1766730015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:30.077289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:37:30.077744) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:37:30.078117) ========= ========= Total master_lag: 0.18 =========