builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1496837727.35 results: success (0) revision: f6320f91851c2cede08b0fb54a6d0525b870310e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.350469) ========= 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:27.350843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.351118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.366360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.366783) ========= 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=d2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000 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% 289K=0.04s 2017-06-07 05:15:28 (289 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.576265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.576572) ========= 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=d2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.625906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:27.626250) ========= 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=d2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-07 05:15:28,238 truncating revision to first 12 chars 2017-06-07 05:15:28,238 Setting DEBUG logging. 2017-06-07 05:15:28,238 attempt 1/10 2017-06-07 05:15:28,238 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,741 unpacking tar archive at: mozilla-central-f6320f91851c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.797219 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.437969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.438261) ========= script_repo_revision: f6320f91851c2cede08b0fb54a6d0525b870310e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.438607) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.438889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-07 05:15:28.458192) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-07 05:15:28.458470) ========= /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=d2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:29 INFO - MultiFileLogger online at 20170607 05:15:29 in /builds/slave/test 05:15:29 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:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:29 INFO - {'append_to_log': False, 05:15:29 INFO - 'base_work_dir': '/builds/slave/test', 05:15:29 INFO - 'blob_upload_branch': 'Firefox', 05:15:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:29 INFO - 'branch': 'Firefox', 05:15:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:29 INFO - 'config_files': ('talos/linux_config.py',), 05:15:29 INFO - 'default_actions': ('clobber', 05:15:29 INFO - 'read-buildbot-config', 05:15:29 INFO - 'download-and-extract', 05:15:29 INFO - 'populate-webroot', 05:15:29 INFO - 'create-virtualenv', 05:15:29 INFO - 'install', 05:15:29 INFO - 'setup-mitmproxy', 05:15:29 INFO - 'run-tests'), 05:15:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:29 INFO - 'download_minidump_stackwalk': True, 05:15:29 INFO - 'download_symbols': 'ondemand', 05:15:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:29 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:29 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:29 INFO - 'gecko_profile': False, 05:15:29 INFO - 'gecko_profile_interval': 0, 05:15:29 INFO - 'installer_path': 'installer.exe', 05:15:29 INFO - 'log_level': 'info', 05:15:29 INFO - 'log_name': 'talos', 05:15:29 INFO - 'log_to_console': True, 05:15:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:29 INFO - 'opt_config_files': (), 05:15:29 INFO - 'pip_index': False, 05:15:29 INFO - 'suite': 'dromaeojs-e10s', 05:15:29 INFO - 'system_bits': '32', 05:15:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:29 INFO - 'title': 'talos-linux64-ix-043', 05:15:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:29 INFO - 'use_talos_json': True, 05:15:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:29 INFO - 'work_dir': 'build'} 05:15:29 INFO - [mozharness: 2017-06-07 12:15:29.176938Z] Running clobber step. 05:15:29 INFO - Running pre-action listener: _resource_record_pre_action 05:15:29 INFO - Running main action method: clobber 05:15:29 INFO - rmtree: /builds/slave/test/build 05:15:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:30 INFO - Running post-action listener: _resource_record_post_action 05:15:30 INFO - [mozharness: 2017-06-07 12:15:30.208368Z] Finished clobber step (success) 05:15:30 INFO - [mozharness: 2017-06-07 12:15:30.208471Z] Running read-buildbot-config step. 05:15:30 INFO - Running pre-action listener: _resource_record_pre_action 05:15:30 INFO - Running main action method: read_buildbot_config 05:15:30 INFO - Using buildbot properties: 05:15:30 INFO - { 05:15:30 INFO - "project": "", 05:15:30 INFO - "product": "firefox", 05:15:30 INFO - "who": "cbook@mozilla.com", 05:15:30 INFO - "installer_path": "public/build/target.tar.bz2", 05:15:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:15:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:15:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:15:30 INFO - "stage_platform": "linux64-stylosequential", 05:15:30 INFO - "basedir": "/builds/slave/test", 05:15:30 INFO - "buildnumber": 51, 05:15:30 INFO - "platform": "ubuntu64_hw_styloseq", 05:15:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:15:30 INFO - "slavebuilddir": "test", 05:15:30 INFO - "taskId": "AXXPJW6nRAaElDDZiD2cAQ", 05:15:30 INFO - "branch": "mozilla-central", 05:15:30 INFO - "script_repo_revision": "production", 05:15:30 INFO - "revision": "f6320f91851c2cede08b0fb54a6d0525b870310e", 05:15:30 INFO - "slavename": "talos-linux64-ix-043", 05:15:30 INFO - "repo_path": "mozilla-central" 05:15:30 INFO - } 05:15:30 INFO - Finding installer, test and symbols from parent task. 05:15:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXXPJW6nRAaElDDZiD2cAQ'}, attempt #1 05:15:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AXXPJW6nRAaElDDZiD2cAQ'}, attempt #1 05:15:31 INFO - Task dependencies: EsjSzTmcTRGF966pkkVXsQ 05:15:31 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.528495Z] Finished read-buildbot-config step (success) 05:15:31 INFO - [mozharness: 2017-06-07 12:15:31.528715Z] 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:32 INFO - Downloaded 989 bytes. 05:15:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:15:32 INFO - Using the following test package requirements: 05:15:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:15:32 INFO - u'common': [u'target.common.tests.zip'], 05:15:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:15:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:15:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:15:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:15:32 INFO - u'mozbase': [u'target.common.tests.zip'], 05:15:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:15:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:15:32 INFO - u'web-platform': [u'target.common.tests.zip', 05:15:32 INFO - u'target.web-platform.tests.tar.gz'], 05:15:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:15:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:15:32 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:32 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:32 INFO - Fetch https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip into memory 05:15:35 INFO - Content-Length response header: 65117446 05:15:35 INFO - Bytes received: 65117446 05:15:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:15:46 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:46 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:46 INFO - Fetch https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.common.tests.zip into memory 05:15:47 INFO - Content-Length response header: 65117446 05:15:47 INFO - Bytes received: 65117446 05:15:59 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:15:59 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:15:59 INFO - Fetch https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.talos.tests.zip into memory 05:16:00 INFO - Content-Length response header: 14447563 05:16:00 INFO - Bytes received: 14447563 05:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:00 INFO - trying https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 05:16:00 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:00 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.266522Z] Finished download-and-extract step (success) 05:16:03 INFO - [mozharness: 2017-06-07 12:16:03.266728Z] 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.287041Z] Finished populate-webroot step (success) 05:16:03 INFO - [mozharness: 2017-06-07 12:16:03.287131Z] 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:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:05 INFO - Installing pip.................done. 05:16:05 INFO - Return code: 0 05:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:16:05 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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 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 - Downloading/unpacking psutil>=3.1.1 05:16:06 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:06 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:06 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:06 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:07 INFO - Installing collected packages: psutil 05:16:07 INFO - Running setup.py install for psutil 05:16:07 INFO - building 'psutil._psutil_linux' extension 05:16:07 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:07 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:08 INFO - building 'psutil._psutil_posix' extension 05:16:08 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:08 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: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 - Successfully installed psutil 05:16:08 INFO - Cleaning up... 05:16:08 INFO - Return code: 0 05:16:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:08 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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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:08 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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 05:16:08 INFO - 'HOME': '/home/cltbld', 05:16:08 INFO - 'LANG': 'en_US.UTF-8', 05:16:08 INFO - 'LANGUAGE': 'en_US:en', 05:16:08 INFO - 'LOGNAME': 'cltbld', 05:16:08 INFO - 'MAIL': '/var/mail/cltbld', 05:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:08 INFO - 'MOZ_NO_REMOTE': '1', 05:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:08 INFO - 'NO_EM_RESTART': '1', 05:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:08 INFO - 'PWD': '/builds/slave/test', 05:16:08 INFO - 'SHELL': '/bin/bash', 05:16:08 INFO - 'SHLVL': '1', 05:16:08 INFO - 'TERM': 'linux', 05:16:08 INFO - 'TMOUT': '86400', 05:16:08 INFO - 'USER': 'cltbld', 05:16:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:08 INFO - '_': '/tools/buildbot/bin/python'} 05:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:08 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:08 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 - 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:08 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 - Downloading mozsystemmonitor-0.3.tar.gz 05:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:09 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:09 INFO - Installing collected packages: mozsystemmonitor 05:16:09 INFO - Running setup.py install for mozsystemmonitor 05:16:09 INFO - Successfully installed mozsystemmonitor 05:16:09 INFO - Cleaning up... 05:16:09 INFO - Return code: 0 05:16:09 INFO - Installing jsonschema==2.5.1 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', '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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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', 'jsonschema==2.5.1'] 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 jsonschema==2.5.1 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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:09 INFO - '_': '/tools/buildbot/bin/python'} 05:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:10 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:10 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:10 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 - 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:10 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:11 INFO - Downloading/unpacking functools32 (from 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:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:11 INFO - warning: no files found matching '*.txt' 05:16:11 INFO - no previously-included directories found matching 'build' 05:16:11 INFO - no previously-included directories found matching 'dist' 05:16:11 INFO - no previously-included directories found matching '.git*' 05:16:11 INFO - Installing collected packages: jsonschema, functools32 05:16:11 INFO - Running setup.py install for functools32 05:16:11 INFO - warning: no files found matching '*.txt' 05:16:11 INFO - no previously-included directories found matching 'build' 05:16:11 INFO - no previously-included directories found matching 'dist' 05:16:11 INFO - no previously-included directories found matching '.git*' 05:16:11 INFO - Successfully installed jsonschema functools32 05:16:11 INFO - Cleaning up... 05:16:11 INFO - Return code: 0 05:16:11 INFO - Installing functools32==3.2.3-2 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', '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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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', 'functools32==3.2.3-2'] 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 functools32==3.2.3-2 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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:11 INFO - Cleaning up... 05:16:11 INFO - Return code: 0 05:16:11 INFO - Installing blobuploader==1.2.4 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', '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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - '_': '/tools/buildbot/bin/python'} 05:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:12 INFO - Downloading/unpacking blobuploader==1.2.4 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:13 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:13 INFO - Downloading/unpacking requests==1.2.3. (from 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:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:13 INFO - Downloading/unpacking docopt==0.6.1 (from 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:13 INFO - Downloading docopt-0.6.1.tar.gz 05:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:13 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:13 INFO - Running setup.py install for blobuploader 05:16:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:13 INFO - Running setup.py install for requests 05:16:14 INFO - Running setup.py install for docopt 05:16:14 INFO - Successfully installed blobuploader requests docopt 05:16:14 INFO - Cleaning up... 05:16:14 INFO - Return code: 0 05:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:14 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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 05:16:14 INFO - 'HOME': '/home/cltbld', 05:16:14 INFO - 'LANG': 'en_US.UTF-8', 05:16:14 INFO - 'LANGUAGE': 'en_US:en', 05:16:14 INFO - 'LOGNAME': 'cltbld', 05:16:14 INFO - 'MAIL': '/var/mail/cltbld', 05:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:14 INFO - 'MOZ_NO_REMOTE': '1', 05:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:14 INFO - 'NO_EM_RESTART': '1', 05:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:14 INFO - 'PWD': '/builds/slave/test', 05:16:14 INFO - 'SHELL': '/bin/bash', 05:16:14 INFO - 'SHLVL': '1', 05:16:14 INFO - 'TERM': 'linux', 05:16:14 INFO - 'TMOUT': '86400', 05:16:14 INFO - 'USER': 'cltbld', 05:16:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:14 INFO - '_': '/tools/buildbot/bin/python'} 05:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:14 INFO - Running setup.py (path:/tmp/pip-xaboZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:14 INFO - Running setup.py (path:/tmp/pip-xsSRjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:14 INFO - Running setup.py (path:/tmp/pip-9GrzoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:14 INFO - Running setup.py (path:/tmp/pip-roq2sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:14 INFO - Running setup.py (path:/tmp/pip-bsDrnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:14 INFO - Running setup.py (path:/tmp/pip-hmtPii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:14 INFO - Running setup.py (path:/tmp/pip-G_ViA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:15 INFO - Running setup.py (path:/tmp/pip-jCDV9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:15 INFO - Running setup.py (path:/tmp/pip-MzVCGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:15 INFO - Running setup.py (path:/tmp/pip-E9Ys1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:15 INFO - Running setup.py (path:/tmp/pip-SxjWml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:15 INFO - Running setup.py (path:/tmp/pip-i9qhm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:15 INFO - Running setup.py (path:/tmp/pip-CpEIXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:15 INFO - Running setup.py (path:/tmp/pip-953aQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:15 INFO - Running setup.py (path:/tmp/pip-l_3rcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:15 INFO - Running setup.py (path:/tmp/pip-pa1Mt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:15 INFO - Running setup.py (path:/tmp/pip-S4o3Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:15 INFO - Running setup.py install for manifestparser 05:16:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:15 INFO - Running setup.py install for mozcrash 05:16:15 INFO - Running setup.py install for mozdebug 05:16:16 INFO - Running setup.py install for mozdevice 05:16:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Running setup.py install for mozfile 05:16:16 INFO - Running setup.py install for mozhttpd 05:16:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Running setup.py install for mozinfo 05:16:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Running setup.py install for mozInstall 05:16:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Running setup.py install for mozleak 05:16:16 INFO - Running setup.py install for mozlog 05:16:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Running setup.py install for moznetwork 05:16:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:16 INFO - Running setup.py install for mozprocess 05:16:16 INFO - Running setup.py install for mozprofile 05:16:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozrunner 05:16:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Running setup.py install for mozscreenshot 05:16:17 INFO - Running setup.py install for moztest 05:16:17 INFO - Running setup.py install for mozversion 05:16:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:17 INFO - Cleaning up... 05:16:17 INFO - Return code: 0 05:16:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:17 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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 05:16:17 INFO - 'HOME': '/home/cltbld', 05:16:17 INFO - 'LANG': 'en_US.UTF-8', 05:16:17 INFO - 'LANGUAGE': 'en_US:en', 05:16:17 INFO - 'LOGNAME': 'cltbld', 05:16:17 INFO - 'MAIL': '/var/mail/cltbld', 05:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:17 INFO - 'MOZ_NO_REMOTE': '1', 05:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:17 INFO - 'NO_EM_RESTART': '1', 05:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:17 INFO - 'PWD': '/builds/slave/test', 05:16:17 INFO - 'SHELL': '/bin/bash', 05:16:17 INFO - 'SHLVL': '1', 05:16:17 INFO - 'TERM': 'linux', 05:16:17 INFO - 'TMOUT': '86400', 05:16:17 INFO - 'USER': 'cltbld', 05:16:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:17 INFO - '_': '/tools/buildbot/bin/python'} 05:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:17 INFO - Running setup.py (path:/tmp/pip-fLHFT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:17 INFO - Running setup.py (path:/tmp/pip-C76IOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:17 INFO - Running setup.py (path:/tmp/pip-BOlaau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:17 INFO - Running setup.py (path:/tmp/pip-toPjcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:18 INFO - Running setup.py (path:/tmp/pip-31jATi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:18 INFO - Running setup.py (path:/tmp/pip-sKbN_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:18 INFO - Running setup.py (path:/tmp/pip-9Vlw_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:18 INFO - Running setup.py (path:/tmp/pip-b5Coon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:18 INFO - Running setup.py (path:/tmp/pip-p7vIuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:18 INFO - Running setup.py (path:/tmp/pip-lu8u8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:18 INFO - Running setup.py (path:/tmp/pip-6j8g9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:18 INFO - Running setup.py (path:/tmp/pip-3jMSWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:18 INFO - Running setup.py (path:/tmp/pip-Ic41Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:18 INFO - Running setup.py (path:/tmp/pip-JaUPta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:18 INFO - Running setup.py (path:/tmp/pip-WBj3Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:18 INFO - Running setup.py (path:/tmp/pip-Y51L2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:18 INFO - Running setup.py (path:/tmp/pip-vHmISX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:18 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:18 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:18 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:18 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:18 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:18 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:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:18 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:18 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:18 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:18 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 - Downloading blessings-1.6.tar.gz 05:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:20 INFO - Installing collected packages: blessings 05:16:20 INFO - Running setup.py install for blessings 05:16:20 INFO - Successfully installed blessings 05:16:20 INFO - Cleaning up... 05:16:20 INFO - Return code: 0 05:16:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:20 INFO - Reading from file tmpfile_stdout 05:16:20 INFO - Current package versions: 05:16:20 INFO - argparse == 1.2.1 05:16:20 INFO - blessings == 1.6 05:16:20 INFO - blobuploader == 1.2.4 05:16:20 INFO - docopt == 0.6.1 05:16:20 INFO - functools32 == 3.2.3-2 05:16:20 INFO - jsonschema == 2.5.1 05:16:20 INFO - manifestparser == 1.1 05:16:20 INFO - mozInstall == 1.12 05:16:20 INFO - mozcrash == 1.0 05:16:20 INFO - mozdebug == 0.1 05:16:20 INFO - mozdevice == 0.51 05:16:20 INFO - mozfile == 1.2 05:16:20 INFO - mozhttpd == 0.7 05:16:20 INFO - mozinfo == 0.10 05:16:20 INFO - mozleak == 0.1 05:16:20 INFO - mozlog == 3.4 05:16:20 INFO - moznetwork == 0.27 05:16:20 INFO - mozprocess == 0.25 05:16:20 INFO - mozprofile == 0.28 05:16:20 INFO - mozrunner == 6.13 05:16:20 INFO - mozscreenshot == 0.1 05:16:20 INFO - mozsystemmonitor == 0.3 05:16:20 INFO - moztest == 0.8 05:16:20 INFO - mozversion == 1.4 05:16:20 INFO - psutil == 3.1.1 05:16:20 INFO - requests == 1.2.3 05:16:20 INFO - wsgiref == 0.1.2 05:16:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:20 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 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 05:16:20 INFO - 'HOME': '/home/cltbld', 05:16:20 INFO - 'LANG': 'en_US.UTF-8', 05:16:20 INFO - 'LANGUAGE': 'en_US:en', 05:16:20 INFO - 'LOGNAME': 'cltbld', 05:16:20 INFO - 'MAIL': '/var/mail/cltbld', 05:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:20 INFO - 'MOZ_NO_REMOTE': '1', 05:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:20 INFO - 'NO_EM_RESTART': '1', 05:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:20 INFO - 'PWD': '/builds/slave/test', 05:16:20 INFO - 'SHELL': '/bin/bash', 05:16:20 INFO - 'SHLVL': '1', 05:16:20 INFO - 'TERM': 'linux', 05:16:20 INFO - 'TMOUT': '86400', 05:16:20 INFO - 'USER': 'cltbld', 05:16:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:20 INFO - '_': '/tools/buildbot/bin/python'} 05:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/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 marionette_driver-1.4.0.tar.gz 05:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:16:21 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:21 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:21 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:21 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:21 INFO - Installing collected packages: marionette-driver 05:16:21 INFO - Running setup.py install for marionette-driver 05:16:21 INFO - Successfully installed marionette-driver 05:16:21 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d219a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, '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': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', '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:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:16:22 INFO - Using env: {'DISPLAY': ':0', 05:16:22 INFO - 'HOME': '/home/cltbld', 05:16:22 INFO - 'LANG': 'en_US.UTF-8', 05:16:22 INFO - 'LANGUAGE': 'en_US:en', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MAIL': '/var/mail/cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SHLVL': '1', 05:16:22 INFO - 'TERM': 'linux', 05:16:22 INFO - 'TMOUT': '86400', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - '_': '/tools/buildbot/bin/python'} 05:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:22 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Running post-action listener: _resource_record_post_action 05:16:22 INFO - Running post-action listener: _start_resource_monitoring 05:16:22 INFO - Starting resource monitoring. 05:16:22 INFO - [mozharness: 2017-06-07 12:16:22.288413Z] Finished create-virtualenv step (success) 05:16:22 INFO - [mozharness: 2017-06-07 12:16:22.288887Z] Running install step. 05:16:22 INFO - Running pre-action listener: _resource_record_pre_action 05:16:22 INFO - Running main action method: install 05:16:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:22 INFO - Reading from file tmpfile_stdout 05:16:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:22 INFO - Reading from file tmpfile_stdout 05:16:22 INFO - Output received: 05:16:22 INFO - Usage: mozinstall [options] installer 05:16:22 INFO - Options: 05:16:22 INFO - -h, --help show this help message and exit 05:16:22 INFO - -d DEST, --destination=DEST 05:16:22 INFO - Directory to install application into. [default: 05:16:22 INFO - "/builds/slave/test"] 05:16:22 INFO - --app=APP Application being installed. [default: firefox] 05:16:22 INFO - mkdir: /builds/slave/test/build/application 05:16:22 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:22 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:40 INFO - Reading from file tmpfile_stdout 05:16:40 INFO - Output received: 05:16:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:16:40 INFO - Running post-action listener: _resource_record_post_action 05:16:40 INFO - [mozharness: 2017-06-07 12:16:40.070553Z] Finished install step (success) 05:16:40 INFO - [mozharness: 2017-06-07 12:16:40.070834Z] Running setup-mitmproxy step. 05:16:40 INFO - Running pre-action listener: _resource_record_pre_action 05:16:40 INFO - Running main action method: setup_mitmproxy 05:16:40 INFO - Skipping: mitmproxy is not required 05:16:40 INFO - Running post-action listener: _resource_record_post_action 05:16:40 INFO - [mozharness: 2017-06-07 12:16:40.071971Z] Finished setup-mitmproxy step (success) 05:16:40 INFO - [mozharness: 2017-06-07 12:16:40.072194Z] Running run-tests step. 05:16:40 INFO - Running pre-action listener: _resource_record_pre_action 05:16:40 INFO - Running main action method: run_tests 05:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:40 INFO - Python 2.7.3 05:16:40 INFO - Return code: 0 05:16:40 INFO - grabbing minidump binary from tooltool 05:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:40 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 0x2d1f140>, '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 0x2d1fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1fed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:40 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:40 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:40 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:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:40 INFO - Return code: 0 05:16:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:16:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:40 INFO - ENV: RUST_BACKTRACE is now 1 05:16:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:16:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:40 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-043', '--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:40 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-043 --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:40 INFO - Using env: {'DISPLAY': ':0', 05:16:40 INFO - 'HOME': '/home/cltbld', 05:16:40 INFO - 'LANG': 'en_US.UTF-8', 05:16:40 INFO - 'LANGUAGE': 'en_US:en', 05:16:40 INFO - 'LOGNAME': 'cltbld', 05:16:40 INFO - 'MAIL': '/var/mail/cltbld', 05:16:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:40 INFO - 'MOZ_NO_REMOTE': '1', 05:16:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:40 INFO - 'NO_EM_RESTART': '1', 05:16:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:40 INFO - 'PWD': '/builds/slave/test', 05:16:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:40 INFO - 'RUST_BACKTRACE': '1', 05:16:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:16:40 INFO - 'SHELL': '/bin/bash', 05:16:40 INFO - 'SHLVL': '1', 05:16:40 INFO - 'TERM': 'linux', 05:16:40 INFO - 'TMOUT': '86400', 05:16:40 INFO - 'USER': 'cltbld', 05:16:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000', 05:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:40 INFO - '_': '/tools/buildbot/bin/python'} 05:16:40 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-043', '--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:40 INFO - mozversion application_buildid: 20170607113307 05:16:40 INFO - mozversion application_changeset: f6320f91851c2cede08b0fb54a6d0525b870310e 05:16:40 INFO - mozversion application_display_name: Nightly 05:16:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:40 INFO - mozversion application_name: Firefox 05:16:40 INFO - mozversion application_remotingname: firefox 05:16:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:40 INFO - mozversion application_vendor: Mozilla 05:16:40 INFO - mozversion application_version: 55.0a1 05:16:40 INFO - mozversion platform_buildid: 20170607113307 05:16:40 INFO - mozversion platform_changeset: f6320f91851c2cede08b0fb54a6d0525b870310e 05:16:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:40 INFO - mozversion platform_version: 55.0a1 05:16:40 INFO - using testdate: 1496837800 05:16:40 INFO - actual date: 1496837800 05:16:40 INFO - starting webserver on 'localhost:50070' 05:16:40 INFO - SUITE-START | Running 2 tests 05:16:40 INFO - TEST-START | dromaeo_css 05:16:40 INFO - operating with platform_type : linux_ 05:16:40 INFO - Initialising browser for dromaeo_css test... 05:16:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50070/getInfo.html -profile /tmp/tmpLTSw7U/profile 05:16:40 INFO - TEST-INFO | started process 20711 (/builds/slave/test/build/application/firefox/firefox http://localhost:50070/getInfo.html) 05:17:15 INFO - TEST-INFO | 20711: killed by SIGTERM 05:17:16 INFO - Browser initialized. 05:17:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:16 INFO - TEST-INFO | started process 20943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLTSw7U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:27 INFO - PID 20943 | RSS: Main: 188608512 05:17:27 INFO - PID 20943 | 05:20:28 INFO - PID 20943 | Cycle 1(1): loaded http://localhost:50070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50070/tests/dromaeo/cssquery-ext.html) 05:20:29 INFO - PID 20943 | RSS: Main: 186880000 05:20:29 INFO - PID 20943 | 05:23:31 INFO - PID 20943 | Cycle 1(1): loaded http://localhost:50070/tests/dromaeo/cssquery-ext.html (next: http://localhost:50070/tests/dromaeo/cssquery-jquery.html) 05:23:32 INFO - PID 20943 | RSS: Main: 190853120 05:23:32 INFO - PID 20943 | 05:26:34 INFO - PID 20943 | Cycle 1(1): loaded http://localhost:50070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50070/tests/dromaeo/cssquery-mootools.html) 05:26:34 INFO - PID 20943 | RSS: Main: 188825600 05:26:34 INFO - PID 20943 | 05:29:36 INFO - PID 20943 | Cycle 1(1): loaded http://localhost:50070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50070/tests/dromaeo/cssquery-prototype.html) 05:29:37 INFO - PID 20943 | RSS: Main: 192266240 05:29:37 INFO - PID 20943 | 05:32:39 INFO - PID 20943 | Cycle 1(1): loaded http://localhost:50070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50070/tests/dromaeo/cssquery-yui.html) 05:32:40 INFO - PID 20943 | RSS: Main: 189026304 05:32:40 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | Cycle 1(1): loaded http://localhost:50070/tests/dromaeo/cssquery-yui.html (next: http://localhost:50070/tests/dromaeo/cssquery-dojo.html) 05:35:42 INFO - PID 20943 | RSS: Main: 191049728 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | __start_tp_report 05:35:42 INFO - PID 20943 | _x_x_mozilla_page_load 05:35:42 INFO - PID 20943 | _x_x_mozilla_page_load_details 05:35:42 INFO - PID 20943 | |i|pagename|runs| 05:35:42 INFO - PID 20943 | |0;dojo.html;3075.138961090894;3081.938361232777;3100.1629560018787;3106.6272047354305;3113.330633913708;5893.675847828367;6000.75996960121;6012.879742405149;6039.27528696556;6048.516118710503;5931.288245410546;5984.910226346608;6019.488343490809;6094.481969032627;6108.908366374508;5476.945230547703;5518.668879867211;5586.24585680934;5600;5608.495235428811;5609.76585151266;5664.291963504562;5682.6306290091015;5693.231413759131;5702.173184888189;5436.646617969859;5441.238226648273;5502.972485137549;5554.472325129106;5582.832515024576;5549.278593782823;5566.610337276392;5578.525825304854;5605.495505404492;5613.9157912630935;5540.279763630702;5540.86147846303;5546.084895992157;5546.889062218774;5568.192612071268;5814.680192589406;5996.5202783777195;6013.879722405572;6023.518118550549;6030.547708921848;6337.017762246859;6378.330275321071;6441.871162576722;6451.322611125811;6508.153939987818;6583.93416065838;6606.075149479077;6614.173228346457;6615.702293396808;6628.801135965929;6103.23709536308;6119.418655227791;6126.877462450726;6127.785527506516;6131.110988906584;6410.711517981609;6498.122753428322;6548.8362790930605;6585.769498067544;6662.267150613428;6184.319724830265;6224.159738435344;6284.057391391328;6387.744490220432;6393.9360606394275;6456.677166141674;6508.837279068061;6523.902141467882;6541.313162118005;6550.115734375893;6526.543141980016;6535.836604084936;6538.1827271591055;6542.280349161589;6547.9672601636685;6203.503719702413;6318.304986451487;6338.556301058881;6467.385598368148;6473.417392434703;5240.737963101829;5250.973745131327;5253.028189784902;5264.236685680555;5294.894102117936;4474.351219073216;4478.641708663299;4482.7758612069265;4483.2602620567895;4520.095980803852;5470.152126420411;5565.972170139124;5579.7489112990015;5683.062294721325;5745.511631511285;6403.839904002344;6483.546151769425;6525.510586706016;6527.2167339919515;6535.509836762262;5633.436656334416;5667.688277144796;5705.600607957404;5715.685637289989;5731.140328950691;5454.509094181463;5602.13166959122;5608.298962629671;5613.550915926716;5617;6185.907211391833;6228.875422491616;6284.937150628435;6337.493000559852;6354.6822658867795;6559.048937904073;6569;6589.439897608565;6592.7033283503315;6596.241432235354;6252.749890004349;6280.152179455898;6288.654124023223;6291.087792270187;6299.874002520016;6136.243373036893;6214.5960512566535;6264.68676566179;6340.890344189841;6362.204724409449;6571.145751052524;6573.57271777333;6575.375339342755;6589.538732288694;6602.636854973022;6134.987727024991;6209.937900620936;6310.116583678197;6317.241930968313;6334.841628959313;6232.501399888089;6317.6209427434505;6339.492840572835;6343.3022367538615;6345.96827015862;6032.215811944595;6086.60437071589;6099.695015249131;6133;6137.3862613738265;6060.787872424444;6170.197874276315;6250.687465626609;6254.249490061222;6282.340354262919;6084;6131.132004888217;6152.169457123231;6162.938370616236;6191.597546159485 05:35:42 INFO - PID 20943 | |1;ext.html;686.7390391651174;732.5714457042629;762;1156.629878438899;1166.3643314393655;36728;37897.24205515892;38033.429498557474;38051.04872378188;38154;40297.19405611886;40691.18617627646;40741.7962910185;40772.59227407725;40792;7235.493515453921;7410.70357185712;7478.14001389839;7610.124835643916;7612.885806712876;6921.100256966587;6944.6180460074675;6987.161540615133;7002.229754727002;7021.262767409399;7006.929930700704;7010.859782804341;7051.224365319811;7055.611941343224;7070.222275549685;6956.79129626112;7030;7031.929680703204;7040.471964602675;7042.5070245083125;7020.684069216897;7070.29297070294;7077.893831592531;7108.751193708195;7116;36263;36601;36670.633293666986;36678.449823252675;36824.631753682654;3397.184675677844;3430.3996800559803;3430.451127819562;3441.9827900860337;3442.8794992175153;28101.297467563476;28266.717332826614;28346.858265708746;28361.14916552507;28361.432771344666;3570.1610121621397;3573.249617580311;3577.0342007657787;3584.2831433713363;3594.2991116732246;127018.36490817579;131308.74765009483;131549.34225328907;160499;161348;38820.41769373462;39359.606403936166;39430.40854387187;39506.80246598806;39521.60478395237;40741;40950.79524602417;41000.38499422511;41035.7948210263;41192.79403603023;14959.102453852804;15139;15185.924070379577;15228.619284517754;15239.314230859638;12335.814962775565;12361.320127393079;12410.007199424024;12431.31627760482;12436.75126497465;13902.443902244;13967.650808729863;13984.720305593832;14143.22212278314;14261.144331340152;5532.446755324436;5573.69344686038;5586.91619625706;5756.798512052058;5758;992.8461088531145;1002.819492491344;1009.8939611340703;1025.1696126137851;1029.6859457865273;22510.54978900413;22757.772422275564;23185.884070579537;23430.882845585664;24270.75729242685;1076.6500887211687;1097.8133717268083;1099.7092779332625;1109.877913429522;1132.5016992523429;12164.635060948185;12296.262224266573;12547.3098979557;12799.424025918855;12981.610551683465;158882;159036;176680;179096;207265;50764;51196;51242.74378628083;51340.22989655158;51487.48512514902;1392.512620582788;1439.0789894467548;1440.762274224741;1455.7306898223862;1465.6702241995465;25986.48027039411;28458.223617330317;28589.714102858707;28603.14190574286;28816.567751483326;36119.09702257464;36561.45157822582;36674;36674;36729.44905826361;166437;167991;168684.15657921633;168931;169483;34801.12997175091;35155.824220878734;35181.29637407186;35468.46797297991;35473.64526354807;40989.59010409858;41151;41175.58824411718;41635.375469367376;42448.5755142457;29445.852770736008;29824.552631710107;30616.540751889184;30665.386692266475;31958.52062219115;26317;27491.587626186025;27515;28063.859680702284;28474.715252847207;34534.48198277078;34667.826660866536;34972.825135874155;35063.82468087643;35157.648423515435;27593.17220483389;28186.29534261578;29071.7092829069;29630.11109666627;30162.245943850703;22216.222432214796;24226.87886560556;24283;24283.757162428148;24295.878520607283 05:35:42 INFO - PID 20943 | |2;jquery.html;409.5167702111511;410.7453378905079;424.4566954298498;425.22608851889555;440.3548801006525;20337.38987830364;21054.684179737316;21212.151513939443;21242.256521021747;23142;23278;23878.40303992401;23880.761192388116;23950.922208500615;23978.52042959144;5804.361520232771;5923.466887980081;5943;5943.702814859262;5948;6066.090086487018;6072.6356418614805;6099.634021958696;6114.571979961404;6116.816495505142;5774.595778295521;5920.259967504062;5946.197263369455;5948.524118070565;5967.701614919259;5942.286925568917;5950.523958083343;5976.760929562813;5988.461038506512;6007.219061521996;5364.839054828361;5365.678059316415;5367.543758780469;5370.516653501165;5377.381601115843;26361.472770544482;26413.867930660417;26426.07857724153;26745.197644070708;26794.330141746417;1844.9907750461296;1905.2188602672838;1907.4945139538033;1913.3877159309027;1915.454095582766;16930.661386772317;17382;17383.652326953517;17416.564585885328;17453.389131380467;2182.0944308112116;2226.3543572363997;2267.841251112423;2268.9319320420414;2274.6588011798362;113873;117081;120475;121928;123184;11469.942650286695;11573.775571916358;11585.826212606818;11887.70280742971;12135.271883687006;16394.83605163957;16700.74948875768;16722.665546688997;16787.83212167887;16892.746608800877;8169.63236654352;8433.19884610961;8862.512561809033;8868.8669669955;9094.226990705733;8694.608742606599;8716.215540601377;8885.689000884939;8895.421797583136;8947.284217262604;7560.092788865371;7815.374770018385;7837.177096404909;7899.170587088388;7934.206579342135;2080.9687854682193;2087.3007542473442;2145.656694928835;2146.5599552091785;2298.0577963035075;965.5124162297994;971.8785151856018;974.3861367338532;993.3146129170849;1010.1060561403211;18838.71741923872;19143.13855876461;19376;19417.611647766964;19516;987.2151639446657;1014.6854475112739;1015.9898401016043;1024.1653052762124;1035.0477560644226;10122.39265644049;10323.690289291333;10769.261405500167;10874.728131796768;11041.056744037356;433023;441577;446005;448320;448920;95713;96637.51681241549;98142.50928745454;98529;98843.50578247063;1145.3357052909294;1150.4535345710888;1177.917545771805;1178.5168081086713;1188.6552899659002;15982.200889955224;16593.91703041477;16834;16970.575735606708;17624.82375176283;44755;46136.307955381366;46684.299735504675;47190.76404617955;47842.760786195846;57872.421275786706;58510.7074464625;63294.68352658207;66318.66840665959;66590.66704666446;10119.79760404773;10369.688909332732;10490.475476226311;10556.102731267621;10560.15518758513;17328.13359332003;17898.91050544791;19106.808931910502;19136.71294930605;19230.711539326643;15323.387064517294;15703.450379236672;15742.425757424166;15790.289436975134;15830.44593439224;13319.86680133225;14322.283885805877;14330.856691432953;14474.710505790035;14477.131372117707;15674;15834.28745706469;15949.920250398674;16212.513624591282;16285;10219;10285.84571231447;10331.793364132825;10356.741081473023;10376.584936602452;15290.159041252839;15307.234638267819;15331.386744530093;15344.769828452805;15411.845881541041 05:35:42 INFO - PID 20943 | |3;mootools.html;1324.112844394256;1385.6743665238673;1386.5008596905113;1393.728222996515;1395.6510872281926;10633.52149153288;10879.292845965027;11226.04578610818;11227.326360418381;11623.244489108223;11090;11258.211925165242;11287.209895307331;11318.886811131886;11323.037541808957;2203.162798136706;2220.744614369352;2225.721784776903;2237.8097861681695;2240.215924426446;2305.5734689082487;2320.385097949045;2340.929772106831;2343.250159948817;2343.273585188597;2232.0513781642817;2234.530748542808;2237.429455488848;2254.0983606557425;2257.819374450048;2192.802647761693;2218.5230175512343;2221.1115553778536;2224.2993457061057;2231.6764069210035;1911.7323574699553;1975.3580086471811;2199.978000220009;2205.8014778669994;2208.182972300243;10920.2901811382;10963.61627343047;11019.614313498989;11027.72430689231;11047.613333533369;6017.308009578911;6288.496920246369;6301.054841773725;6305.621662700252;6314.463270621956;3477.669621385964;3647.6534729200685;3682.1899182179877;3721.0325315417917;3747.7189210809024;1284.4990453723055;1288.6005338345049;1288.9613311600667;1293.72831705342;1317.683755898587;15864.682706345808;16080.59798505035;16085.919570402073;16092.356305747757;16117.388261173788;5047.4447810740785;5054;5171.146760784429;5177.456367081478;5180.533751962342;11719.355435450962;11748.70628234301;11790.292582445081;11795.469203885847;11856.407179640983;5673.290838645169;6165.075238714139;6174.9073763893575;6181.1655426516845;6187.133801267826;5576.581756368289;5762.337331206881;5805.477507024388;5822.359540450547;5834.212381328552;4021.2158629067053;4066.3087275163293;4070.3690927906223;4133.545310015896;4142.357934520154;1151.4473052934638;1162.9709257268637;1170.1984140863535;1180.8819118088295;1181.9704507387385;783.6003638144588;818.1981657975217;822.4653974916353;829.4276948905236;829.9668013279402;6202.303180115013;6389.7124629390855;6451.903221451682;6483.157189565326;6725.831854203684;988.7923536057365;992.8724517769085;997.2719914462483;1009.1271050541376;1018.8064267789097;3671.7980511072146;3681.1349332906743;3747.9063023424633;3768.886933391948;3884.7086468514976;13256.73486530264;13903.582892513241;14125.434982600786;14150.85849141516;14167;13628.591142265748;13632.93183534076;13697.178169309675;13744.106633068819;13763.931180344034;8867.201951824367;8958.507282099547;9077.954610226907;9094.81810363789;9147.268218542633;5834.620749651259;6170.753169873155;6274.403931626488;6302.338254483397;6355.332690067661;12600;12930.159539629894;13045.934770326467;13050.804237936249;13055.738885222052;12861;12968.610941671765;12981.935090324489;13180.670483237996;13361.732765344444;8037.598120094089;8093.0692970309165;8109.189081091844;8209.05595856484;8212.260896519341;10438.164946804389;10497.160227181654;10499.160067194452;10500.789984200426;10514;8559.957200214209;8736.432131911406;8854.203121719076;9159.175674189355;9186;8707.91292087071;8760.912390876265;8766.517841518778;8851.69019084329;8857.867131992896;7415.147258065392;7453.515521491086;7466.887996679946;7512.32389084985;7514.8497030058;5143.177091665465;5384.865378365415;5397.622166448468;5479.369872464717;5488.396276409512;5434.538064264424;5527.861803454945;5554.638948468337;5657.547396208376;5667.829965101054 05:35:42 INFO - PID 20943 | |4;prototype.html;383.29856362855975;395.0656696911804;395.84068904127986;402.73822015689797;405.43441898551504;6163.845903852395;6267.153934218879;6339.619622822628;6364.649944253064;6383.489320854332;6050.939490605093;6072.848178795522;6103.847403814907;6125.5712100153005;6128.877422451548;4745.501722319159;4776.761161941907;4779.187538118511;4789.544993225638;4791.808327666898;4758.3576217210575;4764.85705428836;4775.474697783258;4784.97607511962;4786.4974177711365;4721.268203428474;4735.50277220892;4735.763211839411;4745.169595320823;4747.335373047776;4729.385179926605;4732.455767586703;4733.650909490813;4736.171170045262;4741.454732705749;4138.6482149017365;4153.439285696422;4160.9375859362135;4172.499300083979;4178.289690752579;6029.517638588903;6087.078202462799;6095.756169753205;6115.7859474918605;6137.508999280091;5370.865728356823;5378.327709036371;5400.540954018913;5400.810971615974;5412.5940554458575;6517.967410162919;6521.47828173745;6537;6582.473402127818;6592.505562082815;4471.6646251531265;4519.0400287811535;4520.98277887476;4547.840825571089;4548.8862778430475;6530.869382612321;6854.828629284208;6919.550229235084;6921.93078069223;6993.580385176906;4643.3731446255;4647.37260469839;4649.093426781813;4656.254999200111;4680.789364478538;4654.301854721751;4656.650751193674;4670.929936050962;4680.7191568506;4701.600363969101;5242.449542797951;5394.217838413408;5407.215953686693;5417.295751552352;5432.402435732066;6524.553292515307;6548.48154773205;6554.9672251639395;6559.672016399161;6568.503968491942;1607.6543543138282;1614.1848366574804;1620.1980019889995;1630.184907546227;1634.6648936967892;1041.8020576090519;1087.6947662804666;1087.907527860125;1091.3233795046963;1107.9972624774591;5818.679972601463;5824.184614154022;5877.52979761618;5878.970605146947;5900;6721.22705888829;6756.76351327711;6767.627780472121;6777.423918966844;6817.659117044128;5760.8271751847515;5781.132830075522;5818.418158184148;5849.151872978395;5875.618084824473;3604.7837129772297;3607.8196090195383;3609.187932715118;3609.5668519777796;3627.836747346376;6592.703328350236;6592.901106483407;6596.307387724316;6615.272320044791;6678.96660516704;6963.8064009836735;6966.164060312693;6973.58158510491;6984.79045628632;6992.755253566203;6591.274959754423;6614.503912206507;6618.6690665467495;6645.700943457556;6659.2008958925235;6661.533692641468;6753.662316884234;6758.187958355712;6761.22245941723;6827;6386.966191059396;6576.210854697467;6671.432928200963;6692.631905245258;6751.189857217166;6506.869862602816;6536.117624120683;6583.242927063449;6591;6599.548099418121;4656.5110663379855;4659.370984916993;4660;4684.859454216379;4688.859334219979;6577.552938353555;6848.691808868513;6855.862882742217;6869.828254293483;6872.278410766798;6559.376859198369;6594.670266486753;6605.669716514251;6616;6632.204135503771;6523.804285871432;6530.869382612226;6555.508336874658;6613.933860661332;6622.205335359788;6453.419192272718;6494.6103233806125;6504.642244676588;6512.185976752906;6538.607683539003;6638.867222655616;6648.501362397937;6658.134442522635;6659.467242620675;6670.566413183127;6375.489960803217;6396.552241343247;6423.807285781434;6434.8391290218115;6473 05:35:42 INFO - PID 20943 | |5;yui.html;811.2374368093988;839.811042515434;849.7535714642754;859.6303589456534;860.9926386128229;16929.746053809187;17310.307587696494;17310.913445432772;18853.340133095346;20306.492337691565;17853.821461785377;18508.167132479037;18775.81224187758;18818.905905470452;18963.431097067074;963.5519483440216;999.3454287441738;1002.1882275356948;1004.3020101029787;1004.5228516454662;700.0828914122491;714.8284411741197;1012.488693209928;1016.0398423489805;1016.4257194685016;999.990000099997;1048.643461223184;1050.842373643952;1052.2581579986092;1052.9420881851495;1028.1517747858009;1032.5611615063606;1033.1837848099992;1033.7415646088516;1037;743.8735414979467;747.9925200747978;750.2347605442473;751.3012898004853;752.6913965274266;17079.743803842954;17289.913550432295;17447.12764361777;17566;17663;17440.738388924176;17502;17562.473125806246;17604.91197544017;17726;16655.66688666232;17353.2191051403;17442.651146977118;17484.300627974993;17536;5086.745662716887;5140.228965655144;5168.457311982263;5217.921731174036;5220.399654039758;83538.58230708807;84762.59035963839;92988;95349.523252384;95759;15201.847981520043;15412.845871541365;15468.22658867052;15517.767233491506;15529.844701553066;25388.74611253864;25869.482610348063;26111.216663500127;26147.869260653573;27446.313842153708;7659.234076592407;7840.568768717661;8018.158093400226;8102.270795628422;8112.918870811334;3730.5896351401325;3788.6400791924725;3825.158465137665;3833.0225792422752;3841.8847434577006;4097.344424892003;4214.157168566299;4244.893877653021;4252.723572967747;4252.766097864585;797.194833218442;808.5148910653678;809.3161278719473;813.4305985809957;814.3973459639824;684.3191024930227;706.7773651299824;715.4205093873978;720.5964659790534;722.288545782404;10416.32293900894;11378.601748938747;11898.524059037714;12379.69050773738;13115.934420327838;679.5481005131533;685.2873012067494;697.1320705721308;711.8825393810067;718.7196993172666;4613.515580864028;4855.562999330006;4922.064807686528;4992.675476094042;5013;82887;84531.57734211412;85828.57085714531;87009.12990870138;88231.11768882358;70161;72577.63711181516;72814;73248.26751732414;74256.62871685714;63120.36879631237;63876.68061659662;65287;66514.66742666256;67260.66369668121;10405.323653962469;10951.671449856518;11498.425078745862;11630.53477860876;11771.646850594496;28418.289542761595;28733;29078.41843163167;29257;29944.700552994193;56926.715366422904;57006.429935700115;57666.42333576778;57805;58460.4153958455;15763.211839408214;15785.605359865636;15941.44204952821;16060.277287521856;16158.353665853234;16040;18381.908090459463;19177.13702883346;19429.902850485658;19941.501462463555;16133.193340333171;16375.181240937667;16500;16577.834221657627;16825.74761378556;17760.91119544394;17847;17910.10449477547;18010.189541470405;18105.547361316072;15401.306941187897;15555.222238888236;15738.842611573738;15775.921120394325;15862.44481443144;10533.894661053291;11095.72260693489;11243.156763242627;11374.943125284652;11376.260543064674;13943.511977080754;14000.509982150576;14182.14907105577;14236.715265694422;14248.35882385316 05:35:42 INFO - PID 20943 | __end_tp_report 05:35:42 INFO - PID 20943 | __start_cc_report 05:35:42 INFO - PID 20943 | _x_x_mozilla_cycle_collect,390 05:35:42 INFO - PID 20943 | __end_cc_report 05:35:42 INFO - PID 20943 | __startTimestamp1496838942740__endTimestamp 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | ------- Summary: start ------- 05:35:42 INFO - PID 20943 | Number of tests: 6 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | [#0] dojo.html Cycles:165 Average:5954.56 Median:6134.99 stddev:691.30 (11.3%) stddev-sans-first:655.48 05:35:42 INFO - PID 20943 | Values: 3075.1 3081.9 3100.2 3106.6 3113.3 5893.7 6000.8 6012.9 6039.3 6048.5 5931.3 5984.9 6019.5 6094.5 6108.9 5476.9 5518.7 5586.2 5600.0 5608.5 5609.8 5664.3 5682.6 5693.2 5702.2 5436.6 5441.2 5503.0 5554.5 5582.8 5549.3 5566.6 5578.5 5605.5 5613.9 5540.3 5540.9 5546.1 5546.9 5568.2 5814.7 5996.5 6013.9 6023.5 6030.5 6337.0 6378.3 6441.9 6451.3 6508.2 6583.9 6606.1 6614.2 6615.7 6628.8 6103.2 6119.4 6126.9 6127.8 6131.1 6410.7 6498.1 6548.8 6585.8 6662.3 6184.3 6224.2 6284.1 6387.7 6393.9 6456.7 6508.8 6523.9 6541.3 6550.1 6526.5 6535.8 6538.2 6542.3 6548.0 6203.5 6318.3 6338.6 6467.4 6473.4 5240.7 5251.0 5253.0 5264.2 5294.9 4474.4 4478.6 4482.8 4483.3 4520.1 5470.2 5566.0 5579.7 5683.1 5745.5 6403.8 6483.5 6525.5 6527.2 6535.5 5633.4 5667.7 5705.6 5715.7 5731.1 5454.5 5602.1 5608.3 5613.6 5617.0 6185.9 6228.9 6284.9 6337.5 6354.7 6559.0 6569.0 6589.4 6592.7 6596.2 6252.7 6280.2 6288.7 6291.1 6299.9 6136.2 6214.6 6264.7 6340.9 6362.2 6571.1 6573.6 6575.4 6589.5 6602.6 6135.0 6209.9 6310.1 6317.2 6334.8 6232.5 6317.6 6339.5 6343.3 6346.0 6032.2 6086.6 6099.7 6133.0 6137.4 6060.8 6170.2 6250.7 6254.2 6282.3 6084.0 6131.1 6152.2 6162.9 6191.6 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | [#1] ext.html Cycles:180 Average:32745.63 Median:18988.68 stddev:42163.60 (222.0%) stddev-sans-first:42213.15 05:35:42 INFO - PID 20943 | Values: 686.7 732.6 762.0 1156.6 1166.4 36728.0 37897.2 38033.4 38051.0 38154.0 40297.2 40691.2 40741.8 40772.6 40792.0 7235.5 7410.7 7478.1 7610.1 7612.9 6921.1 6944.6 6987.2 7002.2 7021.3 7006.9 7010.9 7051.2 7055.6 7070.2 6956.8 7030.0 7031.9 7040.5 7042.5 7020.7 7070.3 7077.9 7108.8 7116.0 36263.0 36601.0 36670.6 36678.4 36824.6 3397.2 3430.4 3430.5 3442.0 3442.9 28101.3 28266.7 28346.9 28361.1 28361.4 3570.2 3573.2 3577.0 3584.3 3594.3 127018.4 131308.7 131549.3 160499.0 161348.0 38820.4 39359.6 39430.4 39506.8 39521.6 40741.0 40950.8 41000.4 41035.8 41192.8 14959.1 15139.0 15185.9 15228.6 15239.3 12335.8 12361.3 12410.0 12431.3 12436.8 13902.4 13967.7 13984.7 14143.2 14261.1 5532.4 5573.7 5586.9 5756.8 5758.0 992.8 1002.8 1009.9 1025.2 1029.7 22510.5 22757.8 23185.9 23430.9 24270.8 1076.7 1097.8 1099.7 1109.9 1132.5 12164.6 12296.3 12547.3 12799.4 12981.6 158882.0 159036.0 176680.0 179096.0 207265.0 50764.0 51196.0 51242.7 51340.2 51487.5 1392.5 1439.1 1440.8 1455.7 1465.7 25986.5 28458.2 28589.7 28603.1 28816.6 36119.1 36561.5 36674.0 36674.0 36729.4 166437.0 167991.0 168684.2 168931.0 169483.0 34801.1 35155.8 35181.3 35468.5 35473.6 40989.6 41151.0 41175.6 41635.4 42448.6 29445.9 29824.6 30616.5 30665.4 31958.5 26317.0 27491.6 27515.0 28063.9 28474.7 34534.5 34667.8 34972.8 35063.8 35157.6 27593.2 28186.3 29071.7 29630.1 30162.2 22216.2 24226.9 24283.0 24283.8 24295.9 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | [#2] jquery.html Cycles:180 Average:30516.31 Median:11693.96 stddev:74412.37 (636.3%) stddev-sans-first:74586.78 05:35:42 INFO - PID 20943 | Values: 409.5 410.7 424.5 425.2 440.4 20337.4 21054.7 21212.2 21242.3 23142.0 23278.0 23878.4 23880.8 23950.9 23978.5 5804.4 5923.5 5943.0 5943.7 5948.0 6066.1 6072.6 6099.6 6114.6 6116.8 5774.6 5920.3 5946.2 5948.5 5967.7 5942.3 5950.5 5976.8 5988.5 6007.2 5364.8 5365.7 5367.5 5370.5 5377.4 26361.5 26413.9 26426.1 26745.2 26794.3 1845.0 1905.2 1907.5 1913.4 1915.5 16930.7 17382.0 17383.7 17416.6 17453.4 2182.1 2226.4 2267.8 2268.9 2274.7 113873.0 117081.0 120475.0 121928.0 123184.0 11469.9 11573.8 11585.8 11887.7 12135.3 16394.8 16700.7 16722.7 16787.8 16892.7 8169.6 8433.2 8862.5 8868.9 9094.2 8694.6 8716.2 8885.7 8895.4 8947.3 7560.1 7815.4 7837.2 7899.2 7934.2 2081.0 2087.3 2145.7 2146.6 2298.1 965.5 971.9 974.4 993.3 1010.1 18838.7 19143.1 19376.0 19417.6 19516.0 987.2 1014.7 1016.0 1024.2 1035.0 10122.4 10323.7 10769.3 10874.7 11041.1 433023.0 441577.0 446005.0 448320.0 448920.0 95713.0 96637.5 98142.5 98529.0 98843.5 1145.3 1150.5 1177.9 1178.5 1188.7 15982.2 16593.9 16834.0 16970.6 17624.8 44755.0 46136.3 46684.3 47190.8 47842.8 57872.4 58510.7 63294.7 66318.7 66590.7 10119.8 10369.7 10490.5 10556.1 10560.2 17328.1 17898.9 19106.8 19136.7 19230.7 15323.4 15703.5 15742.4 15790.3 15830.4 13319.9 14322.3 14330.9 14474.7 14477.1 15674.0 15834.3 15949.9 16212.5 16285.0 10219.0 10285.8 10331.8 10356.7 10376.6 15290.2 15307.2 15331.4 15344.8 15411.8 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | [#3] mootools.html Cycles:180 Average:6741.54 Median:2343.26 stddev:4333.12 (184.9%) stddev-sans-first:4326.16 05:35:42 INFO - PID 20943 | Values: 1324.1 1385.7 1386.5 1393.7 1395.7 10633.5 10879.3 11226.0 11227.3 11623.2 11090.0 11258.2 11287.2 11318.9 11323.0 2203.2 2220.7 2225.7 2237.8 2240.2 2305.6 2320.4 2340.9 2343.3 2343.3 2232.1 2234.5 2237.4 2254.1 2257.8 2192.8 2218.5 2221.1 2224.3 2231.7 1911.7 1975.4 2200.0 2205.8 2208.2 10920.3 10963.6 11019.6 11027.7 11047.6 6017.3 6288.5 6301.1 6305.6 6314.5 3477.7 3647.7 3682.2 3721.0 3747.7 1284.5 1288.6 1289.0 1293.7 1317.7 15864.7 16080.6 16085.9 16092.4 16117.4 5047.4 5054.0 5171.1 5177.5 5180.5 11719.4 11748.7 11790.3 11795.5 11856.4 5673.3 6165.1 6174.9 6181.2 6187.1 5576.6 5762.3 5805.5 5822.4 5834.2 4021.2 4066.3 4070.4 4133.5 4142.4 1151.4 1163.0 1170.2 1180.9 1182.0 783.6 818.2 822.5 829.4 830.0 6202.3 6389.7 6451.9 6483.2 6725.8 988.8 992.9 997.3 1009.1 1018.8 3671.8 3681.1 3747.9 3768.9 3884.7 13256.7 13903.6 14125.4 14150.9 14167.0 13628.6 13632.9 13697.2 13744.1 13763.9 8867.2 8958.5 9078.0 9094.8 9147.3 5834.6 6170.8 6274.4 6302.3 6355.3 12600.0 12930.2 13045.9 13050.8 13055.7 12861.0 12968.6 12981.9 13180.7 13361.7 8037.6 8093.1 8109.2 8209.1 8212.3 10438.2 10497.2 10499.2 10500.8 10514.0 8560.0 8736.4 8854.2 9159.2 9186.0 8707.9 8760.9 8766.5 8851.7 8857.9 7415.1 7453.5 7466.9 7512.3 7514.8 5143.2 5384.9 5397.6 5479.4 5488.4 5434.5 5527.9 5554.6 5657.5 5667.8 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | [#4] prototype.html Cycles:180 Average:5438.11 Median:6109.82 stddev:1622.79 (26.6%) stddev-sans-first:1582.37 05:35:42 INFO - PID 20943 | Values: 383.3 395.1 395.8 402.7 405.4 6163.8 6267.2 6339.6 6364.6 6383.5 6050.9 6072.8 6103.8 6125.6 6128.9 4745.5 4776.8 4779.2 4789.5 4791.8 4758.4 4764.9 4775.5 4785.0 4786.5 4721.3 4735.5 4735.8 4745.2 4747.3 4729.4 4732.5 4733.7 4736.2 4741.5 4138.6 4153.4 4160.9 4172.5 4178.3 6029.5 6087.1 6095.8 6115.8 6137.5 5370.9 5378.3 5400.5 5400.8 5412.6 6518.0 6521.5 6537.0 6582.5 6592.5 4471.7 4519.0 4521.0 4547.8 4548.9 6530.9 6854.8 6919.6 6921.9 6993.6 4643.4 4647.4 4649.1 4656.3 4680.8 4654.3 4656.7 4670.9 4680.7 4701.6 5242.4 5394.2 5407.2 5417.3 5432.4 6524.6 6548.5 6555.0 6559.7 6568.5 1607.7 1614.2 1620.2 1630.2 1634.7 1041.8 1087.7 1087.9 1091.3 1108.0 5818.7 5824.2 5877.5 5879.0 5900.0 6721.2 6756.8 6767.6 6777.4 6817.7 5760.8 5781.1 5818.4 5849.2 5875.6 3604.8 3607.8 3609.2 3609.6 3627.8 6592.7 6592.9 6596.3 6615.3 6679.0 6963.8 6966.2 6973.6 6984.8 6992.8 6591.3 6614.5 6618.7 6645.7 6659.2 6661.5 6753.7 6758.2 6761.2 6827.0 6387.0 6576.2 6671.4 6692.6 6751.2 6506.9 6536.1 6583.2 6591.0 6599.5 4656.5 4659.4 4660.0 4684.9 4688.9 6577.6 6848.7 6855.9 6869.8 6872.3 6559.4 6594.7 6605.7 6616.0 6632.2 6523.8 6530.9 6555.5 6613.9 6622.2 6453.4 6494.6 6504.6 6512.2 6538.6 6638.9 6648.5 6658.1 6659.5 6670.6 6375.5 6396.6 6423.8 6434.8 6473.0 05:35:42 INFO - PID 20943 | 05:35:42 INFO - PID 20943 | [#5] yui.html Cycles:180 Average:19388.99 Median:25629.11 stddev:23879.81 (93.2%) stddev-sans-first:23906.04 05:35:42 INFO - PID 20943 | Values: 811.2 839.8 849.8 859.6 861.0 16929.7 17310.3 17310.9 18853.3 20306.5 17853.8 18508.2 18775.8 18818.9 18963.4 963.6 999.3 1002.2 1004.3 1004.5 700.1 714.8 1012.5 1016.0 1016.4 1000.0 1048.6 1050.8 1052.3 1052.9 1028.2 1032.6 1033.2 1033.7 1037.0 743.9 748.0 750.2 751.3 752.7 17079.7 17289.9 17447.1 17566.0 17663.0 17440.7 17502.0 17562.5 17604.9 17726.0 16655.7 17353.2 17442.7 17484.3 17536.0 5086.7 5140.2 5168.5 5217.9 5220.4 83538.6 84762.6 92988.0 95349.5 95759.0 15201.8 15412.8 15468.2 15517.8 15529.8 25388.7 25869.5 26111.2 26147.9 27446.3 7659.2 7840.6 8018.2 8102.3 8112.9 3730.6 3788.6 3825.2 3833.0 3841.9 4097.3 4214.2 4244.9 4252.7 4252.8 797.2 808.5 809.3 813.4 814.4 684.3 706.8 715.4 720.6 722.3 10416.3 11378.6 11898.5 12379.7 13115.9 679.5 685.3 697.1 711.9 718.7 4613.5 4855.6 4922.1 4992.7 5013.0 82887.0 84531.6 85828.6 87009.1 88231.1 70161.0 72577.6 72814.0 73248.3 74256.6 63120.4 63876.7 65287.0 66514.7 67260.7 10405.3 10951.7 11498.4 11630.5 11771.6 28418.3 28733.0 29078.4 29257.0 29944.7 56926.7 57006.4 57666.4 57805.0 58460.4 15763.2 15785.6 15941.4 16060.3 16158.4 16040.0 18381.9 19177.1 19429.9 19941.5 16133.2 16375.2 16500.0 16577.8 16825.7 17760.9 17847.0 17910.1 18010.2 18105.5 15401.3 15555.2 15738.8 15775.9 15862.4 10533.9 11095.7 11243.2 11374.9 11376.3 13943.5 14000.5 14182.1 14236.7 14248.4 05:35:42 INFO - PID 20943 | -------- Summary: end -------- 05:35:42 INFO - PID 20943 | 05:35:43 INFO - TEST-INFO | 20943: exit 0 05:35:43 INFO - TEST-OK | dromaeo_css | took 1143282ms 05:35:43 INFO - TEST-START | kraken 05:35:43 INFO - operating with platform_type : linux_ 05:35:43 INFO - Initialising browser for kraken test... 05:35:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50070/getInfo.html -profile /tmp/tmpPj08ZE/profile 05:35:43 INFO - TEST-INFO | started process 21381 (/builds/slave/test/build/application/firefox/firefox http://localhost:50070/getInfo.html) 05:36:18 INFO - TEST-INFO | 21381: killed by SIGTERM 05:36:18 INFO - Browser initialized. 05:36:18 INFO - Running cycle 1/1 for kraken test... 05:36:18 INFO - TEST-INFO | started process 21613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPj08ZE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:30 INFO - PID 21613 | RSS: Main: 188043264 05:36:30 INFO - PID 21613 | 05:36:32 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50070/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:33 INFO - PID 21613 | RSS: Main: 193503232 05:36:33 INFO - PID 21613 | 05:36:36 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50070/tests/kraken/driver.html?testName=audio-dft) 05:36:37 INFO - PID 21613 | RSS: Main: 192233472 05:36:37 INFO - PID 21613 | 05:36:40 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50070/tests/kraken/driver.html?testName=audio-fft) 05:36:40 INFO - PID 21613 | RSS: Main: 188198912 05:36:40 INFO - PID 21613 | 05:36:42 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50070/tests/kraken/driver.html?testName=audio-oscillator) 05:36:43 INFO - PID 21613 | RSS: Main: 189136896 05:36:43 INFO - PID 21613 | 05:36:45 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:46 INFO - PID 21613 | RSS: Main: 188706816 05:36:46 INFO - PID 21613 | 05:36:49 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50070/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:50 INFO - PID 21613 | RSS: Main: 190111744 05:36:50 INFO - PID 21613 | 05:36:53 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50070/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:54 INFO - PID 21613 | RSS: Main: 189415424 05:36:54 INFO - PID 21613 | 05:36:57 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50070/tests/kraken/driver.html?testName=json-parse-financial) 05:36:57 INFO - PID 21613 | RSS: Main: 190005248 05:36:57 INFO - PID 21613 | 05:36:59 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:59 INFO - PID 21613 | RSS: Main: 190185472 05:36:59 INFO - PID 21613 | 05:37:01 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:02 INFO - PID 21613 | RSS: Main: 189444096 05:37:02 INFO - PID 21613 | 05:37:04 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:05 INFO - PID 21613 | RSS: Main: 190337024 05:37:05 INFO - PID 21613 | 05:37:08 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:08 INFO - PID 21613 | RSS: Main: 190148608 05:37:08 INFO - PID 21613 | 05:37:11 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:12 INFO - PID 21613 | RSS: Main: 189861888 05:37:12 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | Cycle 1(1): loaded http://localhost:50070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50070/tests/kraken/driver.html?testName=ai-astar) 05:37:14 INFO - PID 21613 | RSS: Main: 191528960 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | __start_tp_report 05:37:14 INFO - PID 21613 | _x_x_mozilla_page_load 05:37:14 INFO - PID 21613 | _x_x_mozilla_page_load_details 05:37:14 INFO - PID 21613 | |i|pagename|runs| 05:37:14 INFO - PID 21613 | |0;ai-astar;99;111;110;109;110;110;113;108;109;111 05:37:14 INFO - PID 21613 | |1;audio-beat-detection;143;123;120;167;122;126;131;122;153;121 05:37:14 INFO - PID 21613 | |2;audio-dft;164;165;165;163;164;165;179;170;166;161 05:37:14 INFO - PID 21613 | |3;audio-fft;79;73;73;113;73;74;73;73;97;74 05:37:14 INFO - PID 21613 | |4;audio-oscillator;83;84;99;85;83;84;100;85;85;105 05:37:14 INFO - PID 21613 | |5;imaging-gaussian-blur;118;115;113;114;113;114;114;113;115;117 05:37:14 INFO - PID 21613 | |6;imaging-darkroom;151;150;151;150;152;152;151;153;152;152 05:37:14 INFO - PID 21613 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;95;95 05:37:14 INFO - PID 21613 | |8;json-parse-financial;54;55;55;56;57;55;56;54;55;55 05:37:14 INFO - PID 21613 | |9;json-stringify-tinderbox;55;56;55;55;54;55;56;55;56;55 05:37:14 INFO - PID 21613 | |10;stanford-crypto-aes;83;87;86;85;92;86;86;87;121;84 05:37:14 INFO - PID 21613 | |11;stanford-crypto-ccm;146;143;141;131;134;135;128;132;136;129 05:37:14 INFO - PID 21613 | |12;stanford-crypto-pbkdf2;201;188;186;193;181;182;192;188;187;179 05:37:14 INFO - PID 21613 | |13;stanford-crypto-sha256-iterative;71;74;76;74;72;70;70;74;71;71 05:37:14 INFO - PID 21613 | __end_tp_report 05:37:14 INFO - PID 21613 | __start_cc_report 05:37:14 INFO - PID 21613 | _x_x_mozilla_cycle_collect,985 05:37:14 INFO - PID 21613 | __end_cc_report 05:37:14 INFO - PID 21613 | __startTimestamp1496839034466__endTimestamp 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | ------- Summary: start ------- 05:37:14 INFO - PID 21613 | Number of tests: 14 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.77 (3.4%) stddev-sans-first:1.45 05:37:14 INFO - PID 21613 | Values: 99.0 111.0 110.0 109.0 110.0 110.0 113.0 108.0 109.0 111.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:128.50 stddev:16.21 (12.6%) stddev-sans-first:16.76 05:37:14 INFO - PID 21613 | Values: 143.0 123.0 120.0 167.0 122.0 126.0 131.0 122.0 153.0 121.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:5.05 (3.1%) stddev-sans-first:5.29 05:37:14 INFO - PID 21613 | Values: 164.0 165.0 165.0 163.0 164.0 165.0 179.0 170.0 166.0 161.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#3] audio-fft Cycles:10 Average:80.20 Median:73.50 stddev:13.73 (18.7%) stddev-sans-first:14.55 05:37:14 INFO - PID 21613 | Values: 79.0 73.0 73.0 113.0 73.0 74.0 73.0 73.0 97.0 74.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:84.50 stddev:8.47 (10.0%) stddev-sans-first:8.67 05:37:14 INFO - PID 21613 | Values: 83.0 84.0 99.0 85.0 83.0 84.0 100.0 85.0 85.0 105.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.71 (1.5%) stddev-sans-first:1.30 05:37:14 INFO - PID 21613 | Values: 118.0 115.0 113.0 114.0 113.0 114.0 114.0 113.0 115.0 117.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 05:37:14 INFO - PID 21613 | Values: 151.0 150.0 151.0 150.0 152.0 152.0 151.0 153.0 152.0 152.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:37:14 INFO - PID 21613 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 05:37:14 INFO - PID 21613 | Values: 54.0 55.0 55.0 56.0 57.0 55.0 56.0 54.0 55.0 55.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 05:37:14 INFO - PID 21613 | Values: 55.0 56.0 55.0 55.0 54.0 55.0 56.0 55.0 56.0 55.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:86.00 stddev:11.26 (13.1%) stddev-sans-first:11.67 05:37:14 INFO - PID 21613 | Values: 83.0 87.0 86.0 85.0 92.0 86.0 86.0 87.0 121.0 84.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:135.50 stddev:6.06 (4.5%) stddev-sans-first:5.10 05:37:14 INFO - PID 21613 | Values: 146.0 143.0 141.0 131.0 134.0 135.0 128.0 132.0 136.0 129.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:188.00 stddev:6.50 (3.5%) stddev-sans-first:4.79 05:37:14 INFO - PID 21613 | Values: 201.0 188.0 186.0 193.0 181.0 182.0 192.0 188.0 187.0 179.0 05:37:14 INFO - PID 21613 | 05:37:14 INFO - PID 21613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:2.06 (2.8%) stddev-sans-first:2.13 05:37:14 INFO - PID 21613 | Values: 71.0 74.0 76.0 74.0 72.0 70.0 70.0 74.0 71.0 71.0 05:37:14 INFO - PID 21613 | -------- Summary: end -------- 05:37:14 INFO - PID 21613 | 05:37:15 INFO - TEST-INFO | 21613: exit 0 05:37:15 INFO - TEST-OK | kraken | took 92047ms 05:37:15 INFO - SUITE-END | took 1235s 05:37:16 INFO - Completed test suite (00:20:35) 05:37:16 INFO - javascript benchmark 05:37:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7673.179521804867, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.138961090894, 3081.938361232777, 3100.1629560018787, 3106.6272047354305, 3113.330633913708, 5893.675847828367, 6000.75996960121, 6012.879742405149, 6039.27528696556, 6048.516118710503, 5931.288245410546, 5984.910226346608, 6019.488343490809, 6094.481969032627, 6108.908366374508, 5476.945230547703, 5518.668879867211, 5586.24585680934, 5600.0, 5608.495235428811, 5609.76585151266, 5664.291963504562, 5682.6306290091015, 5693.231413759131, 5702.173184888189, 5436.646617969859, 5441.238226648273, 5502.972485137549, 5554.472325129106, 5582.832515024576, 5549.278593782823, 5566.610337276392, 5578.525825304854, 5605.495505404492, 5613.9157912630935, 5540.279763630702, 5540.86147846303, 5546.084895992157, 5546.889062218774, 5568.192612071268, 5814.680192589406, 5996.5202783777195, 6013.879722405572, 6023.518118550549, 6030.547708921848, 6337.017762246859, 6378.330275321071, 6441.871162576722, 6451.322611125811, 6508.153939987818, 6583.93416065838, 6606.075149479077, 6614.173228346457, 6615.702293396808, 6628.801135965929, 6103.23709536308, 6119.418655227791, 6126.877462450726, 6127.785527506516, 6131.110988906584, 6410.711517981609, 6498.122753428322, 6548.8362790930605, 6585.769498067544, 6662.267150613428, 6184.319724830265, 6224.159738435344, 6284.057391391328, 6387.744490220432, 6393.9360606394275, 6456.677166141674, 6508.837279068061, 6523.902141467882, 6541.313162118005, 6550.115734375893, 6526.543141980016, 6535.836604084936, 6538.1827271591055, 6542.280349161589, 6547.9672601636685, 6203.503719702413, 6318.304986451487, 6338.556301058881, 6467.385598368148, 6473.417392434703, 5240.737963101829, 5250.973745131327, 5253.028189784902, 5264.236685680555, 5294.894102117936, 4474.351219073216, 4478.641708663299, 4482.7758612069265, 4483.2602620567895, 4520.095980803852, 5470.152126420411, 5565.972170139124, 5579.7489112990015, 5683.062294721325, 5745.511631511285, 6403.839904002344, 6483.546151769425, 6525.510586706016, 6527.2167339919515, 6535.509836762262, 5633.436656334416, 5667.688277144796, 5705.600607957404, 5715.685637289989, 5731.140328950691, 5454.509094181463, 5602.13166959122, 5608.298962629671, 5613.550915926716, 5617.0, 6185.907211391833, 6228.875422491616, 6284.937150628435, 6337.493000559852, 6354.6822658867795, 6559.048937904073, 6569.0, 6589.439897608565, 6592.7033283503315, 6596.241432235354, 6252.749890004349, 6280.152179455898, 6288.654124023223, 6291.087792270187, 6299.874002520016, 6136.243373036893, 6214.5960512566535, 6264.68676566179, 6340.890344189841, 6362.204724409449, 6571.145751052524, 6573.57271777333, 6575.375339342755, 6589.538732288694, 6602.636854973022, 6134.987727024991, 6209.937900620936, 6310.116583678197, 6317.241930968313, 6334.841628959313, 6232.501399888089, 6317.6209427434505, 6339.492840572835, 6343.3022367538615, 6345.96827015862, 6032.215811944595, 6086.60437071589, 6099.695015249131, 6133.0, 6137.3862613738265, 6060.787872424444, 6170.197874276315, 6250.687465626609, 6254.249490061222, 6282.340354262919, 6084.0, 6131.132004888217, 6152.169457123231, 6162.938370616236, 6191.597546159485], "value": 5903.725616052475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.7390391651174, 732.5714457042629, 762.0, 1156.629878438899, 1166.3643314393655, 36728.0, 37897.24205515892, 38033.429498557474, 38051.04872378188, 38154.0, 40297.19405611886, 40691.18617627646, 40741.7962910185, 40772.59227407725, 40792.0, 7235.493515453921, 7410.70357185712, 7478.14001389839, 7610.124835643916, 7612.885806712876, 6921.100256966587, 6944.6180460074675, 6987.161540615133, 7002.229754727002, 7021.262767409399, 7006.929930700704, 7010.859782804341, 7051.224365319811, 7055.611941343224, 7070.222275549685, 6956.79129626112, 7030.0, 7031.929680703204, 7040.471964602675, 7042.5070245083125, 7020.684069216897, 7070.29297070294, 7077.893831592531, 7108.751193708195, 7116.0, 36263.0, 36601.0, 36670.633293666986, 36678.449823252675, 36824.631753682654, 3397.184675677844, 3430.3996800559803, 3430.451127819562, 3441.9827900860337, 3442.8794992175153, 28101.297467563476, 28266.717332826614, 28346.858265708746, 28361.14916552507, 28361.432771344666, 3570.1610121621397, 3573.249617580311, 3577.0342007657787, 3584.2831433713363, 3594.2991116732246, 127018.36490817579, 131308.74765009483, 131549.34225328907, 160499.0, 161348.0, 38820.41769373462, 39359.606403936166, 39430.40854387187, 39506.80246598806, 39521.60478395237, 40741.0, 40950.79524602417, 41000.38499422511, 41035.7948210263, 41192.79403603023, 14959.102453852804, 15139.0, 15185.924070379577, 15228.619284517754, 15239.314230859638, 12335.814962775565, 12361.320127393079, 12410.007199424024, 12431.31627760482, 12436.75126497465, 13902.443902244, 13967.650808729863, 13984.720305593832, 14143.22212278314, 14261.144331340152, 5532.446755324436, 5573.69344686038, 5586.91619625706, 5756.798512052058, 5758.0, 992.8461088531145, 1002.819492491344, 1009.8939611340703, 1025.1696126137851, 1029.6859457865273, 22510.54978900413, 22757.772422275564, 23185.884070579537, 23430.882845585664, 24270.75729242685, 1076.6500887211687, 1097.8133717268083, 1099.7092779332625, 1109.877913429522, 1132.5016992523429, 12164.635060948185, 12296.262224266573, 12547.3098979557, 12799.424025918855, 12981.610551683465, 158882.0, 159036.0, 176680.0, 179096.0, 207265.0, 50764.0, 51196.0, 51242.74378628083, 51340.22989655158, 51487.48512514902, 1392.512620582788, 1439.0789894467548, 1440.762274224741, 1455.7306898223862, 1465.6702241995465, 25986.48027039411, 28458.223617330317, 28589.714102858707, 28603.14190574286, 28816.567751483326, 36119.09702257464, 36561.45157822582, 36674.0, 36674.0, 36729.44905826361, 166437.0, 167991.0, 168684.15657921633, 168931.0, 169483.0, 34801.12997175091, 35155.824220878734, 35181.29637407186, 35468.46797297991, 35473.64526354807, 40989.59010409858, 41151.0, 41175.58824411718, 41635.375469367376, 42448.5755142457, 29445.852770736008, 29824.552631710107, 30616.540751889184, 30665.386692266475, 31958.52062219115, 26317.0, 27491.587626186025, 27515.0, 28063.859680702284, 28474.715252847207, 34534.48198277078, 34667.826660866536, 34972.825135874155, 35063.82468087643, 35157.648423515435, 27593.17220483389, 28186.29534261578, 29071.7092829069, 29630.11109666627, 30162.245943850703, 22216.222432214796, 24226.87886560556, 24283.0, 24283.757162428148, 24295.878520607283], "value": 16027.966969988396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.5167702111511, 410.7453378905079, 424.4566954298498, 425.22608851889555, 440.3548801006525, 20337.38987830364, 21054.684179737316, 21212.151513939443, 21242.256521021747, 23142.0, 23278.0, 23878.40303992401, 23880.761192388116, 23950.922208500615, 23978.52042959144, 5804.361520232771, 5923.466887980081, 5943.0, 5943.702814859262, 5948.0, 6066.090086487018, 6072.6356418614805, 6099.634021958696, 6114.571979961404, 6116.816495505142, 5774.595778295521, 5920.259967504062, 5946.197263369455, 5948.524118070565, 5967.701614919259, 5942.286925568917, 5950.523958083343, 5976.760929562813, 5988.461038506512, 6007.219061521996, 5364.839054828361, 5365.678059316415, 5367.543758780469, 5370.516653501165, 5377.381601115843, 26361.472770544482, 26413.867930660417, 26426.07857724153, 26745.197644070708, 26794.330141746417, 1844.9907750461296, 1905.2188602672838, 1907.4945139538033, 1913.3877159309027, 1915.454095582766, 16930.661386772317, 17382.0, 17383.652326953517, 17416.564585885328, 17453.389131380467, 2182.0944308112116, 2226.3543572363997, 2267.841251112423, 2268.9319320420414, 2274.6588011798362, 113873.0, 117081.0, 120475.0, 121928.0, 123184.0, 11469.942650286695, 11573.775571916358, 11585.826212606818, 11887.70280742971, 12135.271883687006, 16394.83605163957, 16700.74948875768, 16722.665546688997, 16787.83212167887, 16892.746608800877, 8169.63236654352, 8433.19884610961, 8862.512561809033, 8868.8669669955, 9094.226990705733, 8694.608742606599, 8716.215540601377, 8885.689000884939, 8895.421797583136, 8947.284217262604, 7560.092788865371, 7815.374770018385, 7837.177096404909, 7899.170587088388, 7934.206579342135, 2080.9687854682193, 2087.3007542473442, 2145.656694928835, 2146.5599552091785, 2298.0577963035075, 965.5124162297994, 971.8785151856018, 974.3861367338532, 993.3146129170849, 1010.1060561403211, 18838.71741923872, 19143.13855876461, 19376.0, 19417.611647766964, 19516.0, 987.2151639446657, 1014.6854475112739, 1015.9898401016043, 1024.1653052762124, 1035.0477560644226, 10122.39265644049, 10323.690289291333, 10769.261405500167, 10874.728131796768, 11041.056744037356, 433023.0, 441577.0, 446005.0, 448320.0, 448920.0, 95713.0, 96637.51681241549, 98142.50928745454, 98529.0, 98843.50578247063, 1145.3357052909294, 1150.4535345710888, 1177.917545771805, 1178.5168081086713, 1188.6552899659002, 15982.200889955224, 16593.91703041477, 16834.0, 16970.575735606708, 17624.82375176283, 44755.0, 46136.307955381366, 46684.299735504675, 47190.76404617955, 47842.760786195846, 57872.421275786706, 58510.7074464625, 63294.68352658207, 66318.66840665959, 66590.66704666446, 10119.79760404773, 10369.688909332732, 10490.475476226311, 10556.102731267621, 10560.15518758513, 17328.13359332003, 17898.91050544791, 19106.808931910502, 19136.71294930605, 19230.711539326643, 15323.387064517294, 15703.450379236672, 15742.425757424166, 15790.289436975134, 15830.44593439224, 13319.86680133225, 14322.283885805877, 14330.856691432953, 14474.710505790035, 14477.131372117707, 15674.0, 15834.28745706469, 15949.920250398674, 16212.513624591282, 16285.0, 10219.0, 10285.84571231447, 10331.793364132825, 10356.741081473023, 10376.584936602452, 15290.159041252839, 15307.234638267819, 15331.386744530093, 15344.769828452805, 15411.845881541041], "value": 10443.536027297609, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.112844394256, 1385.6743665238673, 1386.5008596905113, 1393.728222996515, 1395.6510872281926, 10633.52149153288, 10879.292845965027, 11226.04578610818, 11227.326360418381, 11623.244489108223, 11090.0, 11258.211925165242, 11287.209895307331, 11318.886811131886, 11323.037541808957, 2203.162798136706, 2220.744614369352, 2225.721784776903, 2237.8097861681695, 2240.215924426446, 2305.5734689082487, 2320.385097949045, 2340.929772106831, 2343.250159948817, 2343.273585188597, 2232.0513781642817, 2234.530748542808, 2237.429455488848, 2254.0983606557425, 2257.819374450048, 2192.802647761693, 2218.5230175512343, 2221.1115553778536, 2224.2993457061057, 2231.6764069210035, 1911.7323574699553, 1975.3580086471811, 2199.978000220009, 2205.8014778669994, 2208.182972300243, 10920.2901811382, 10963.61627343047, 11019.614313498989, 11027.72430689231, 11047.613333533369, 6017.308009578911, 6288.496920246369, 6301.054841773725, 6305.621662700252, 6314.463270621956, 3477.669621385964, 3647.6534729200685, 3682.1899182179877, 3721.0325315417917, 3747.7189210809024, 1284.4990453723055, 1288.6005338345049, 1288.9613311600667, 1293.72831705342, 1317.683755898587, 15864.682706345808, 16080.59798505035, 16085.919570402073, 16092.356305747757, 16117.388261173788, 5047.4447810740785, 5054.0, 5171.146760784429, 5177.456367081478, 5180.533751962342, 11719.355435450962, 11748.70628234301, 11790.292582445081, 11795.469203885847, 11856.407179640983, 5673.290838645169, 6165.075238714139, 6174.9073763893575, 6181.1655426516845, 6187.133801267826, 5576.581756368289, 5762.337331206881, 5805.477507024388, 5822.359540450547, 5834.212381328552, 4021.2158629067053, 4066.3087275163293, 4070.3690927906223, 4133.545310015896, 4142.357934520154, 1151.4473052934638, 1162.9709257268637, 1170.1984140863535, 1180.8819118088295, 1181.9704507387385, 783.6003638144588, 818.1981657975217, 822.4653974916353, 829.4276948905236, 829.9668013279402, 6202.303180115013, 6389.7124629390855, 6451.903221451682, 6483.157189565326, 6725.831854203684, 988.7923536057365, 992.8724517769085, 997.2719914462483, 1009.1271050541376, 1018.8064267789097, 3671.7980511072146, 3681.1349332906743, 3747.9063023424633, 3768.886933391948, 3884.7086468514976, 13256.73486530264, 13903.582892513241, 14125.434982600786, 14150.85849141516, 14167.0, 13628.591142265748, 13632.93183534076, 13697.178169309675, 13744.106633068819, 13763.931180344034, 8867.201951824367, 8958.507282099547, 9077.954610226907, 9094.81810363789, 9147.268218542633, 5834.620749651259, 6170.753169873155, 6274.403931626488, 6302.338254483397, 6355.332690067661, 12600.0, 12930.159539629894, 13045.934770326467, 13050.804237936249, 13055.738885222052, 12861.0, 12968.610941671765, 12981.935090324489, 13180.670483237996, 13361.732765344444, 8037.598120094089, 8093.0692970309165, 8109.189081091844, 8209.05595856484, 8212.260896519341, 10438.164946804389, 10497.160227181654, 10499.160067194452, 10500.789984200426, 10514.0, 8559.957200214209, 8736.432131911406, 8854.203121719076, 9159.175674189355, 9186.0, 8707.91292087071, 8760.912390876265, 8766.517841518778, 8851.69019084329, 8857.867131992896, 7415.147258065392, 7453.515521491086, 7466.887996679946, 7512.32389084985, 7514.8497030058, 5143.177091665465, 5384.865378365415, 5397.622166448468, 5479.369872464717, 5488.396276409512, 5434.538064264424, 5527.861803454945, 5554.638948468337, 5657.547396208376, 5667.829965101054], "value": 5082.735803784396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.29856362855975, 395.0656696911804, 395.84068904127986, 402.73822015689797, 405.43441898551504, 6163.845903852395, 6267.153934218879, 6339.619622822628, 6364.649944253064, 6383.489320854332, 6050.939490605093, 6072.848178795522, 6103.847403814907, 6125.5712100153005, 6128.877422451548, 4745.501722319159, 4776.761161941907, 4779.187538118511, 4789.544993225638, 4791.808327666898, 4758.3576217210575, 4764.85705428836, 4775.474697783258, 4784.97607511962, 4786.4974177711365, 4721.268203428474, 4735.50277220892, 4735.763211839411, 4745.169595320823, 4747.335373047776, 4729.385179926605, 4732.455767586703, 4733.650909490813, 4736.171170045262, 4741.454732705749, 4138.6482149017365, 4153.439285696422, 4160.9375859362135, 4172.499300083979, 4178.289690752579, 6029.517638588903, 6087.078202462799, 6095.756169753205, 6115.7859474918605, 6137.508999280091, 5370.865728356823, 5378.327709036371, 5400.540954018913, 5400.810971615974, 5412.5940554458575, 6517.967410162919, 6521.47828173745, 6537.0, 6582.473402127818, 6592.505562082815, 4471.6646251531265, 4519.0400287811535, 4520.98277887476, 4547.840825571089, 4548.8862778430475, 6530.869382612321, 6854.828629284208, 6919.550229235084, 6921.93078069223, 6993.580385176906, 4643.3731446255, 4647.37260469839, 4649.093426781813, 4656.254999200111, 4680.789364478538, 4654.301854721751, 4656.650751193674, 4670.929936050962, 4680.7191568506, 4701.600363969101, 5242.449542797951, 5394.217838413408, 5407.215953686693, 5417.295751552352, 5432.402435732066, 6524.553292515307, 6548.48154773205, 6554.9672251639395, 6559.672016399161, 6568.503968491942, 1607.6543543138282, 1614.1848366574804, 1620.1980019889995, 1630.184907546227, 1634.6648936967892, 1041.8020576090519, 1087.6947662804666, 1087.907527860125, 1091.3233795046963, 1107.9972624774591, 5818.679972601463, 5824.184614154022, 5877.52979761618, 5878.970605146947, 5900.0, 6721.22705888829, 6756.76351327711, 6767.627780472121, 6777.423918966844, 6817.659117044128, 5760.8271751847515, 5781.132830075522, 5818.418158184148, 5849.151872978395, 5875.618084824473, 3604.7837129772297, 3607.8196090195383, 3609.187932715118, 3609.5668519777796, 3627.836747346376, 6592.703328350236, 6592.901106483407, 6596.307387724316, 6615.272320044791, 6678.96660516704, 6963.8064009836735, 6966.164060312693, 6973.58158510491, 6984.79045628632, 6992.755253566203, 6591.274959754423, 6614.503912206507, 6618.6690665467495, 6645.700943457556, 6659.2008958925235, 6661.533692641468, 6753.662316884234, 6758.187958355712, 6761.22245941723, 6827.0, 6386.966191059396, 6576.210854697467, 6671.432928200963, 6692.631905245258, 6751.189857217166, 6506.869862602816, 6536.117624120683, 6583.242927063449, 6591.0, 6599.548099418121, 4656.5110663379855, 4659.370984916993, 4660.0, 4684.859454216379, 4688.859334219979, 6577.552938353555, 6848.691808868513, 6855.862882742217, 6869.828254293483, 6872.278410766798, 6559.376859198369, 6594.670266486753, 6605.669716514251, 6616.0, 6632.204135503771, 6523.804285871432, 6530.869382612226, 6555.508336874658, 6613.933860661332, 6622.205335359788, 6453.419192272718, 6494.6103233806125, 6504.642244676588, 6512.185976752906, 6538.607683539003, 6638.867222655616, 6648.501362397937, 6658.134442522635, 6659.467242620675, 6670.566413183127, 6375.489960803217, 6396.552241343247, 6423.807285781434, 6434.8391290218115, 6473.0], "value": 4923.2357219275955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.2374368093988, 839.811042515434, 849.7535714642754, 859.6303589456534, 860.9926386128229, 16929.746053809187, 17310.307587696494, 17310.913445432772, 18853.340133095346, 20306.492337691565, 17853.821461785377, 18508.167132479037, 18775.81224187758, 18818.905905470452, 18963.431097067074, 963.5519483440216, 999.3454287441738, 1002.1882275356948, 1004.3020101029787, 1004.5228516454662, 700.0828914122491, 714.8284411741197, 1012.488693209928, 1016.0398423489805, 1016.4257194685016, 999.990000099997, 1048.643461223184, 1050.842373643952, 1052.2581579986092, 1052.9420881851495, 1028.1517747858009, 1032.5611615063606, 1033.1837848099992, 1033.7415646088516, 1037.0, 743.8735414979467, 747.9925200747978, 750.2347605442473, 751.3012898004853, 752.6913965274266, 17079.743803842954, 17289.913550432295, 17447.12764361777, 17566.0, 17663.0, 17440.738388924176, 17502.0, 17562.473125806246, 17604.91197544017, 17726.0, 16655.66688666232, 17353.2191051403, 17442.651146977118, 17484.300627974993, 17536.0, 5086.745662716887, 5140.228965655144, 5168.457311982263, 5217.921731174036, 5220.399654039758, 83538.58230708807, 84762.59035963839, 92988.0, 95349.523252384, 95759.0, 15201.847981520043, 15412.845871541365, 15468.22658867052, 15517.767233491506, 15529.844701553066, 25388.74611253864, 25869.482610348063, 26111.216663500127, 26147.869260653573, 27446.313842153708, 7659.234076592407, 7840.568768717661, 8018.158093400226, 8102.270795628422, 8112.918870811334, 3730.5896351401325, 3788.6400791924725, 3825.158465137665, 3833.0225792422752, 3841.8847434577006, 4097.344424892003, 4214.157168566299, 4244.893877653021, 4252.723572967747, 4252.766097864585, 797.194833218442, 808.5148910653678, 809.3161278719473, 813.4305985809957, 814.3973459639824, 684.3191024930227, 706.7773651299824, 715.4205093873978, 720.5964659790534, 722.288545782404, 10416.32293900894, 11378.601748938747, 11898.524059037714, 12379.69050773738, 13115.934420327838, 679.5481005131533, 685.2873012067494, 697.1320705721308, 711.8825393810067, 718.7196993172666, 4613.515580864028, 4855.562999330006, 4922.064807686528, 4992.675476094042, 5013.0, 82887.0, 84531.57734211412, 85828.57085714531, 87009.12990870138, 88231.11768882358, 70161.0, 72577.63711181516, 72814.0, 73248.26751732414, 74256.62871685714, 63120.36879631237, 63876.68061659662, 65287.0, 66514.66742666256, 67260.66369668121, 10405.323653962469, 10951.671449856518, 11498.425078745862, 11630.53477860876, 11771.646850594496, 28418.289542761595, 28733.0, 29078.41843163167, 29257.0, 29944.700552994193, 56926.715366422904, 57006.429935700115, 57666.42333576778, 57805.0, 58460.4153958455, 15763.211839408214, 15785.605359865636, 15941.44204952821, 16060.277287521856, 16158.353665853234, 16040.0, 18381.908090459463, 19177.13702883346, 19429.902850485658, 19941.501462463555, 16133.193340333171, 16375.181240937667, 16500.0, 16577.834221657627, 16825.74761378556, 17760.91119544394, 17847.0, 17910.10449477547, 18010.189541470405, 18105.547361316072, 15401.306941187897, 15555.222238888236, 15738.842611573738, 15775.921120394325, 15862.44481443144, 10533.894661053291, 11095.72260693489, 11243.156763242627, 11374.943125284652, 11376.260543064674, 13943.511977080754, 14000.509982150576, 14182.14907105577, 14236.715265694422, 14248.35882385316], "value": 8253.209962962801, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 110.0, 109.0, 110.0, 110.0, 113.0, 108.0, 109.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 123.0, 120.0, 167.0, 122.0, 126.0, 131.0, 122.0, 153.0, 121.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 163.0, 164.0, 165.0, 179.0, 170.0, 166.0, 161.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 73.0, 113.0, 73.0, 74.0, 73.0, 73.0, 97.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 99.0, 85.0, 83.0, 84.0, 100.0, 85.0, 85.0, 105.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 117.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 150.0, 152.0, 152.0, 151.0, 153.0, 152.0, 152.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 56.0, 57.0, 55.0, 56.0, 54.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 54.0, 55.0, 56.0, 55.0, 56.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 85.0, 92.0, 86.0, 86.0, 87.0, 121.0, 84.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 141.0, 131.0, 134.0, 135.0, 128.0, 132.0, 136.0, 129.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 188.0, 186.0, 193.0, 181.0, 182.0, 192.0, 188.0, 187.0, 179.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 76.0, 74.0, 72.0, 70.0, 70.0, 74.0, 71.0, 71.0], "value": 72.3, "unit": "score"}]}]} 05:37:16 INFO - Return code: 0 05:37:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:16 INFO - # TBPL SUCCESS # 05:37:16 INFO - Running post-action listener: _resource_record_post_action 05:37:16 INFO - [mozharness: 2017-06-07 12:37:16.327336Z] Finished run-tests step (success) 05:37:16 INFO - Running post-run listener: _resource_record_post_run 05:37:16 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 8192; Write bytes: 434429952; Read time: 100; Write time: 233268 05:37:16 INFO - TinderboxPrint: CPU usage
12.7% 05:37:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 100 05:37:16 INFO - TinderboxPrint: I/O write bytes / time
434,429,952 / 233,268 05:37:16 INFO - TinderboxPrint: CPU idle
8,732.7 (87.3%) 05:37:16 INFO - TinderboxPrint: CPU user
1,211.1 (12.1%) 05:37:16 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104071168; Read time: 0; Write time: 61184 05:37:16 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:16 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 8192; Write bytes: 330358784; Read time: 100; Write time: 172084 05:37:16 INFO - Running post-run listener: _upload_blobber_files 05:37:16 INFO - Blob upload gear active. 05:37:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:16 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:16 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:16 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:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:37:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:18 INFO - (blobuploader) - INFO - Done attempting. 05:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:21 INFO - (blobuploader) - INFO - Done attempting. 05:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:25 INFO - (blobuploader) - INFO - Done attempting. 05:37:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:37:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:25 INFO - (blobuploader) - INFO - Done attempting. 05:37:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:25 INFO - Return code: 0 05:37:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a10de5c5c3870b93640bb5e61793e43f63e8ce4d84f22ce46c78b5307563de2b16f8440c4b515cf62f2a05c6b70039b9ef670e5a8ab3e9e291d4feeeb1a9db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b125b10720db26843b64cb374c98dbee69443b76ed77c63eac147dcf400a55c7aa2cadebf2e9521cd1cebcad86189e62437b34b3f5afcd11581b470e90045791", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a4d428b44f4df6805f8f3fb30798a13827aa133205c7b7bd989e9c06b335eee23fcf2efaaebfb30197f63d8896925c7b4440402e36e13a4c80ce3d56d59078c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43cc8571d2263aa65bcd32089ee4e0f86367f94caa44f8c51c008d91caefb783e8ec841bb31503d5a4ffbb336fc57b8b418f06381fda91d98052c70241c62472"} 05:37:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:25 INFO - Contents: 05:37:25 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a10de5c5c3870b93640bb5e61793e43f63e8ce4d84f22ce46c78b5307563de2b16f8440c4b515cf62f2a05c6b70039b9ef670e5a8ab3e9e291d4feeeb1a9db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b125b10720db26843b64cb374c98dbee69443b76ed77c63eac147dcf400a55c7aa2cadebf2e9521cd1cebcad86189e62437b34b3f5afcd11581b470e90045791", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a4d428b44f4df6805f8f3fb30798a13827aa133205c7b7bd989e9c06b335eee23fcf2efaaebfb30197f63d8896925c7b4440402e36e13a4c80ce3d56d59078c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43cc8571d2263aa65bcd32089ee4e0f86367f94caa44f8c51c008d91caefb783e8ec841bb31503d5a4ffbb336fc57b8b418f06381fda91d98052c70241c62472"} 05:37:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:25 INFO - Copying logs to upload dir... 05:37:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.845750 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-07 05:37:25.316816) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:25.322764) ========= 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=d2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a10de5c5c3870b93640bb5e61793e43f63e8ce4d84f22ce46c78b5307563de2b16f8440c4b515cf62f2a05c6b70039b9ef670e5a8ab3e9e291d4feeeb1a9db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b125b10720db26843b64cb374c98dbee69443b76ed77c63eac147dcf400a55c7aa2cadebf2e9521cd1cebcad86189e62437b34b3f5afcd11581b470e90045791", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a4d428b44f4df6805f8f3fb30798a13827aa133205c7b7bd989e9c06b335eee23fcf2efaaebfb30197f63d8896925c7b4440402e36e13a4c80ce3d56d59078c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43cc8571d2263aa65bcd32089ee4e0f86367f94caa44f8c51c008d91caefb783e8ec841bb31503d5a4ffbb336fc57b8b418f06381fda91d98052c70241c62472"} build_url:https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/EsjSzTmcTRGF966pkkVXsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a10de5c5c3870b93640bb5e61793e43f63e8ce4d84f22ce46c78b5307563de2b16f8440c4b515cf62f2a05c6b70039b9ef670e5a8ab3e9e291d4feeeb1a9db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b125b10720db26843b64cb374c98dbee69443b76ed77c63eac147dcf400a55c7aa2cadebf2e9521cd1cebcad86189e62437b34b3f5afcd11581b470e90045791", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a4d428b44f4df6805f8f3fb30798a13827aa133205c7b7bd989e9c06b335eee23fcf2efaaebfb30197f63d8896925c7b4440402e36e13a4c80ce3d56d59078c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43cc8571d2263aa65bcd32089ee4e0f86367f94caa44f8c51c008d91caefb783e8ec841bb31503d5a4ffbb336fc57b8b418f06381fda91d98052c70241c62472"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:25.348297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:25.348699) ========= 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=d2a8c569965ab8367867b893000001a1-1496833585.259246-1908057000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-07 05:37:25.432245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:37:25.432602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-07 05:37:25.432949) ========= ========= Total master_lag: 0.17 =========