builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1496655831.57 results: success (0) revision: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:51.572648) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:51.573031) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:51.573296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:51.628264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:43:51.628527) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 02:43:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-06-05 02:43:52 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129745 ========= master_lag: 1.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:43:53.153954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:53.154256) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018204 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:53.198756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:43:53.199093) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 --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 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 --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=d6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 02:43:53,643 truncating revision to first 12 chars 2017-06-05 02:43:53,643 Setting DEBUG logging. 2017-06-05 02:43:53,643 attempt 1/10 2017-06-05 02:43:53,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d5df2dead2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 02:43:54,350 unpacking tar archive at: mozilla-central-7d5df2dead2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:43:54.232014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:54.232484) ========= script_repo_revision: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:54.232901) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:54.233162) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:43:54.250311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-06-05 02:43:54.250687) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:43:54 INFO - MultiFileLogger online at 20170605 02:43:54 in /builds/slave/test 02:43:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:43:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:43:54 INFO - {'append_to_log': False, 02:43:54 INFO - 'base_work_dir': '/builds/slave/test', 02:43:54 INFO - 'blob_upload_branch': 'Firefox', 02:43:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:43:54 INFO - 'branch': 'Firefox', 02:43:54 INFO - 'buildbot_json_path': 'buildprops.json', 02:43:54 INFO - 'config_files': ('talos/linux_config.py',), 02:43:54 INFO - 'default_actions': ('clobber', 02:43:54 INFO - 'read-buildbot-config', 02:43:54 INFO - 'download-and-extract', 02:43:54 INFO - 'populate-webroot', 02:43:54 INFO - 'create-virtualenv', 02:43:54 INFO - 'install', 02:43:54 INFO - 'setup-mitmproxy', 02:43:54 INFO - 'run-tests'), 02:43:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:43:54 INFO - 'download_minidump_stackwalk': True, 02:43:54 INFO - 'download_symbols': 'ondemand', 02:43:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:43:54 INFO - 'tooltool.py': '/tools/tooltool.py', 02:43:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:43:54 INFO - '/tools/misc-python/virtualenv.py')}, 02:43:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:43:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:43:54 INFO - 'gecko_profile': False, 02:43:54 INFO - 'gecko_profile_interval': 0, 02:43:54 INFO - 'installer_path': 'installer.exe', 02:43:54 INFO - 'log_level': 'info', 02:43:54 INFO - 'log_name': 'talos', 02:43:54 INFO - 'log_to_console': True, 02:43:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:43:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:43:54 INFO - 'opt_config_files': (), 02:43:54 INFO - 'pip_index': False, 02:43:54 INFO - 'suite': 'dromaeojs-e10s', 02:43:54 INFO - 'system_bits': '32', 02:43:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:43:54 INFO - 'title': 'talos-linux64-ix-034', 02:43:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:43:54 INFO - 'use_talos_json': True, 02:43:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:43:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:43:54 INFO - 'work_dir': 'build'} 02:43:54 INFO - [mozharness: 2017-06-05 09:43:54.779340Z] Running clobber step. 02:43:54 INFO - Running pre-action listener: _resource_record_pre_action 02:43:54 INFO - Running main action method: clobber 02:43:54 INFO - rmtree: /builds/slave/test/build 02:43:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:43:56 INFO - Running post-action listener: _resource_record_post_action 02:43:56 INFO - [mozharness: 2017-06-05 09:43:56.320160Z] Finished clobber step (success) 02:43:56 INFO - [mozharness: 2017-06-05 09:43:56.320259Z] Running read-buildbot-config step. 02:43:56 INFO - Running pre-action listener: _resource_record_pre_action 02:43:56 INFO - Running main action method: read_buildbot_config 02:43:56 INFO - Using buildbot properties: 02:43:56 INFO - { 02:43:56 INFO - "project": "", 02:43:56 INFO - "product": "firefox", 02:43:56 INFO - "who": "archaeopteryx@coole-files.de", 02:43:56 INFO - "installer_path": "public/build/target.tar.bz2", 02:43:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:43:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:43:56 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:43:56 INFO - "stage_platform": "linux64-stylo", 02:43:56 INFO - "basedir": "/builds/slave/test", 02:43:56 INFO - "buildnumber": 127, 02:43:56 INFO - "platform": "ubuntu64_hw_stylo", 02:43:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:43:56 INFO - "slavebuilddir": "test", 02:43:56 INFO - "taskId": "UDU2ebt0R42yykx8drA5KQ", 02:43:56 INFO - "branch": "mozilla-central", 02:43:56 INFO - "script_repo_revision": "production", 02:43:56 INFO - "revision": "7d5df2dead2c9edaa41688a82d9d9dcc86529ef2", 02:43:56 INFO - "slavename": "talos-linux64-ix-034", 02:43:56 INFO - "repo_path": "mozilla-central" 02:43:56 INFO - } 02:43:56 INFO - Finding installer, test and symbols from parent task. 02:43:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UDU2ebt0R42yykx8drA5KQ'}, attempt #1 02:43:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UDU2ebt0R42yykx8drA5KQ'}, attempt #1 02:43:57 INFO - Task dependencies: NVsSSnvXTZSfWgd9XpcK7A 02:43:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A'}, attempt #1 02:43:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:43:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/test_packages.json 02:43:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip 02:43:57 INFO - Running post-action listener: _resource_record_post_action 02:43:57 INFO - [mozharness: 2017-06-05 09:43:57.694886Z] Finished read-buildbot-config step (success) 02:43:57 INFO - [mozharness: 2017-06-05 09:43:57.695107Z] Running download-and-extract step. 02:43:57 INFO - Running pre-action listener: _resource_record_pre_action 02:43:57 INFO - Running main action method: download_and_extract 02:43:57 INFO - mkdir: /builds/slave/test/build/tests 02:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:43:57 INFO - trying https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.test_packages.json 02:43:57 INFO - Downloading https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:43:58 INFO - Downloaded 989 bytes. 02:43:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:43:58 INFO - Using the following test package requirements: 02:43:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:43:58 INFO - u'common': [u'target.common.tests.zip'], 02:43:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:43:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:43:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:43:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:43:58 INFO - u'mozbase': [u'target.common.tests.zip'], 02:43:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:43:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:43:58 INFO - u'web-platform': [u'target.common.tests.zip', 02:43:58 INFO - u'target.web-platform.tests.tar.gz'], 02:43:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:43:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:43:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip 02:43:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:43:58 INFO - Fetch https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip into memory 02:43:59 INFO - Content-Length response header: 65102564 02:43:59 INFO - Bytes received: 65102564 02:44:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:44:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip 02:44:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:10 INFO - Fetch https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip into memory 02:44:12 INFO - Content-Length response header: 65102564 02:44:12 INFO - Bytes received: 65102564 02:44:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.talos.tests.zip 02:44:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:44:24 INFO - Fetch https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.talos.tests.zip into memory 02:44:25 INFO - Content-Length response header: 14447425 02:44:25 INFO - Bytes received: 14447425 02:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:25 INFO - trying https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:44:25 INFO - Downloading https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:44:27 INFO - Downloaded 60348594 bytes. 02:44:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:44:27 INFO - mkdir: /builds/slave/test/properties 02:44:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:27 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:27 INFO - Contents: 02:44:27 INFO - build_url:https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:44:27 INFO - Running post-action listener: _resource_record_post_action 02:44:27 INFO - Running post-action listener: set_extra_try_arguments 02:44:27 INFO - [mozharness: 2017-06-05 09:44:27.424449Z] Finished download-and-extract step (success) 02:44:27 INFO - [mozharness: 2017-06-05 09:44:27.424570Z] Running populate-webroot step. 02:44:27 INFO - Running pre-action listener: _resource_record_pre_action 02:44:27 INFO - Running main action method: populate_webroot 02:44:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:27 INFO - '--tppagecycles', 02:44:27 INFO - '7'], 02:44:27 INFO - 'tests': ['tsvgm']}}, 02:44:27 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['damp', 'tps']}, 02:44:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'tests': ['damp', 'tps']}, 02:44:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['dromaeo_dom']}, 02:44:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:44:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:44:27 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:44:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['a11yr', 02:44:27 INFO - 'ts_paint', 02:44:27 INFO - 'tpaint', 02:44:27 INFO - 'sessionrestore', 02:44:27 INFO - 'sessionrestore_no_auto_restore', 02:44:27 INFO - 'tabpaint']}, 02:44:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:27 INFO - 'ts_paint', 02:44:27 INFO - 'tpaint', 02:44:27 INFO - 'sessionrestore', 02:44:27 INFO - 'sessionrestore_no_auto_restore', 02:44:27 INFO - 'tabpaint']}, 02:44:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:44:27 INFO - 'ts_paint', 02:44:27 INFO - 'tpaint', 02:44:27 INFO - 'sessionrestore', 02:44:27 INFO - 'sessionrestore_no_auto_restore', 02:44:27 INFO - 'tabpaint']}, 02:44:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:44:27 INFO - 'ts_paint', 02:44:27 INFO - 'tpaint', 02:44:27 INFO - 'sessionrestore', 02:44:27 INFO - 'sessionrestore_no_auto_restore', 02:44:27 INFO - 'tabpaint']}, 02:44:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['a11yr', 02:44:27 INFO - 'ts_paint', 02:44:27 INFO - 'tpaint', 02:44:27 INFO - 'sessionrestore', 02:44:27 INFO - 'sessionrestore_no_auto_restore', 02:44:27 INFO - 'tabpaint']}, 02:44:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['a11yr', 02:44:27 INFO - 'ts_paint', 02:44:27 INFO - 'tpaint', 02:44:27 INFO - 'sessionrestore', 02:44:27 INFO - 'sessionrestore_no_auto_restore', 02:44:27 INFO - 'tabpaint']}, 02:44:27 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:44:27 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:44:27 INFO - 'bloom_basic_ref']}, 02:44:27 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:44:27 INFO - 'talos_options': ['--mitmproxy', 02:44:27 INFO - 'mitmproxy-recording-1.mp', 02:44:27 INFO - '--firstNonBlankPaint'], 02:44:27 INFO - 'tests': ['Quantum_1']}, 02:44:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['tsvgx', 02:44:27 INFO - 'tsvgr_opacity', 02:44:27 INFO - 'tart', 02:44:27 INFO - 'tscrollx', 02:44:27 INFO - 'cart', 02:44:27 INFO - 'tsvg_static']}, 02:44:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:27 INFO - 'tsvgr_opacity', 02:44:27 INFO - 'tart', 02:44:27 INFO - 'tscrollx', 02:44:27 INFO - 'cart', 02:44:27 INFO - 'tsvg_static']}, 02:44:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'talos_options': ['--disable-e10s'], 02:44:27 INFO - 'tests': ['tp5o']}, 02:44:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:44:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'talos_options': ['--disable-e10s', 02:44:27 INFO - '--xperf_path', 02:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:27 INFO - 'tests': ['tp5n']}, 02:44:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:44:27 INFO - 'talos_options': ['--xperf_path', 02:44:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:27 INFO - 'tests': ['tp5n']}}, 02:44:27 INFO - 'talos.zip': {'path': '', 02:44:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:27 INFO - Running post-action listener: _resource_record_post_action 02:44:27 INFO - [mozharness: 2017-06-05 09:44:27.442746Z] Finished populate-webroot step (success) 02:44:27 INFO - [mozharness: 2017-06-05 09:44:27.442840Z] Running create-virtualenv step. 02:44:27 INFO - Running pre-action listener: _resource_record_pre_action 02:44:27 INFO - Running main action method: create_virtualenv 02:44:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:44:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:27 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:44:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:27 INFO - Using real prefix '/usr' 02:44:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:30 INFO - Installing pip.................done. 02:44:30 INFO - Return code: 0 02:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:44:30 INFO - Reading from file tmpfile_stdout 02:44:30 INFO - Output received: 02:44:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:44:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:44:30 INFO - Using env: {'DISPLAY': ':0', 02:44:30 INFO - 'HOME': '/home/cltbld', 02:44:30 INFO - 'LANG': 'en_US.UTF-8', 02:44:30 INFO - 'LANGUAGE': 'en_US:en', 02:44:30 INFO - 'LOGNAME': 'cltbld', 02:44:30 INFO - 'MAIL': '/var/mail/cltbld', 02:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:30 INFO - 'MOZ_NO_REMOTE': '1', 02:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:30 INFO - 'NO_EM_RESTART': '1', 02:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:30 INFO - 'PWD': '/builds/slave/test', 02:44:30 INFO - 'SHELL': '/bin/bash', 02:44:30 INFO - 'SHLVL': '1', 02:44:30 INFO - 'TERM': 'linux', 02:44:30 INFO - 'TMOUT': '86400', 02:44:30 INFO - 'USER': 'cltbld', 02:44:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:30 INFO - '_': '/tools/buildbot/bin/python'} 02:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:44:30 INFO - Cleaning up... 02:44:30 INFO - Return code: 0 02:44:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:44:30 INFO - Using env: {'DISPLAY': ':0', 02:44:30 INFO - 'HOME': '/home/cltbld', 02:44:30 INFO - 'LANG': 'en_US.UTF-8', 02:44:30 INFO - 'LANGUAGE': 'en_US:en', 02:44:30 INFO - 'LOGNAME': 'cltbld', 02:44:30 INFO - 'MAIL': '/var/mail/cltbld', 02:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:30 INFO - 'MOZ_NO_REMOTE': '1', 02:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:30 INFO - 'NO_EM_RESTART': '1', 02:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:30 INFO - 'PWD': '/builds/slave/test', 02:44:30 INFO - 'SHELL': '/bin/bash', 02:44:30 INFO - 'SHLVL': '1', 02:44:30 INFO - 'TERM': 'linux', 02:44:30 INFO - 'TMOUT': '86400', 02:44:30 INFO - 'USER': 'cltbld', 02:44:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:30 INFO - '_': '/tools/buildbot/bin/python'} 02:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:30 INFO - Downloading/unpacking psutil>=3.1.1 02:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:32 INFO - Installing collected packages: psutil 02:44:32 INFO - Running setup.py install for psutil 02:44:32 INFO - building 'psutil._psutil_linux' extension 02:44:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:44:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:44:32 INFO - building 'psutil._psutil_posix' extension 02:44:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:44:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:32 INFO - Successfully installed psutil 02:44:32 INFO - Cleaning up... 02:44:32 INFO - Return code: 0 02:44:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:44:32 INFO - Using env: {'DISPLAY': ':0', 02:44:32 INFO - 'HOME': '/home/cltbld', 02:44:32 INFO - 'LANG': 'en_US.UTF-8', 02:44:32 INFO - 'LANGUAGE': 'en_US:en', 02:44:32 INFO - 'LOGNAME': 'cltbld', 02:44:32 INFO - 'MAIL': '/var/mail/cltbld', 02:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:32 INFO - 'MOZ_NO_REMOTE': '1', 02:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:32 INFO - 'NO_EM_RESTART': '1', 02:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:32 INFO - 'PWD': '/builds/slave/test', 02:44:32 INFO - 'SHELL': '/bin/bash', 02:44:32 INFO - 'SHLVL': '1', 02:44:32 INFO - 'TERM': 'linux', 02:44:32 INFO - 'TMOUT': '86400', 02:44:32 INFO - 'USER': 'cltbld', 02:44:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:32 INFO - '_': '/tools/buildbot/bin/python'} 02:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:44:33 INFO - Installing collected packages: mozsystemmonitor 02:44:33 INFO - Running setup.py install for mozsystemmonitor 02:44:33 INFO - Successfully installed mozsystemmonitor 02:44:33 INFO - Cleaning up... 02:44:34 INFO - Return code: 0 02:44:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:34 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:44:34 INFO - Using env: {'DISPLAY': ':0', 02:44:34 INFO - 'HOME': '/home/cltbld', 02:44:34 INFO - 'LANG': 'en_US.UTF-8', 02:44:34 INFO - 'LANGUAGE': 'en_US:en', 02:44:34 INFO - 'LOGNAME': 'cltbld', 02:44:34 INFO - 'MAIL': '/var/mail/cltbld', 02:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:34 INFO - 'MOZ_NO_REMOTE': '1', 02:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:34 INFO - 'NO_EM_RESTART': '1', 02:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:34 INFO - 'PWD': '/builds/slave/test', 02:44:34 INFO - 'SHELL': '/bin/bash', 02:44:34 INFO - 'SHLVL': '1', 02:44:34 INFO - 'TERM': 'linux', 02:44:34 INFO - 'TMOUT': '86400', 02:44:34 INFO - 'USER': 'cltbld', 02:44:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:34 INFO - '_': '/tools/buildbot/bin/python'} 02:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:44:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:44:35 INFO - warning: no files found matching '*.txt' 02:44:35 INFO - no previously-included directories found matching 'build' 02:44:35 INFO - no previously-included directories found matching 'dist' 02:44:35 INFO - no previously-included directories found matching '.git*' 02:44:35 INFO - Installing collected packages: jsonschema, functools32 02:44:35 INFO - Running setup.py install for functools32 02:44:35 INFO - warning: no files found matching '*.txt' 02:44:35 INFO - no previously-included directories found matching 'build' 02:44:35 INFO - no previously-included directories found matching 'dist' 02:44:35 INFO - no previously-included directories found matching '.git*' 02:44:35 INFO - Successfully installed jsonschema functools32 02:44:35 INFO - Cleaning up... 02:44:35 INFO - Return code: 0 02:44:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:35 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:44:35 INFO - Using env: {'DISPLAY': ':0', 02:44:35 INFO - 'HOME': '/home/cltbld', 02:44:35 INFO - 'LANG': 'en_US.UTF-8', 02:44:35 INFO - 'LANGUAGE': 'en_US:en', 02:44:35 INFO - 'LOGNAME': 'cltbld', 02:44:35 INFO - 'MAIL': '/var/mail/cltbld', 02:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:35 INFO - 'MOZ_NO_REMOTE': '1', 02:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:35 INFO - 'NO_EM_RESTART': '1', 02:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:35 INFO - 'PWD': '/builds/slave/test', 02:44:35 INFO - 'SHELL': '/bin/bash', 02:44:35 INFO - 'SHLVL': '1', 02:44:35 INFO - 'TERM': 'linux', 02:44:35 INFO - 'TMOUT': '86400', 02:44:35 INFO - 'USER': 'cltbld', 02:44:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:35 INFO - '_': '/tools/buildbot/bin/python'} 02:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:44:35 INFO - Cleaning up... 02:44:35 INFO - Return code: 0 02:44:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:35 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:44:35 INFO - Using env: {'DISPLAY': ':0', 02:44:35 INFO - 'HOME': '/home/cltbld', 02:44:35 INFO - 'LANG': 'en_US.UTF-8', 02:44:35 INFO - 'LANGUAGE': 'en_US:en', 02:44:35 INFO - 'LOGNAME': 'cltbld', 02:44:35 INFO - 'MAIL': '/var/mail/cltbld', 02:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:35 INFO - 'MOZ_NO_REMOTE': '1', 02:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:35 INFO - 'NO_EM_RESTART': '1', 02:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:35 INFO - 'PWD': '/builds/slave/test', 02:44:35 INFO - 'SHELL': '/bin/bash', 02:44:35 INFO - 'SHLVL': '1', 02:44:35 INFO - 'TERM': 'linux', 02:44:35 INFO - 'TMOUT': '86400', 02:44:35 INFO - 'USER': 'cltbld', 02:44:35 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:35 INFO - '_': '/tools/buildbot/bin/python'} 02:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - Downloading docopt-0.6.1.tar.gz 02:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:37 INFO - Running setup.py install for blobuploader 02:44:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:37 INFO - Running setup.py install for requests 02:44:38 INFO - Running setup.py install for docopt 02:44:38 INFO - Successfully installed blobuploader requests docopt 02:44:38 INFO - Cleaning up... 02:44:38 INFO - Return code: 0 02:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:38 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:44:38 INFO - Using env: {'DISPLAY': ':0', 02:44:38 INFO - 'HOME': '/home/cltbld', 02:44:38 INFO - 'LANG': 'en_US.UTF-8', 02:44:38 INFO - 'LANGUAGE': 'en_US:en', 02:44:38 INFO - 'LOGNAME': 'cltbld', 02:44:38 INFO - 'MAIL': '/var/mail/cltbld', 02:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:38 INFO - 'MOZ_NO_REMOTE': '1', 02:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:38 INFO - 'NO_EM_RESTART': '1', 02:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:38 INFO - 'PWD': '/builds/slave/test', 02:44:38 INFO - 'SHELL': '/bin/bash', 02:44:38 INFO - 'SHLVL': '1', 02:44:38 INFO - 'TERM': 'linux', 02:44:38 INFO - 'TMOUT': '86400', 02:44:38 INFO - 'USER': 'cltbld', 02:44:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:38 INFO - '_': '/tools/buildbot/bin/python'} 02:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:38 INFO - Running setup.py (path:/tmp/pip-6WIJUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:38 INFO - Running setup.py (path:/tmp/pip-RNEQbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:38 INFO - Running setup.py (path:/tmp/pip-WNp4ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:38 INFO - Running setup.py (path:/tmp/pip-Numlot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:38 INFO - Running setup.py (path:/tmp/pip-z9r3kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:38 INFO - Running setup.py (path:/tmp/pip-qGf_X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:39 INFO - Running setup.py (path:/tmp/pip-QXhMfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:39 INFO - Running setup.py (path:/tmp/pip-GGCmNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:39 INFO - Running setup.py (path:/tmp/pip-t78x5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:39 INFO - Running setup.py (path:/tmp/pip-M0yN81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:39 INFO - Running setup.py (path:/tmp/pip-vKnD2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:39 INFO - Running setup.py (path:/tmp/pip-Hy9mr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:39 INFO - Running setup.py (path:/tmp/pip-gDPHeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:39 INFO - Running setup.py (path:/tmp/pip-WbHzUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:39 INFO - Running setup.py (path:/tmp/pip-gwMchm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:39 INFO - Running setup.py (path:/tmp/pip-nS2H5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:39 INFO - Running setup.py (path:/tmp/pip-Iv8H0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:39 INFO - Running setup.py install for manifestparser 02:44:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:39 INFO - Running setup.py install for mozcrash 02:44:40 INFO - Running setup.py install for mozdebug 02:44:40 INFO - Running setup.py install for mozdevice 02:44:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozfile 02:44:40 INFO - Running setup.py install for mozhttpd 02:44:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozinfo 02:44:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozInstall 02:44:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozleak 02:44:40 INFO - Running setup.py install for mozlog 02:44:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for moznetwork 02:44:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozprocess 02:44:41 INFO - Running setup.py install for mozprofile 02:44:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozrunner 02:44:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozscreenshot 02:44:41 INFO - Running setup.py install for moztest 02:44:41 INFO - Running setup.py install for mozversion 02:44:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:44:41 INFO - Cleaning up... 02:44:41 INFO - Return code: 0 02:44:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:41 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:44:41 INFO - Using env: {'DISPLAY': ':0', 02:44:41 INFO - 'HOME': '/home/cltbld', 02:44:41 INFO - 'LANG': 'en_US.UTF-8', 02:44:41 INFO - 'LANGUAGE': 'en_US:en', 02:44:41 INFO - 'LOGNAME': 'cltbld', 02:44:41 INFO - 'MAIL': '/var/mail/cltbld', 02:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:41 INFO - 'MOZ_NO_REMOTE': '1', 02:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:41 INFO - 'NO_EM_RESTART': '1', 02:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:41 INFO - 'PWD': '/builds/slave/test', 02:44:41 INFO - 'SHELL': '/bin/bash', 02:44:41 INFO - 'SHLVL': '1', 02:44:41 INFO - 'TERM': 'linux', 02:44:41 INFO - 'TMOUT': '86400', 02:44:41 INFO - 'USER': 'cltbld', 02:44:41 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:41 INFO - '_': '/tools/buildbot/bin/python'} 02:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:41 INFO - Running setup.py (path:/tmp/pip-w3axLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:41 INFO - Running setup.py (path:/tmp/pip-Wyyycc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:41 INFO - Running setup.py (path:/tmp/pip-Q_0OOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:42 INFO - Running setup.py (path:/tmp/pip-1IIMpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:42 INFO - Running setup.py (path:/tmp/pip-Q0G4P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:42 INFO - Running setup.py (path:/tmp/pip-GB8anv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:42 INFO - Running setup.py (path:/tmp/pip-vseLZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:42 INFO - Running setup.py (path:/tmp/pip-aYZpz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:42 INFO - Running setup.py (path:/tmp/pip-2wIPEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:42 INFO - Running setup.py (path:/tmp/pip-eESlP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:42 INFO - Running setup.py (path:/tmp/pip-JZsWm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:42 INFO - Running setup.py (path:/tmp/pip-dJ2qa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:42 INFO - Running setup.py (path:/tmp/pip-ZLEjKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:42 INFO - Running setup.py (path:/tmp/pip-LGVMar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:42 INFO - Running setup.py (path:/tmp/pip-npyIfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:42 INFO - Running setup.py (path:/tmp/pip-84iJ_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:42 INFO - Running setup.py (path:/tmp/pip-tRKUIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:44 INFO - Downloading blessings-1.6.tar.gz 02:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:44:44 INFO - Installing collected packages: blessings 02:44:44 INFO - Running setup.py install for blessings 02:44:44 INFO - Successfully installed blessings 02:44:44 INFO - Cleaning up... 02:44:44 INFO - Return code: 0 02:44:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:44 INFO - Reading from file tmpfile_stdout 02:44:44 INFO - Current package versions: 02:44:44 INFO - argparse == 1.2.1 02:44:44 INFO - blessings == 1.6 02:44:44 INFO - blobuploader == 1.2.4 02:44:44 INFO - docopt == 0.6.1 02:44:44 INFO - functools32 == 3.2.3-2 02:44:44 INFO - jsonschema == 2.5.1 02:44:44 INFO - manifestparser == 1.1 02:44:44 INFO - mozInstall == 1.12 02:44:44 INFO - mozcrash == 1.0 02:44:44 INFO - mozdebug == 0.1 02:44:44 INFO - mozdevice == 0.51 02:44:44 INFO - mozfile == 1.2 02:44:44 INFO - mozhttpd == 0.7 02:44:44 INFO - mozinfo == 0.9 02:44:44 INFO - mozleak == 0.1 02:44:44 INFO - mozlog == 3.4 02:44:44 INFO - moznetwork == 0.27 02:44:44 INFO - mozprocess == 0.25 02:44:44 INFO - mozprofile == 0.28 02:44:44 INFO - mozrunner == 6.13 02:44:44 INFO - mozscreenshot == 0.1 02:44:44 INFO - mozsystemmonitor == 0.3 02:44:44 INFO - moztest == 0.8 02:44:44 INFO - mozversion == 1.4 02:44:44 INFO - psutil == 3.1.1 02:44:44 INFO - requests == 1.2.3 02:44:44 INFO - wsgiref == 0.1.2 02:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:44 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:44:44 INFO - Using env: {'DISPLAY': ':0', 02:44:44 INFO - 'HOME': '/home/cltbld', 02:44:44 INFO - 'LANG': 'en_US.UTF-8', 02:44:44 INFO - 'LANGUAGE': 'en_US:en', 02:44:44 INFO - 'LOGNAME': 'cltbld', 02:44:44 INFO - 'MAIL': '/var/mail/cltbld', 02:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:44 INFO - 'MOZ_NO_REMOTE': '1', 02:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:44 INFO - 'NO_EM_RESTART': '1', 02:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:44 INFO - 'PWD': '/builds/slave/test', 02:44:44 INFO - 'SHELL': '/bin/bash', 02:44:44 INFO - 'SHLVL': '1', 02:44:44 INFO - 'TERM': 'linux', 02:44:44 INFO - 'TMOUT': '86400', 02:44:44 INFO - 'USER': 'cltbld', 02:44:44 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:44 INFO - '_': '/tools/buildbot/bin/python'} 02:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:44:44 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:45 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:44:45 INFO - Installing collected packages: marionette-driver 02:44:45 INFO - Running setup.py install for marionette-driver 02:44:46 INFO - Successfully installed marionette-driver 02:44:46 INFO - Cleaning up... 02:44:46 INFO - Return code: 0 02:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:46 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 0x1aa73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e25dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:44:46 INFO - Using env: {'DISPLAY': ':0', 02:44:46 INFO - 'HOME': '/home/cltbld', 02:44:46 INFO - 'LANG': 'en_US.UTF-8', 02:44:46 INFO - 'LANGUAGE': 'en_US:en', 02:44:46 INFO - 'LOGNAME': 'cltbld', 02:44:46 INFO - 'MAIL': '/var/mail/cltbld', 02:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:46 INFO - 'MOZ_NO_REMOTE': '1', 02:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:46 INFO - 'NO_EM_RESTART': '1', 02:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:46 INFO - 'PWD': '/builds/slave/test', 02:44:46 INFO - 'SHELL': '/bin/bash', 02:44:46 INFO - 'SHLVL': '1', 02:44:46 INFO - 'TERM': 'linux', 02:44:46 INFO - 'TMOUT': '86400', 02:44:46 INFO - 'USER': 'cltbld', 02:44:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:46 INFO - '_': '/tools/buildbot/bin/python'} 02:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:44:46 INFO - Cleaning up... 02:44:46 INFO - Return code: 0 02:44:46 INFO - Running post-action listener: _resource_record_post_action 02:44:46 INFO - Running post-action listener: _start_resource_monitoring 02:44:46 INFO - Starting resource monitoring. 02:44:46 INFO - [mozharness: 2017-06-05 09:44:46.405922Z] Finished create-virtualenv step (success) 02:44:46 INFO - [mozharness: 2017-06-05 09:44:46.406487Z] Running install step. 02:44:46 INFO - Running pre-action listener: _resource_record_pre_action 02:44:46 INFO - Running main action method: install 02:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:46 INFO - Reading from file tmpfile_stdout 02:44:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:44:46 INFO - Reading from file tmpfile_stdout 02:44:46 INFO - Output received: 02:44:46 INFO - Usage: mozinstall [options] installer 02:44:46 INFO - Options: 02:44:46 INFO - -h, --help show this help message and exit 02:44:46 INFO - -d DEST, --destination=DEST 02:44:46 INFO - Directory to install application into. [default: 02:44:46 INFO - "/builds/slave/test"] 02:44:46 INFO - --app=APP Application being installed. [default: firefox] 02:44:46 INFO - mkdir: /builds/slave/test/build/application 02:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:45:04 INFO - Reading from file tmpfile_stdout 02:45:04 INFO - Output received: 02:45:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:45:04 INFO - Running post-action listener: _resource_record_post_action 02:45:04 INFO - [mozharness: 2017-06-05 09:45:04.130272Z] Finished install step (success) 02:45:04 INFO - [mozharness: 2017-06-05 09:45:04.130610Z] Running setup-mitmproxy step. 02:45:04 INFO - Running pre-action listener: _resource_record_pre_action 02:45:04 INFO - Running main action method: setup_mitmproxy 02:45:04 INFO - Skipping: mitmproxy is not required 02:45:04 INFO - Running post-action listener: _resource_record_post_action 02:45:04 INFO - [mozharness: 2017-06-05 09:45:04.131728Z] Finished setup-mitmproxy step (success) 02:45:04 INFO - [mozharness: 2017-06-05 09:45:04.131947Z] Running run-tests step. 02:45:04 INFO - Running pre-action listener: _resource_record_pre_action 02:45:04 INFO - Running main action method: run_tests 02:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:04 INFO - Python 2.7.3 02:45:04 INFO - Return code: 0 02:45:04 INFO - grabbing minidump binary from tooltool 02:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:04 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 0x1e22840>, '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 0x1e23740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e23bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:45:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:45:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:45:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:04 INFO - Return code: 0 02:45:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:45:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:04 INFO - ENV: RUST_BACKTRACE is now 1 02:45:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:45:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:04 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/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:45:04 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/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:45:04 INFO - Using env: {'DISPLAY': ':0', 02:45:04 INFO - 'HOME': '/home/cltbld', 02:45:04 INFO - 'LANG': 'en_US.UTF-8', 02:45:04 INFO - 'LANGUAGE': 'en_US:en', 02:45:04 INFO - 'LOGNAME': 'cltbld', 02:45:04 INFO - 'MAIL': '/var/mail/cltbld', 02:45:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:04 INFO - 'MOZ_NO_REMOTE': '1', 02:45:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:04 INFO - 'NO_EM_RESTART': '1', 02:45:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:04 INFO - 'PWD': '/builds/slave/test', 02:45:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:04 INFO - 'RUST_BACKTRACE': '1', 02:45:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:45:04 INFO - 'SHELL': '/bin/bash', 02:45:04 INFO - 'SHLVL': '1', 02:45:04 INFO - 'TERM': 'linux', 02:45:04 INFO - 'TMOUT': '86400', 02:45:04 INFO - 'USER': 'cltbld', 02:45:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431', 02:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:04 INFO - '_': '/tools/buildbot/bin/python'} 02:45:04 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/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:45:04 INFO - mozversion application_buildid: 20170605090212 02:45:04 INFO - mozversion application_changeset: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 02:45:04 INFO - mozversion application_display_name: Nightly 02:45:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:04 INFO - mozversion application_name: Firefox 02:45:04 INFO - mozversion application_remotingname: firefox 02:45:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:45:04 INFO - mozversion application_vendor: Mozilla 02:45:04 INFO - mozversion application_version: 55.0a1 02:45:04 INFO - mozversion platform_buildid: 20170605090212 02:45:04 INFO - mozversion platform_changeset: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 02:45:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:45:04 INFO - mozversion platform_version: 55.0a1 02:45:04 INFO - using testdate: 1496655904 02:45:04 INFO - actual date: 1496655904 02:45:04 INFO - starting webserver on 'localhost:48492' 02:45:04 INFO - SUITE-START | Running 2 tests 02:45:04 INFO - TEST-START | dromaeo_css 02:45:04 INFO - operating with platform_type : linux_ 02:45:04 INFO - Initialising browser for dromaeo_css test... 02:45:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48492/getInfo.html -profile /tmp/tmp3O9AaS/profile 02:45:04 INFO - TEST-INFO | started process 15817 (/builds/slave/test/build/application/firefox/firefox http://localhost:48492/getInfo.html) 02:45:39 INFO - TEST-INFO | 15817: killed by SIGTERM 02:45:39 INFO - Browser initialized. 02:45:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:39 INFO - TEST-INFO | started process 16048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3O9AaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:51 INFO - PID 16048 | RSS: Main: 192294912 02:45:51 INFO - PID 16048 | 02:48:52 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:48492/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48492/tests/dromaeo/cssquery-ext.html) 02:48:54 INFO - PID 16048 | RSS: Main: 186589184 02:48:54 INFO - PID 16048 | 02:51:56 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:48492/tests/dromaeo/cssquery-ext.html (next: http://localhost:48492/tests/dromaeo/cssquery-jquery.html) 02:51:56 INFO - PID 16048 | RSS: Main: 194080768 02:51:56 INFO - PID 16048 | 02:54:58 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:48492/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48492/tests/dromaeo/cssquery-mootools.html) 02:54:59 INFO - PID 16048 | RSS: Main: 188583936 02:54:59 INFO - PID 16048 | 02:58:01 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:48492/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48492/tests/dromaeo/cssquery-prototype.html) 02:58:01 INFO - PID 16048 | RSS: Main: 193167360 02:58:01 INFO - PID 16048 | 03:01:04 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:48492/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48492/tests/dromaeo/cssquery-yui.html) 03:01:05 INFO - PID 16048 | RSS: Main: 192327680 03:01:05 INFO - PID 16048 | 03:04:06 INFO - PID 16048 | Cycle 1(1): loaded http://localhost:48492/tests/dromaeo/cssquery-yui.html (next: http://localhost:48492/tests/dromaeo/cssquery-dojo.html) 03:04:07 INFO - PID 16048 | RSS: Main: 192139264 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | __start_tp_report 03:04:07 INFO - PID 16048 | _x_x_mozilla_page_load 03:04:07 INFO - PID 16048 | _x_x_mozilla_page_load_details 03:04:07 INFO - PID 16048 | |i|pagename|runs| 03:04:07 INFO - PID 16048 | |0;dojo.html;3041.878324867005;3083.2600175957778;3117.7349925256353;3134.827584482853;3135.466970614994;5734.369219385874;5915;5916;5930.22907022087;5938.346781853993;5934.198883150773;5949.25634295713;5958.136070269808;5959.433853783895;6014.578979471439;5411.945880541183;5566.972165139168;5571.665700057989;5581.665100094007;5595.832125036235;5353.973230133864;5514.476124768141;5545.639533430334;5587.7485513152005;5618.241537392461;5502.147167189092;5584.134459158817;5595.328560572737;5639.68981706006;5653.745581448845;5383.515483606455;5409.891802163935;5440.4287549807495;5449.700266485342;5524.889502209973;5483.095289277265;5485.670859748388;5492.0663487206875;5509.173623956399;5536.972315138439;5906.202662640531;5918.585699001072;5919.1417244499735;5949.226600541945;5951.821445356603;6234.594751341148;6390.392912673288;6471.1587493626;6478.384553467413;6492.610443373413;6288.245410550718;6430.421262086435;6492.642904640243;6511.511636627272;6528.37980391862;6018.067199584071;6018.3981601839905;6025.6987150642735;6034.547408944259;6073.18012068374;6314.842128946813;6556.770513032021;6619.238787539398;6621.768238111643;6630.403263706193;6205.317415084337;6274.749010039547;6341.4292713656;6344.936550634527;6368.076628888785;6422.935770642327;6457.2896981332015;6463.4506066983895;6470.417662410311;6472.061551075068;6447.935520644827;6475.028745688184;6479.060536222221;6483.805485835433;6485.643289619022;6218.657973811484;6288.591241569284;6297.4332310091395;6372.235331760218;6457.967710161419;5162.251473536317;5208.9739551302755;5243.370795504564;5258.2638430619745;5263.894722105537;4471.888202794891;4484.215262329079;4503;4521.8191272349395;4537.568930951555;5469.316335458067;5569.526590239794;5617.297837770278;5648.576356773258;5653.152027195872;6503.414692677682;6505.056766768792;6521.9673901630185;6536.117624120683;6539.836504087436;5632.887342253132;5644.322681278273;5651.660900345993;5663.546916246691;5705.771769129271;5553.805616803474;5704.629199102045;5722.113072473773;5736.6558006519745;5748.425157484302;6077.936361136695;6116.327204007555;6125.326214116443;6150.292716337678;6257.7184026718;6464.191976003;6491.870162596627;6525.738970441129;6536;6560.475161987125;6087.36082711309;6107.340534417217;6185.134081228722;6282.937170628235;6310.148130002391;6370.713317900798;6377.87244255103;6386.201724784402;6412.487001039999;6418.326075762165;6280.623162610258;6366.681665916778;6401.263854656588;6546.934530654633;6569.080328754074;6254.186955695731;6287.1512345832725;6319.146915166394;6328.24061112651;6346.650934198663;6340.556161068681;6343.460805831556;6343.809685709436;6358.427741503287;6360.173177486897;6124.601900876429;6181.938180618136;6257.8748425030335;6264.342244064308;6272.937270627235;6158.353372895782;6187.81436556904;6291.087792270004;6311.179546658905;6335.778247761306;6125;6163.506919446344;6167.784127555514;6174.104754810617;6178.443940045418 03:04:07 INFO - PID 16048 | |1;ext.html;719.8128486593484;767.3362541401688;781.8201813582875;1146.0487795130048;1155.8959693627571;36808.44787328189;36972;36992.81503592482;36999;37159;38634.80682596583;38949.22101557967;38980;39057;39091.80454097725;7224.1331040275245;7367.889481657766;7401.481896267263;7422;7516.398688104966;7313.232110628387;7399.186089530147;7404.925950740478;7406.037215162049;7426.665800038984;7373.336399724024;7420.703171873146;7425.962870185642;7433.479656424052;7440.032795736547;7380.852382952365;7381.298776616213;7385.409167266633;7387.409007279405;7400.888986665232;7284.963575182091;7336.303051210127;7339.119305683299;7344.522606030591;7353.7058517659225;34682.82658586716;34890.127746806276;34944;34948;35081.29837403263;3466.5666791651042;3500.667436593545;3500.702440292578;3501.877434289813;3520.700740437066;28027.439451210863;28038.859805700842;28097.43805123886;28098.71901281002;28184;3678.0253232893306;3694.7967861767593;3702.018964974284;3702.8889133326043;3708.8331025103935;140504;143954;152856;162450;164749.40632420947;43218.783906080265;43386.56613433825;43586.346204806956;43628;43657.78171109188;45395.54604453913;45563.772181138884;45772.08455830865;48895.755521222876;49377;14895.329710163069;14991.32539035746;15030;15059.397624095132;15066.698666026618;12253.448594813255;12259.570915017932;12260.877391225973;12269.447874845653;12313.93843030797;13694.94575813616;13822.516211932534;13886.166829990232;13891.930540347435;14073.311202655543;5547.5007249347755;5609.859753506195;5623.718814059281;5674.432556744293;5677.716114194273;959.5442164971582;971.13568923658;984.9261305402124;996.3872218585518;1001.3341128149699;21871.562568748854;22486.212982545534;23241.767582324297;23732.16937407217;23980.52038959211;1052.4737631184407;1069.5614797932965;1077.3320541264309;1084.2356138922041;1116.2409561498098;11362.829557556643;11724.472398742077;11789.115816313812;12087;12703;208093;208178;208385;209530;210174;48935.51064489381;49010.26484602734;49209.50790492121;49254.50745492571;49399;1377.9655508612163;1405.9507917222643;1428.2858570714643;1430.8783753381078;1433.4409580263705;21151.471213219793;21582.568348632627;23112;23283;26649.46701065929;46509.534904651875;46933.765331174494;46978.76510617425;46985.2952205724;47168.528314716415;184875;186200;186252;186321;186971;28170.577441338806;28827.7117228825;31094.378112438077;33600.49599256062;33859.66140338565;37908.62091379051;39636.60363396329;39706.80146599249;39881.800590996856;40159.59840401559;27015.72984270211;28474.57288140721;29029.854850725613;30082.84958575193;30405.695943040286;28680.71319286864;28729.712702872705;29085.85457072701;29165.708342917147;30886.69113308838;33273.33453330871;33337.33325333528;33338.833305833316;33379.33241335208;33384.33231335408;27840.44319113566;27992;28125.71874281231;28908.42183156367;30195;22373;23434.17980370679;23546.764532355144;23626.64560031635;23744.050237990286 03:04:07 INFO - PID 16048 | |2;jquery.html;412.6513096433513;425.03639010189227;434.1750673719932;436.42174119291934;441.8387288639648;14749.926250368733;15258.313375898084;20391.898040509794;21112.26107086252;21142.89428552857;21485.57028859422;22335.66496502554;22339.44151396212;22350.66474002887;22366.776332236714;5835.620684655505;5940.732667029973;5941.554383421239;5955.553333499983;5995.970020149894;5842.503387212071;5930.673812940287;5936.495397891184;5939.376365481627;5943.85140371492;5650.773969041234;5746.051901436258;5846.738973102199;5896.292444906617;5903.085021821603;5744.281964754406;5785.826425207209;5809.564282678795;5830.795922142725;5843.094320380348;5254.894902101974;5255.500727430888;5260.605454590921;5273.077211487975;5285.709285989269;23686.170984015647;24042.7595724044;24170.637440438408;24183.153589624453;24283.514329713307;1860.153630098302;1904.6381187574316;1905.7141428785656;1907.7996810334853;1912.1873203888292;15616.609584760357;16639.916800416042;16654.666906661798;16700.58248543796;16736.748948765777;2158.5251244726137;2177.1835561664375;2228.0419419649543;2240.767577832186;2242.248846636379;103126.48436757768;104156;104310.47844760728;104377;104444.95555044428;10552.736181595368;11653.59212427561;11707.180497365272;11776.293422394512;11822.113341499422;16555.420560280574;16593.087380193963;16600.83399165993;16622.667546648998;16675.583110422336;8655.783605409915;8737.30101591871;8810.955945220232;8901;8951.239144672776;8362.54006029662;8499.575021248913;8500.574971251413;8612.354073444516;8675.86986195195;7493.812654683567;7509.549427034286;7515.511491753018;7685.154632990367;7769.650365733555;2059.104289634014;2064.5960746692394;2074.9066292016896;2119.0782009825775;2220.9000594973263;926.5598840550684;929.080210591523;933.6918816790443;987.913295375096;998.2413365841867;18270.17784199714;18542.81457185411;19079.904600476908;19732.60534789296;20277.391678249674;972.9173020293213;992.4938281476354;998.9300748947504;1000.9649662261932;1009.2430676992255;10066.194704423628;10258.487075646188;10548.736281593021;10875.401852898009;11162.051225645748;465015;467131;470489;475511;482910;99224;99663.50168249113;99885.00804943584;100427;102446;1147.1187252905243;1177.8586569611703;1193.5643490126042;1208.1060015588578;1220.597202923051;15861.286242119364;16468;16587;16640;17855.37506187277;45214;46865;47472.050558989315;47754;48090;59816.10275845779;60146.097808533785;60267;60557.69721151542;60574;9983.650572229937;10013.24900632441;10038.598456061676;10181.236407269336;10225.284230104118;16759.66480670404;17205.247160454266;18074.915505069737;18077;18300.084995750425;14230.573082807532;14516.782248266496;14549.781753273497;14684.926575367055;14732.55802325932;12860.871391285968;12982.527731192606;13000.609981700563;13134.21194728281;13215.537456188988;15216.923915380796;15258.618534536725;15338.233088345314;15363.155026473205;15387.461438849587;10157;10189.74525636865;10235.385876847413;10261.076503114457;10368.53341599645;14151.504697335955;14501.492447764278;14621.780673289697;14665.193414362313;14997.475088371855 03:04:07 INFO - PID 16048 | |3;mootools.html;1284.3449840581304;1321.4978308242867;1332.233965469855;1336.7460182565312;1349.7975303704445;10977.506012229449;11183.217174797768;11466.942665286662;11530.308181509105;11542.538298468051;11252.043576296004;11521.884781152186;11525.596604118857;11536.65390038298;11559.364234967074;2401.687780588521;2458.090506512593;2459.385153711572;2466.519028789387;2469.074097213545;2336.2991102669216;2379.821513386503;2405.230326295586;2407;2429.79346755526;2340.087365927281;2358.7995020423286;2370.7866292033714;2375.0974629640714;2384.403899025244;2259.401258666455;2337.4273303040777;2342.390978345625;2350.083467447697;2351.917682881091;1946.13397038318;2032.9186832526682;2308.319045881452;2326.255598208574;2339.6841426407386;10864.837027444595;10997.065249453726;11002.064824489928;11019.779604407868;11022.724431889186;6228.626282423023;6481.28705842357;6481.4166724994975;6486.254080780724;6492.7402903883785;3844.308024555579;4028.4964379452567;4068.105016896278;4078.857239996586;4110.506739191286;1292.3150730113055;1318.1168617026615;1332.6934804994808;1345.5963211036749;1374.1342953939054;16491.422800201934;16829.737769667325;16948.40680576174;17009.829901701072;17124.74312885308;5527.834164975057;5555.3611334697025;5562.110062389998;5680.943190568124;5685.800996965087;14038.578842634737;14082.577522674335;14117.43530258778;14131.222782747047;14147.575572732834;6396.904046439307;6473.449756770728;6475.3200913903365;6489;6502.057201705727;5773.682447465346;5876.353601103875;5910.527157827363;5933.970330148408;5954.46409823118;4450.599446049871;4467.486239082482;4531.932021019687;4545.0909818036525;4564;1331.593863871509;1348.2112963916022;1357.7759669654397;1381.4198036824357;1391.436468230348;831.8253166834911;851.429542206723;863.3956230638453;868.7654333330092;892.1970226795806;6019.909701354483;6082.635041897501;6234.688265586702;6405.839854003687;6455.257645370749;539.6222644149111;578.632568319112;579.8927198468213;592.4608606168366;595.2559300873908;3991.84032638697;4080.959190408117;4428.7121337112985;4588.118871262766;4619.676622636451;13196.60410187696;13867;14317.78523322151;14331.570052898429;14359.569212923629;13927.721445571235;14228;14232.359543820552;14384.640383990483;14556.053856499293;8839.69061082859;8883.866741998876;9064.818703626022;9072.501012444247;9088.863667044867;6773.900090971618;6941.2364639888565;7078.964605177147;7184.089183166049;7264.782056538313;13114.409851556513;13223.206607603575;13224.603261902159;13427.328633568477;13476.393562289917;13369.66575835612;13400.93299533496;13508;13544.525941591997;13559.389827457591;9384.67153649619;9593.328467007243;9593.808123837623;9624.711258662252;9693.70918872435;10357;10459.581616735246;10461.790764184521;10480.790384192425;10501.159907207559;8795.296376290009;8910.86633700508;9198.172164505228;9229.861552076858;9329.067093290616;8711.956440217758;8757.255633270988;8850.64597416122;8953.597088130919;9025.864612030957;8015.6392962318005;8143.185681432046;8147.75556733299;8187.4678145920325;8195.83608327842;5825.737841797214;5836.941630583639;6187;6221.688915554295;6313.715882785194;6241.96879015602;6317.399847014526;6404.231492220963;6419.325970773001;6501.967490162708 03:04:07 INFO - PID 16048 | |4;prototype.html;387.0903377063899;392.432934409778;403.09706257982117;412.7193508414277;414.2915614299549;5989.790357337494;6089.48239399651;6091.7258723357445;6109.480694140998;6164.691765411734;5878.970605146968;5912.852178695534;5933.554983376253;5950.70246487676;5958.821235362935;4639.909621239023;4680.78936447859;4681.648876334271;4682.344471773954;4700.694454860441;4658.953410465902;4704.45898721648;4712.0811441768865;4716.033213191287;4716.599089077433;4642.767861606923;4654.694407672889;4668.299755036738;4675.859724208279;4677.508861569538;4634.976825115887;4647.581717645395;4668.953310466886;4678.97660511697;4687.20317546018;4071.816768245436;4088.4889388826396;4093.7718684394563;4094.5905409458815;4097.44684467599;5927.881442371128;5939.346671866091;5960.821175364746;5965.22452081231;5978.8505287367725;5354.143337066051;5373.731313434313;5381.973090134564;5389.649672771257;5396.136618141118;6334.1765570476;6383.106365108889;6385.840353991141;6393.328700486429;6399.680015999182;4464.933026004613;4469.195544801934;4477.529859364752;4484.730916145042;4489.573490518395;6346.333634968354;6357.904631430532;6537.150170477855;6701.93298067018;6821.317868213139;4538.659600529973;4549.567791059844;4568.200564901129;4580.312953057068;4590.724556526619;4612.308153776893;4623.838165664186;4640.83757068501;4658.487566367697;4677.859664210079;5160.483951604884;5314.867128321745;5323.600729945269;5329.25390445338;5343.732813359316;6410.4871610272;6429.517786166056;6432.51756118293;6434.420902118832;6440.871182576322;1578.171459983518;1579.7519959232077;1583.116091850694;1586.825449200587;1591.801024871891;1036.2746077745608;1068.8503609494676;1082.5832054659013;1083.8807731149568;1097.5280629329304;5711.8857622848145;5740.6463350027125;5782.479576838105;5787.797427090031;5799.420057994167;6509.934900651027;6550.508711846631;6560.147180866456;6573.3098024706715;6608.735650574019;5708;5718.399568045378;5731.828045158652;5755.798547050833;5768.192453056576;3510.8069056201643;3535.469679548088;3541.4510750833147;3551.9289614207573;3555.235624340779;6450.451711604566;6484.578502397329;6492.902606460907;6502.317256688074;6505.186851643544;6591.176102987127;6702.932970670328;6745.08941292929;6753.45972322213;6772.187337519431;6368.840778980562;6404.327545607737;6406.743730250738;6413.29453760086;6420.7431702731365;6576;6584.440322572635;6584.50616203777;6610.933890661032;6635.568688035262;6528.445082168069;6565.606063636197;6572.474202063919;6579.243387010555;6619.536632435684;5788.784355285437;6067.423594758491;6394.968025159845;6424.871502570016;6457.257415397289;4581.67928245033;4583.816647334203;4600.42494688164;4604.631629469702;4617.79219935097;6645.235797883305;6671.39957403836;6677.666116694243;6677.75297507568;6704.765333213314;6239.78160764371;6378.724255148896;6397.200349956255;6406.327335629878;6457.580257283262;6424.807255782334;6440.130582371507;6447.451966582893;6450.354964503512;6460.806175814733;6321.273053598895;6355.682215889279;6357.618542887257;6357.936420635734;6381.776637817654;6471.935280647133;6483.124778154889;6498.447631951337;6510;6528.183977002875;6306.306306306211;6312.495000400048;6319.178506794271;6340.161353207518;6347.301796802256 03:04:07 INFO - PID 16048 | |5;yui.html;807.2492581898832;820.3109388113979;834.5910503853114;837.5351679817701;845.8984921809382;14766.261686915637;15487.690246195098;17136.31454741809;17654;17724.556886077837;15652.373905043813;16024.519264422086;16112.59718507035;16131.516054518383;16165.353385864551;955.8948515663288;961.6586111930269;963.1524258652377;963.4075043848018;963.8361478548663;949.3070058857038;979.9951000245024;990.1089019882091;1001.4341896828269;1004.7839714461389;1000.9199264058858;1048.7640280936805;1050.3750268590215;1052.5631862776938;1053.2785042246048;993.6671215142936;1043.6764602973026;1045.7176562328204;1047.3820445936897;1052.4264275969538;725.4414101142144;752.4319139049982;762.3634265388407;766.3677466090497;769.1270408086862;17062.317507299693;17400.39098631542;17510.12449377526;17540.561485962826;17978.190981405736;18203.908980455013;18848.62302753951;19214.13536390866;19331.130099145572;19350.709739353922;15055.473058442902;15272.31274592646;15286.464973725866;15305.693886122215;15309.61725956849;3476.200473891019;3525.365434221839;3583.33708263972;3593.047842321787;3602.1354874830113;87596;89885.99999999935;89890;90867.09132908718;91366.54316728374;14166.291685415688;14452.710945781026;14569.053011554428;14590.854091459161;14605.269736513132;23009;23180.304590862303;23246.418839529146;24181.516369672507;25880.870595646902;8471.449355791978;8585.828283434297;8629.266512346521;8686.78283042929;8711.869321960176;3803.904902377463;3878.4764056852528;3950.802459876995;3986.6412022918075;4132.504099508078;4059.5331536873637;4142.606452387018;4179.373094035858;4182.53992060873;4190.078182799779;851.3104385447807;885.2298500304776;889.7997950461095;890.5102193793388;892.205936716323;631.7630888416844;652.9216494020653;654.6203202142746;660.9966950165218;676.2966514824626;10756.623518176826;11063.502142403611;11725.179237453467;12090.395480225954;12281.263124212575;646.615263917968;687.0964681443885;691.5228492340269;706.0503622627558;723.8769409200448;5356.757921965932;5380.950714610613;5521.1442226454965;5769.865149894566;5835.620684655484;91379;91725.08274917299;92346.53826730823;92960;95409;82582.58708706418;82876.58561707153;83233;83419.16580834115;84310;67249.6637516819;70857;71146.28853711397;73318.26681733222;73360;11520.251183673034;12365.75268494643;12489;12663.366831658195;12850.228986260854;29539.261518462212;29669.40661186721;30242;30502.237444064074;30993.225169370948;39075.609243907194;39203.607963919996;39280.410793837545;39420.60579394284;40239.597604024755;16739.24673389676;17234.741478877575;17481.737773933146;17685.734713979044;17739;18184;18311.175997079896;18445.631087377908;18550.907245463688;18878.15048322856;17699.557511061812;17801.376951806626;17912;18208.90895545514;18364;16723.163841807618;16950.660986780444;16983.49049528516;17002.14989250557;17236.396726114526;16653.583660408585;17185.226664799862;17239.7414038787;17285.481435556954;17616.29534818593;11043.834342484708;11564.363959982282;11610.825837612274;11889.464974076014;12137.878621214028;12284.754304913673;13370.331483425594;13646.385912633757;13682.825725420269;13744.450221991008 03:04:07 INFO - PID 16048 | __end_tp_report 03:04:07 INFO - PID 16048 | __start_cc_report 03:04:07 INFO - PID 16048 | _x_x_mozilla_cycle_collect,384 03:04:07 INFO - PID 16048 | __end_cc_report 03:04:07 INFO - PID 16048 | __startTimestamp1496657047226__endTimestamp 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | ------- Summary: start ------- 03:04:07 INFO - PID 16048 | Number of tests: 6 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | [#0] dojo.html Cycles:165 Average:5929.54 Median:6150.29 stddev:683.95 (11.1%) stddev-sans-first:647.45 03:04:07 INFO - PID 16048 | Values: 3041.9 3083.3 3117.7 3134.8 3135.5 5734.4 5915.0 5916.0 5930.2 5938.3 5934.2 5949.3 5958.1 5959.4 6014.6 5411.9 5567.0 5571.7 5581.7 5595.8 5354.0 5514.5 5545.6 5587.7 5618.2 5502.1 5584.1 5595.3 5639.7 5653.7 5383.5 5409.9 5440.4 5449.7 5524.9 5483.1 5485.7 5492.1 5509.2 5537.0 5906.2 5918.6 5919.1 5949.2 5951.8 6234.6 6390.4 6471.2 6478.4 6492.6 6288.2 6430.4 6492.6 6511.5 6528.4 6018.1 6018.4 6025.7 6034.5 6073.2 6314.8 6556.8 6619.2 6621.8 6630.4 6205.3 6274.7 6341.4 6344.9 6368.1 6422.9 6457.3 6463.5 6470.4 6472.1 6447.9 6475.0 6479.1 6483.8 6485.6 6218.7 6288.6 6297.4 6372.2 6458.0 5162.3 5209.0 5243.4 5258.3 5263.9 4471.9 4484.2 4503.0 4521.8 4537.6 5469.3 5569.5 5617.3 5648.6 5653.2 6503.4 6505.1 6522.0 6536.1 6539.8 5632.9 5644.3 5651.7 5663.5 5705.8 5553.8 5704.6 5722.1 5736.7 5748.4 6077.9 6116.3 6125.3 6150.3 6257.7 6464.2 6491.9 6525.7 6536.0 6560.5 6087.4 6107.3 6185.1 6282.9 6310.1 6370.7 6377.9 6386.2 6412.5 6418.3 6280.6 6366.7 6401.3 6546.9 6569.1 6254.2 6287.2 6319.1 6328.2 6346.7 6340.6 6343.5 6343.8 6358.4 6360.2 6124.6 6181.9 6257.9 6264.3 6272.9 6158.4 6187.8 6291.1 6311.2 6335.8 6125.0 6163.5 6167.8 6174.1 6178.4 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | [#1] ext.html Cycles:180 Average:34472.59 Median:33492.41 stddev:47685.11 (142.4%) stddev-sans-first:47751.53 03:04:07 INFO - PID 16048 | Values: 719.8 767.3 781.8 1146.0 1155.9 36808.4 36972.0 36992.8 36999.0 37159.0 38634.8 38949.2 38980.0 39057.0 39091.8 7224.1 7367.9 7401.5 7422.0 7516.4 7313.2 7399.2 7404.9 7406.0 7426.7 7373.3 7420.7 7426.0 7433.5 7440.0 7380.9 7381.3 7385.4 7387.4 7400.9 7285.0 7336.3 7339.1 7344.5 7353.7 34682.8 34890.1 34944.0 34948.0 35081.3 3466.6 3500.7 3500.7 3501.9 3520.7 28027.4 28038.9 28097.4 28098.7 28184.0 3678.0 3694.8 3702.0 3702.9 3708.8 140504.0 143954.0 152856.0 162450.0 164749.4 43218.8 43386.6 43586.3 43628.0 43657.8 45395.5 45563.8 45772.1 48895.8 49377.0 14895.3 14991.3 15030.0 15059.4 15066.7 12253.4 12259.6 12260.9 12269.4 12313.9 13694.9 13822.5 13886.2 13891.9 14073.3 5547.5 5609.9 5623.7 5674.4 5677.7 959.5 971.1 984.9 996.4 1001.3 21871.6 22486.2 23241.8 23732.2 23980.5 1052.5 1069.6 1077.3 1084.2 1116.2 11362.8 11724.5 11789.1 12087.0 12703.0 208093.0 208178.0 208385.0 209530.0 210174.0 48935.5 49010.3 49209.5 49254.5 49399.0 1378.0 1406.0 1428.3 1430.9 1433.4 21151.5 21582.6 23112.0 23283.0 26649.5 46509.5 46933.8 46978.8 46985.3 47168.5 184875.0 186200.0 186252.0 186321.0 186971.0 28170.6 28827.7 31094.4 33600.5 33859.7 37908.6 39636.6 39706.8 39881.8 40159.6 27015.7 28474.6 29029.9 30082.8 30405.7 28680.7 28729.7 29085.9 29165.7 30886.7 33273.3 33337.3 33338.8 33379.3 33384.3 27840.4 27992.0 28125.7 28908.4 30195.0 22373.0 23434.2 23546.8 23626.6 23744.1 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | [#2] jquery.html Cycles:180 Average:30520.22 Median:11630.99 stddev:78541.73 (675.3%) stddev-sans-first:78729.53 03:04:07 INFO - PID 16048 | Values: 412.7 425.0 434.2 436.4 441.8 14749.9 15258.3 20391.9 21112.3 21142.9 21485.6 22335.7 22339.4 22350.7 22366.8 5835.6 5940.7 5941.6 5955.6 5996.0 5842.5 5930.7 5936.5 5939.4 5943.9 5650.8 5746.1 5846.7 5896.3 5903.1 5744.3 5785.8 5809.6 5830.8 5843.1 5254.9 5255.5 5260.6 5273.1 5285.7 23686.2 24042.8 24170.6 24183.2 24283.5 1860.2 1904.6 1905.7 1907.8 1912.2 15616.6 16639.9 16654.7 16700.6 16736.7 2158.5 2177.2 2228.0 2240.8 2242.2 103126.5 104156.0 104310.5 104377.0 104445.0 10552.7 11653.6 11707.2 11776.3 11822.1 16555.4 16593.1 16600.8 16622.7 16675.6 8655.8 8737.3 8811.0 8901.0 8951.2 8362.5 8499.6 8500.6 8612.4 8675.9 7493.8 7509.5 7515.5 7685.2 7769.7 2059.1 2064.6 2074.9 2119.1 2220.9 926.6 929.1 933.7 987.9 998.2 18270.2 18542.8 19079.9 19732.6 20277.4 972.9 992.5 998.9 1001.0 1009.2 10066.2 10258.5 10548.7 10875.4 11162.1 465015.0 467131.0 470489.0 475511.0 482910.0 99224.0 99663.5 99885.0 100427.0 102446.0 1147.1 1177.9 1193.6 1208.1 1220.6 15861.3 16468.0 16587.0 16640.0 17855.4 45214.0 46865.0 47472.1 47754.0 48090.0 59816.1 60146.1 60267.0 60557.7 60574.0 9983.7 10013.2 10038.6 10181.2 10225.3 16759.7 17205.2 18074.9 18077.0 18300.1 14230.6 14516.8 14549.8 14684.9 14732.6 12860.9 12982.5 13000.6 13134.2 13215.5 15216.9 15258.6 15338.2 15363.2 15387.5 10157.0 10189.7 10235.4 10261.1 10368.5 14151.5 14501.5 14621.8 14665.2 14997.5 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | [#3] mootools.html Cycles:180 Average:7087.40 Median:3918.07 stddev:4514.39 (115.2%) stddev-sans-first:4505.99 03:04:07 INFO - PID 16048 | Values: 1284.3 1321.5 1332.2 1336.7 1349.8 10977.5 11183.2 11466.9 11530.3 11542.5 11252.0 11521.9 11525.6 11536.7 11559.4 2401.7 2458.1 2459.4 2466.5 2469.1 2336.3 2379.8 2405.2 2407.0 2429.8 2340.1 2358.8 2370.8 2375.1 2384.4 2259.4 2337.4 2342.4 2350.1 2351.9 1946.1 2032.9 2308.3 2326.3 2339.7 10864.8 10997.1 11002.1 11019.8 11022.7 6228.6 6481.3 6481.4 6486.3 6492.7 3844.3 4028.5 4068.1 4078.9 4110.5 1292.3 1318.1 1332.7 1345.6 1374.1 16491.4 16829.7 16948.4 17009.8 17124.7 5527.8 5555.4 5562.1 5680.9 5685.8 14038.6 14082.6 14117.4 14131.2 14147.6 6396.9 6473.4 6475.3 6489.0 6502.1 5773.7 5876.4 5910.5 5934.0 5954.5 4450.6 4467.5 4531.9 4545.1 4564.0 1331.6 1348.2 1357.8 1381.4 1391.4 831.8 851.4 863.4 868.8 892.2 6019.9 6082.6 6234.7 6405.8 6455.3 539.6 578.6 579.9 592.5 595.3 3991.8 4081.0 4428.7 4588.1 4619.7 13196.6 13867.0 14317.8 14331.6 14359.6 13927.7 14228.0 14232.4 14384.6 14556.1 8839.7 8883.9 9064.8 9072.5 9088.9 6773.9 6941.2 7079.0 7184.1 7264.8 13114.4 13223.2 13224.6 13427.3 13476.4 13369.7 13400.9 13508.0 13544.5 13559.4 9384.7 9593.3 9593.8 9624.7 9693.7 10357.0 10459.6 10461.8 10480.8 10501.2 8795.3 8910.9 9198.2 9229.9 9329.1 8712.0 8757.3 8850.6 8953.6 9025.9 8015.6 8143.2 8147.8 8187.5 8195.8 5825.7 5836.9 6187.0 6221.7 6313.7 6242.0 6317.4 6404.2 6419.3 6502.0 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | [#4] prototype.html Cycles:180 Average:5317.20 Median:5945.02 stddev:1570.05 (26.4%) stddev-sans-first:1530.22 03:04:07 INFO - PID 16048 | Values: 387.1 392.4 403.1 412.7 414.3 5989.8 6089.5 6091.7 6109.5 6164.7 5879.0 5912.9 5933.6 5950.7 5958.8 4639.9 4680.8 4681.6 4682.3 4700.7 4659.0 4704.5 4712.1 4716.0 4716.6 4642.8 4654.7 4668.3 4675.9 4677.5 4635.0 4647.6 4669.0 4679.0 4687.2 4071.8 4088.5 4093.8 4094.6 4097.4 5927.9 5939.3 5960.8 5965.2 5978.9 5354.1 5373.7 5382.0 5389.6 5396.1 6334.2 6383.1 6385.8 6393.3 6399.7 4464.9 4469.2 4477.5 4484.7 4489.6 6346.3 6357.9 6537.2 6701.9 6821.3 4538.7 4549.6 4568.2 4580.3 4590.7 4612.3 4623.8 4640.8 4658.5 4677.9 5160.5 5314.9 5323.6 5329.3 5343.7 6410.5 6429.5 6432.5 6434.4 6440.9 1578.2 1579.8 1583.1 1586.8 1591.8 1036.3 1068.9 1082.6 1083.9 1097.5 5711.9 5740.6 5782.5 5787.8 5799.4 6509.9 6550.5 6560.1 6573.3 6608.7 5708.0 5718.4 5731.8 5755.8 5768.2 3510.8 3535.5 3541.5 3551.9 3555.2 6450.5 6484.6 6492.9 6502.3 6505.2 6591.2 6702.9 6745.1 6753.5 6772.2 6368.8 6404.3 6406.7 6413.3 6420.7 6576.0 6584.4 6584.5 6610.9 6635.6 6528.4 6565.6 6572.5 6579.2 6619.5 5788.8 6067.4 6395.0 6424.9 6457.3 4581.7 4583.8 4600.4 4604.6 4617.8 6645.2 6671.4 6677.7 6677.8 6704.8 6239.8 6378.7 6397.2 6406.3 6457.6 6424.8 6440.1 6447.5 6450.4 6460.8 6321.3 6355.7 6357.6 6357.9 6381.8 6471.9 6483.1 6498.4 6510.0 6528.2 6306.3 6312.5 6319.2 6340.2 6347.3 03:04:07 INFO - PID 16048 | 03:04:07 INFO - PID 16048 | [#5] yui.html Cycles:180 Average:19448.14 Median:27710.07 stddev:24834.76 (89.6%) stddev-sans-first:24864.98 03:04:07 INFO - PID 16048 | Values: 807.2 820.3 834.6 837.5 845.9 14766.3 15487.7 17136.3 17654.0 17724.6 15652.4 16024.5 16112.6 16131.5 16165.4 955.9 961.7 963.2 963.4 963.8 949.3 980.0 990.1 1001.4 1004.8 1000.9 1048.8 1050.4 1052.6 1053.3 993.7 1043.7 1045.7 1047.4 1052.4 725.4 752.4 762.4 766.4 769.1 17062.3 17400.4 17510.1 17540.6 17978.2 18203.9 18848.6 19214.1 19331.1 19350.7 15055.5 15272.3 15286.5 15305.7 15309.6 3476.2 3525.4 3583.3 3593.0 3602.1 87596.0 89886.0 89890.0 90867.1 91366.5 14166.3 14452.7 14569.1 14590.9 14605.3 23009.0 23180.3 23246.4 24181.5 25880.9 8471.4 8585.8 8629.3 8686.8 8711.9 3803.9 3878.5 3950.8 3986.6 4132.5 4059.5 4142.6 4179.4 4182.5 4190.1 851.3 885.2 889.8 890.5 892.2 631.8 652.9 654.6 661.0 676.3 10756.6 11063.5 11725.2 12090.4 12281.3 646.6 687.1 691.5 706.1 723.9 5356.8 5381.0 5521.1 5769.9 5835.6 91379.0 91725.1 92346.5 92960.0 95409.0 82582.6 82876.6 83233.0 83419.2 84310.0 67249.7 70857.0 71146.3 73318.3 73360.0 11520.3 12365.8 12489.0 12663.4 12850.2 29539.3 29669.4 30242.0 30502.2 30993.2 39075.6 39203.6 39280.4 39420.6 40239.6 16739.2 17234.7 17481.7 17685.7 17739.0 18184.0 18311.2 18445.6 18550.9 18878.2 17699.6 17801.4 17912.0 18208.9 18364.0 16723.2 16950.7 16983.5 17002.1 17236.4 16653.6 17185.2 17239.7 17285.5 17616.3 11043.8 11564.4 11610.8 11889.5 12137.9 12284.8 13370.3 13646.4 13682.8 13744.5 03:04:07 INFO - PID 16048 | -------- Summary: end -------- 03:04:07 INFO - PID 16048 | 03:04:08 INFO - TEST-INFO | 16048: exit 0 03:04:08 INFO - TEST-OK | dromaeo_css | took 1143822ms 03:04:08 INFO - TEST-START | kraken 03:04:08 INFO - operating with platform_type : linux_ 03:04:08 INFO - Initialising browser for kraken test... 03:04:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48492/getInfo.html -profile /tmp/tmpvHlcXB/profile 03:04:08 INFO - TEST-INFO | started process 16468 (/builds/slave/test/build/application/firefox/firefox http://localhost:48492/getInfo.html) 03:04:43 INFO - TEST-INFO | 16468: killed by SIGTERM 03:04:43 INFO - Browser initialized. 03:04:43 INFO - Running cycle 1/1 for kraken test... 03:04:43 INFO - TEST-INFO | started process 16697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvHlcXB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:55 INFO - PID 16697 | RSS: Main: 192471040 03:04:55 INFO - PID 16697 | 03:04:57 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48492/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:58 INFO - PID 16697 | RSS: Main: 196521984 03:04:58 INFO - PID 16697 | 03:05:01 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48492/tests/kraken/driver.html?testName=audio-dft) 03:05:02 INFO - PID 16697 | RSS: Main: 194752512 03:05:02 INFO - PID 16697 | 03:05:04 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48492/tests/kraken/driver.html?testName=audio-fft) 03:05:05 INFO - PID 16697 | RSS: Main: 190390272 03:05:05 INFO - PID 16697 | 03:05:07 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48492/tests/kraken/driver.html?testName=audio-oscillator) 03:05:08 INFO - PID 16697 | RSS: Main: 191123456 03:05:08 INFO - PID 16697 | 03:05:10 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48492/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:11 INFO - PID 16697 | RSS: Main: 191324160 03:05:11 INFO - PID 16697 | 03:05:14 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48492/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:14 INFO - PID 16697 | RSS: Main: 192016384 03:05:14 INFO - PID 16697 | 03:05:18 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48492/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:18 INFO - PID 16697 | RSS: Main: 191275008 03:05:18 INFO - PID 16697 | 03:05:21 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48492/tests/kraken/driver.html?testName=json-parse-financial) 03:05:22 INFO - PID 16697 | RSS: Main: 192020480 03:05:22 INFO - PID 16697 | 03:05:24 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48492/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:24 INFO - PID 16697 | RSS: Main: 192667648 03:05:24 INFO - PID 16697 | 03:05:26 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:27 INFO - PID 16697 | RSS: Main: 192032768 03:05:27 INFO - PID 16697 | 03:05:29 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:30 INFO - PID 16697 | RSS: Main: 191991808 03:05:30 INFO - PID 16697 | 03:05:32 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:33 INFO - PID 16697 | RSS: Main: 191905792 03:05:33 INFO - PID 16697 | 03:05:36 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:37 INFO - PID 16697 | RSS: Main: 191832064 03:05:37 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | Cycle 1(1): loaded http://localhost:48492/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48492/tests/kraken/driver.html?testName=ai-astar) 03:05:39 INFO - PID 16697 | RSS: Main: 193204224 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | __start_tp_report 03:05:39 INFO - PID 16697 | _x_x_mozilla_page_load 03:05:39 INFO - PID 16697 | _x_x_mozilla_page_load_details 03:05:39 INFO - PID 16697 | |i|pagename|runs| 03:05:39 INFO - PID 16697 | |0;ai-astar;102;110;111;110;112;112;111;110;111;113 03:05:39 INFO - PID 16697 | |1;audio-beat-detection;148;131;123;171;121;123;127;121;165;128 03:05:39 INFO - PID 16697 | |2;audio-dft;162;164;162;162;166;164;167;174;166;162 03:05:39 INFO - PID 16697 | |3;audio-fft;75;75;73;119;78;73;78;74;93;77 03:05:39 INFO - PID 16697 | |4;audio-oscillator;82;81;111;84;82;81;97;83;83;110 03:05:39 INFO - PID 16697 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;114;114;114 03:05:39 INFO - PID 16697 | |6;imaging-darkroom;150;151;154;151;151;150;151;150;153;152 03:05:39 INFO - PID 16697 | |7;imaging-desaturate;94;96;95;96;95;94;94;95;95;94 03:05:39 INFO - PID 16697 | |8;json-parse-financial;55;54;55;54;56;62;61;56;59;55 03:05:39 INFO - PID 16697 | |9;json-stringify-tinderbox;56;56;56;55;59;56;55;55;56;56 03:05:39 INFO - PID 16697 | |10;stanford-crypto-aes;90;92;88;95;87;94;90;87;113;94 03:05:39 INFO - PID 16697 | |11;stanford-crypto-ccm;137;134;134;138;133;133;136;131;137;139 03:05:39 INFO - PID 16697 | |12;stanford-crypto-pbkdf2;185;199;198;199;195;195;192;194;200;191 03:05:39 INFO - PID 16697 | |13;stanford-crypto-sha256-iterative;73;71;73;72;72;70;73;70;69;72 03:05:39 INFO - PID 16697 | __end_tp_report 03:05:39 INFO - PID 16697 | __start_cc_report 03:05:39 INFO - PID 16697 | _x_x_mozilla_cycle_collect,1027 03:05:39 INFO - PID 16697 | __end_cc_report 03:05:39 INFO - PID 16697 | __startTimestamp1496657139329__endTimestamp 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | ------- Summary: start ------- 03:05:39 INFO - PID 16697 | Number of tests: 14 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.05 (2.7%) stddev-sans-first:1.05 03:05:39 INFO - PID 16697 | Values: 102.0 110.0 111.0 110.0 112.0 112.0 111.0 110.0 111.0 113.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:129.50 stddev:18.76 (14.5%) stddev-sans-first:19.37 03:05:39 INFO - PID 16697 | Values: 148.0 131.0 123.0 171.0 121.0 123.0 127.0 121.0 165.0 128.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:3.73 (2.3%) stddev-sans-first:3.80 03:05:39 INFO - PID 16697 | Values: 162.0 164.0 162.0 162.0 166.0 164.0 167.0 174.0 166.0 162.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:14.41 (19.0%) stddev-sans-first:15.09 03:05:39 INFO - PID 16697 | Values: 75.0 75.0 73.0 119.0 78.0 73.0 78.0 74.0 93.0 77.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.50 stddev:12.07 (14.6%) stddev-sans-first:12.50 03:05:39 INFO - PID 16697 | Values: 82.0 81.0 111.0 84.0 82.0 81.0 97.0 83.0 83.0 110.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:05:39 INFO - PID 16697 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:1.34 (0.9%) stddev-sans-first:1.33 03:05:39 INFO - PID 16697 | Values: 150.0 151.0 154.0 151.0 151.0 150.0 151.0 150.0 153.0 152.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 03:05:39 INFO - PID 16697 | Values: 94.0 96.0 95.0 96.0 95.0 94.0 94.0 95.0 95.0 94.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:2.91 (5.2%) stddev-sans-first:3.02 03:05:39 INFO - PID 16697 | Values: 55.0 54.0 55.0 54.0 56.0 62.0 61.0 56.0 59.0 55.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 03:05:39 INFO - PID 16697 | Values: 56.0 56.0 56.0 55.0 59.0 56.0 55.0 55.0 56.0 56.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:91.00 stddev:7.62 (8.4%) stddev-sans-first:8.00 03:05:39 INFO - PID 16697 | Values: 90.0 92.0 88.0 95.0 87.0 94.0 90.0 87.0 113.0 94.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:136.50 stddev:2.57 (1.9%) stddev-sans-first:2.65 03:05:39 INFO - PID 16697 | Values: 137.0 134.0 134.0 138.0 133.0 133.0 136.0 131.0 137.0 139.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.80 Median:196.50 stddev:4.61 (2.3%) stddev-sans-first:3.26 03:05:39 INFO - PID 16697 | Values: 185.0 199.0 198.0 199.0 195.0 195.0 192.0 194.0 200.0 191.0 03:05:39 INFO - PID 16697 | 03:05:39 INFO - PID 16697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:1.43 (2.0%) stddev-sans-first:1.41 03:05:39 INFO - PID 16697 | Values: 73.0 71.0 73.0 72.0 72.0 70.0 73.0 70.0 69.0 72.0 03:05:39 INFO - PID 16697 | -------- Summary: end -------- 03:05:39 INFO - PID 16697 | 03:05:40 INFO - TEST-INFO | 16697: exit 0 03:05:40 INFO - TEST-OK | kraken | took 92351ms 03:05:40 INFO - SUITE-END | took 1236s 03:05:41 INFO - Completed test suite (00:20:36) 03:05:41 INFO - javascript benchmark 03:05:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7659.167428972188, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3041.878324867005, 3083.2600175957778, 3117.7349925256353, 3134.827584482853, 3135.466970614994, 5734.369219385874, 5915.0, 5916.0, 5930.22907022087, 5938.346781853993, 5934.198883150773, 5949.25634295713, 5958.136070269808, 5959.433853783895, 6014.578979471439, 5411.945880541183, 5566.972165139168, 5571.665700057989, 5581.665100094007, 5595.832125036235, 5353.973230133864, 5514.476124768141, 5545.639533430334, 5587.7485513152005, 5618.241537392461, 5502.147167189092, 5584.134459158817, 5595.328560572737, 5639.68981706006, 5653.745581448845, 5383.515483606455, 5409.891802163935, 5440.4287549807495, 5449.700266485342, 5524.889502209973, 5483.095289277265, 5485.670859748388, 5492.0663487206875, 5509.173623956399, 5536.972315138439, 5906.202662640531, 5918.585699001072, 5919.1417244499735, 5949.226600541945, 5951.821445356603, 6234.594751341148, 6390.392912673288, 6471.1587493626, 6478.384553467413, 6492.610443373413, 6288.245410550718, 6430.421262086435, 6492.642904640243, 6511.511636627272, 6528.37980391862, 6018.067199584071, 6018.3981601839905, 6025.6987150642735, 6034.547408944259, 6073.18012068374, 6314.842128946813, 6556.770513032021, 6619.238787539398, 6621.768238111643, 6630.403263706193, 6205.317415084337, 6274.749010039547, 6341.4292713656, 6344.936550634527, 6368.076628888785, 6422.935770642327, 6457.2896981332015, 6463.4506066983895, 6470.417662410311, 6472.061551075068, 6447.935520644827, 6475.028745688184, 6479.060536222221, 6483.805485835433, 6485.643289619022, 6218.657973811484, 6288.591241569284, 6297.4332310091395, 6372.235331760218, 6457.967710161419, 5162.251473536317, 5208.9739551302755, 5243.370795504564, 5258.2638430619745, 5263.894722105537, 4471.888202794891, 4484.215262329079, 4503.0, 4521.8191272349395, 4537.568930951555, 5469.316335458067, 5569.526590239794, 5617.297837770278, 5648.576356773258, 5653.152027195872, 6503.414692677682, 6505.056766768792, 6521.9673901630185, 6536.117624120683, 6539.836504087436, 5632.887342253132, 5644.322681278273, 5651.660900345993, 5663.546916246691, 5705.771769129271, 5553.805616803474, 5704.629199102045, 5722.113072473773, 5736.6558006519745, 5748.425157484302, 6077.936361136695, 6116.327204007555, 6125.326214116443, 6150.292716337678, 6257.7184026718, 6464.191976003, 6491.870162596627, 6525.738970441129, 6536.0, 6560.475161987125, 6087.36082711309, 6107.340534417217, 6185.134081228722, 6282.937170628235, 6310.148130002391, 6370.713317900798, 6377.87244255103, 6386.201724784402, 6412.487001039999, 6418.326075762165, 6280.623162610258, 6366.681665916778, 6401.263854656588, 6546.934530654633, 6569.080328754074, 6254.186955695731, 6287.1512345832725, 6319.146915166394, 6328.24061112651, 6346.650934198663, 6340.556161068681, 6343.460805831556, 6343.809685709436, 6358.427741503287, 6360.173177486897, 6124.601900876429, 6181.938180618136, 6257.8748425030335, 6264.342244064308, 6272.937270627235, 6158.353372895782, 6187.81436556904, 6291.087792270004, 6311.179546658905, 6335.778247761306, 6125.0, 6163.506919446344, 6167.784127555514, 6174.104754810617, 6178.443940045418], "value": 5879.776559996562, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8128486593484, 767.3362541401688, 781.8201813582875, 1146.0487795130048, 1155.8959693627571, 36808.44787328189, 36972.0, 36992.81503592482, 36999.0, 37159.0, 38634.80682596583, 38949.22101557967, 38980.0, 39057.0, 39091.80454097725, 7224.1331040275245, 7367.889481657766, 7401.481896267263, 7422.0, 7516.398688104966, 7313.232110628387, 7399.186089530147, 7404.925950740478, 7406.037215162049, 7426.665800038984, 7373.336399724024, 7420.703171873146, 7425.962870185642, 7433.479656424052, 7440.032795736547, 7380.852382952365, 7381.298776616213, 7385.409167266633, 7387.409007279405, 7400.888986665232, 7284.963575182091, 7336.303051210127, 7339.119305683299, 7344.522606030591, 7353.7058517659225, 34682.82658586716, 34890.127746806276, 34944.0, 34948.0, 35081.29837403263, 3466.5666791651042, 3500.667436593545, 3500.702440292578, 3501.877434289813, 3520.700740437066, 28027.439451210863, 28038.859805700842, 28097.43805123886, 28098.71901281002, 28184.0, 3678.0253232893306, 3694.7967861767593, 3702.018964974284, 3702.8889133326043, 3708.8331025103935, 140504.0, 143954.0, 152856.0, 162450.0, 164749.40632420947, 43218.783906080265, 43386.56613433825, 43586.346204806956, 43628.0, 43657.78171109188, 45395.54604453913, 45563.772181138884, 45772.08455830865, 48895.755521222876, 49377.0, 14895.329710163069, 14991.32539035746, 15030.0, 15059.397624095132, 15066.698666026618, 12253.448594813255, 12259.570915017932, 12260.877391225973, 12269.447874845653, 12313.93843030797, 13694.94575813616, 13822.516211932534, 13886.166829990232, 13891.930540347435, 14073.311202655543, 5547.5007249347755, 5609.859753506195, 5623.718814059281, 5674.432556744293, 5677.716114194273, 959.5442164971582, 971.13568923658, 984.9261305402124, 996.3872218585518, 1001.3341128149699, 21871.562568748854, 22486.212982545534, 23241.767582324297, 23732.16937407217, 23980.52038959211, 1052.4737631184407, 1069.5614797932965, 1077.3320541264309, 1084.2356138922041, 1116.2409561498098, 11362.829557556643, 11724.472398742077, 11789.115816313812, 12087.0, 12703.0, 208093.0, 208178.0, 208385.0, 209530.0, 210174.0, 48935.51064489381, 49010.26484602734, 49209.50790492121, 49254.50745492571, 49399.0, 1377.9655508612163, 1405.9507917222643, 1428.2858570714643, 1430.8783753381078, 1433.4409580263705, 21151.471213219793, 21582.568348632627, 23112.0, 23283.0, 26649.46701065929, 46509.534904651875, 46933.765331174494, 46978.76510617425, 46985.2952205724, 47168.528314716415, 184875.0, 186200.0, 186252.0, 186321.0, 186971.0, 28170.577441338806, 28827.7117228825, 31094.378112438077, 33600.49599256062, 33859.66140338565, 37908.62091379051, 39636.60363396329, 39706.80146599249, 39881.800590996856, 40159.59840401559, 27015.72984270211, 28474.57288140721, 29029.854850725613, 30082.84958575193, 30405.695943040286, 28680.71319286864, 28729.712702872705, 29085.85457072701, 29165.708342917147, 30886.69113308838, 33273.33453330871, 33337.33325333528, 33338.833305833316, 33379.33241335208, 33384.33231335408, 27840.44319113566, 27992.0, 28125.71874281231, 28908.42183156367, 30195.0, 22373.0, 23434.17980370679, 23546.764532355144, 23626.64560031635, 23744.050237990286], "value": 16174.502741750073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.6513096433513, 425.03639010189227, 434.1750673719932, 436.42174119291934, 441.8387288639648, 14749.926250368733, 15258.313375898084, 20391.898040509794, 21112.26107086252, 21142.89428552857, 21485.57028859422, 22335.66496502554, 22339.44151396212, 22350.66474002887, 22366.776332236714, 5835.620684655505, 5940.732667029973, 5941.554383421239, 5955.553333499983, 5995.970020149894, 5842.503387212071, 5930.673812940287, 5936.495397891184, 5939.376365481627, 5943.85140371492, 5650.773969041234, 5746.051901436258, 5846.738973102199, 5896.292444906617, 5903.085021821603, 5744.281964754406, 5785.826425207209, 5809.564282678795, 5830.795922142725, 5843.094320380348, 5254.894902101974, 5255.500727430888, 5260.605454590921, 5273.077211487975, 5285.709285989269, 23686.170984015647, 24042.7595724044, 24170.637440438408, 24183.153589624453, 24283.514329713307, 1860.153630098302, 1904.6381187574316, 1905.7141428785656, 1907.7996810334853, 1912.1873203888292, 15616.609584760357, 16639.916800416042, 16654.666906661798, 16700.58248543796, 16736.748948765777, 2158.5251244726137, 2177.1835561664375, 2228.0419419649543, 2240.767577832186, 2242.248846636379, 103126.48436757768, 104156.0, 104310.47844760728, 104377.0, 104444.95555044428, 10552.736181595368, 11653.59212427561, 11707.180497365272, 11776.293422394512, 11822.113341499422, 16555.420560280574, 16593.087380193963, 16600.83399165993, 16622.667546648998, 16675.583110422336, 8655.783605409915, 8737.30101591871, 8810.955945220232, 8901.0, 8951.239144672776, 8362.54006029662, 8499.575021248913, 8500.574971251413, 8612.354073444516, 8675.86986195195, 7493.812654683567, 7509.549427034286, 7515.511491753018, 7685.154632990367, 7769.650365733555, 2059.104289634014, 2064.5960746692394, 2074.9066292016896, 2119.0782009825775, 2220.9000594973263, 926.5598840550684, 929.080210591523, 933.6918816790443, 987.913295375096, 998.2413365841867, 18270.17784199714, 18542.81457185411, 19079.904600476908, 19732.60534789296, 20277.391678249674, 972.9173020293213, 992.4938281476354, 998.9300748947504, 1000.9649662261932, 1009.2430676992255, 10066.194704423628, 10258.487075646188, 10548.736281593021, 10875.401852898009, 11162.051225645748, 465015.0, 467131.0, 470489.0, 475511.0, 482910.0, 99224.0, 99663.50168249113, 99885.00804943584, 100427.0, 102446.0, 1147.1187252905243, 1177.8586569611703, 1193.5643490126042, 1208.1060015588578, 1220.597202923051, 15861.286242119364, 16468.0, 16587.0, 16640.0, 17855.37506187277, 45214.0, 46865.0, 47472.050558989315, 47754.0, 48090.0, 59816.10275845779, 60146.097808533785, 60267.0, 60557.69721151542, 60574.0, 9983.650572229937, 10013.24900632441, 10038.598456061676, 10181.236407269336, 10225.284230104118, 16759.66480670404, 17205.247160454266, 18074.915505069737, 18077.0, 18300.084995750425, 14230.573082807532, 14516.782248266496, 14549.781753273497, 14684.926575367055, 14732.55802325932, 12860.871391285968, 12982.527731192606, 13000.609981700563, 13134.21194728281, 13215.537456188988, 15216.923915380796, 15258.618534536725, 15338.233088345314, 15363.155026473205, 15387.461438849587, 10157.0, 10189.74525636865, 10235.385876847413, 10261.076503114457, 10368.53341599645, 14151.504697335955, 14501.492447764278, 14621.780673289697, 14665.193414362313, 14997.475088371855], "value": 10157.377022799701, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.3449840581304, 1321.4978308242867, 1332.233965469855, 1336.7460182565312, 1349.7975303704445, 10977.506012229449, 11183.217174797768, 11466.942665286662, 11530.308181509105, 11542.538298468051, 11252.043576296004, 11521.884781152186, 11525.596604118857, 11536.65390038298, 11559.364234967074, 2401.687780588521, 2458.090506512593, 2459.385153711572, 2466.519028789387, 2469.074097213545, 2336.2991102669216, 2379.821513386503, 2405.230326295586, 2407.0, 2429.79346755526, 2340.087365927281, 2358.7995020423286, 2370.7866292033714, 2375.0974629640714, 2384.403899025244, 2259.401258666455, 2337.4273303040777, 2342.390978345625, 2350.083467447697, 2351.917682881091, 1946.13397038318, 2032.9186832526682, 2308.319045881452, 2326.255598208574, 2339.6841426407386, 10864.837027444595, 10997.065249453726, 11002.064824489928, 11019.779604407868, 11022.724431889186, 6228.626282423023, 6481.28705842357, 6481.4166724994975, 6486.254080780724, 6492.7402903883785, 3844.308024555579, 4028.4964379452567, 4068.105016896278, 4078.857239996586, 4110.506739191286, 1292.3150730113055, 1318.1168617026615, 1332.6934804994808, 1345.5963211036749, 1374.1342953939054, 16491.422800201934, 16829.737769667325, 16948.40680576174, 17009.829901701072, 17124.74312885308, 5527.834164975057, 5555.3611334697025, 5562.110062389998, 5680.943190568124, 5685.800996965087, 14038.578842634737, 14082.577522674335, 14117.43530258778, 14131.222782747047, 14147.575572732834, 6396.904046439307, 6473.449756770728, 6475.3200913903365, 6489.0, 6502.057201705727, 5773.682447465346, 5876.353601103875, 5910.527157827363, 5933.970330148408, 5954.46409823118, 4450.599446049871, 4467.486239082482, 4531.932021019687, 4545.0909818036525, 4564.0, 1331.593863871509, 1348.2112963916022, 1357.7759669654397, 1381.4198036824357, 1391.436468230348, 831.8253166834911, 851.429542206723, 863.3956230638453, 868.7654333330092, 892.1970226795806, 6019.909701354483, 6082.635041897501, 6234.688265586702, 6405.839854003687, 6455.257645370749, 539.6222644149111, 578.632568319112, 579.8927198468213, 592.4608606168366, 595.2559300873908, 3991.84032638697, 4080.959190408117, 4428.7121337112985, 4588.118871262766, 4619.676622636451, 13196.60410187696, 13867.0, 14317.78523322151, 14331.570052898429, 14359.569212923629, 13927.721445571235, 14228.0, 14232.359543820552, 14384.640383990483, 14556.053856499293, 8839.69061082859, 8883.866741998876, 9064.818703626022, 9072.501012444247, 9088.863667044867, 6773.900090971618, 6941.2364639888565, 7078.964605177147, 7184.089183166049, 7264.782056538313, 13114.409851556513, 13223.206607603575, 13224.603261902159, 13427.328633568477, 13476.393562289917, 13369.66575835612, 13400.93299533496, 13508.0, 13544.525941591997, 13559.389827457591, 9384.67153649619, 9593.328467007243, 9593.808123837623, 9624.711258662252, 9693.70918872435, 10357.0, 10459.581616735246, 10461.790764184521, 10480.790384192425, 10501.159907207559, 8795.296376290009, 8910.86633700508, 9198.172164505228, 9229.861552076858, 9329.067093290616, 8711.956440217758, 8757.255633270988, 8850.64597416122, 8953.597088130919, 9025.864612030957, 8015.6392962318005, 8143.185681432046, 8147.75556733299, 8187.4678145920325, 8195.83608327842, 5825.737841797214, 5836.941630583639, 6187.0, 6221.688915554295, 6313.715882785194, 6241.96879015602, 6317.399847014526, 6404.231492220963, 6419.325970773001, 6501.967490162708], "value": 5292.548012159984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.0903377063899, 392.432934409778, 403.09706257982117, 412.7193508414277, 414.2915614299549, 5989.790357337494, 6089.48239399651, 6091.7258723357445, 6109.480694140998, 6164.691765411734, 5878.970605146968, 5912.852178695534, 5933.554983376253, 5950.70246487676, 5958.821235362935, 4639.909621239023, 4680.78936447859, 4681.648876334271, 4682.344471773954, 4700.694454860441, 4658.953410465902, 4704.45898721648, 4712.0811441768865, 4716.033213191287, 4716.599089077433, 4642.767861606923, 4654.694407672889, 4668.299755036738, 4675.859724208279, 4677.508861569538, 4634.976825115887, 4647.581717645395, 4668.953310466886, 4678.97660511697, 4687.20317546018, 4071.816768245436, 4088.4889388826396, 4093.7718684394563, 4094.5905409458815, 4097.44684467599, 5927.881442371128, 5939.346671866091, 5960.821175364746, 5965.22452081231, 5978.8505287367725, 5354.143337066051, 5373.731313434313, 5381.973090134564, 5389.649672771257, 5396.136618141118, 6334.1765570476, 6383.106365108889, 6385.840353991141, 6393.328700486429, 6399.680015999182, 4464.933026004613, 4469.195544801934, 4477.529859364752, 4484.730916145042, 4489.573490518395, 6346.333634968354, 6357.904631430532, 6537.150170477855, 6701.93298067018, 6821.317868213139, 4538.659600529973, 4549.567791059844, 4568.200564901129, 4580.312953057068, 4590.724556526619, 4612.308153776893, 4623.838165664186, 4640.83757068501, 4658.487566367697, 4677.859664210079, 5160.483951604884, 5314.867128321745, 5323.600729945269, 5329.25390445338, 5343.732813359316, 6410.4871610272, 6429.517786166056, 6432.51756118293, 6434.420902118832, 6440.871182576322, 1578.171459983518, 1579.7519959232077, 1583.116091850694, 1586.825449200587, 1591.801024871891, 1036.2746077745608, 1068.8503609494676, 1082.5832054659013, 1083.8807731149568, 1097.5280629329304, 5711.8857622848145, 5740.6463350027125, 5782.479576838105, 5787.797427090031, 5799.420057994167, 6509.934900651027, 6550.508711846631, 6560.147180866456, 6573.3098024706715, 6608.735650574019, 5708.0, 5718.399568045378, 5731.828045158652, 5755.798547050833, 5768.192453056576, 3510.8069056201643, 3535.469679548088, 3541.4510750833147, 3551.9289614207573, 3555.235624340779, 6450.451711604566, 6484.578502397329, 6492.902606460907, 6502.317256688074, 6505.186851643544, 6591.176102987127, 6702.932970670328, 6745.08941292929, 6753.45972322213, 6772.187337519431, 6368.840778980562, 6404.327545607737, 6406.743730250738, 6413.29453760086, 6420.7431702731365, 6576.0, 6584.440322572635, 6584.50616203777, 6610.933890661032, 6635.568688035262, 6528.445082168069, 6565.606063636197, 6572.474202063919, 6579.243387010555, 6619.536632435684, 5788.784355285437, 6067.423594758491, 6394.968025159845, 6424.871502570016, 6457.257415397289, 4581.67928245033, 4583.816647334203, 4600.42494688164, 4604.631629469702, 4617.79219935097, 6645.235797883305, 6671.39957403836, 6677.666116694243, 6677.75297507568, 6704.765333213314, 6239.78160764371, 6378.724255148896, 6397.200349956255, 6406.327335629878, 6457.580257283262, 6424.807255782334, 6440.130582371507, 6447.451966582893, 6450.354964503512, 6460.806175814733, 6321.273053598895, 6355.682215889279, 6357.618542887257, 6357.936420635734, 6381.776637817654, 6471.935280647133, 6483.124778154889, 6498.447631951337, 6510.0, 6528.183977002875, 6306.306306306211, 6312.495000400048, 6319.178506794271, 6340.161353207518, 6347.301796802256], "value": 4823.293465224335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.2492581898832, 820.3109388113979, 834.5910503853114, 837.5351679817701, 845.8984921809382, 14766.261686915637, 15487.690246195098, 17136.31454741809, 17654.0, 17724.556886077837, 15652.373905043813, 16024.519264422086, 16112.59718507035, 16131.516054518383, 16165.353385864551, 955.8948515663288, 961.6586111930269, 963.1524258652377, 963.4075043848018, 963.8361478548663, 949.3070058857038, 979.9951000245024, 990.1089019882091, 1001.4341896828269, 1004.7839714461389, 1000.9199264058858, 1048.7640280936805, 1050.3750268590215, 1052.5631862776938, 1053.2785042246048, 993.6671215142936, 1043.6764602973026, 1045.7176562328204, 1047.3820445936897, 1052.4264275969538, 725.4414101142144, 752.4319139049982, 762.3634265388407, 766.3677466090497, 769.1270408086862, 17062.317507299693, 17400.39098631542, 17510.12449377526, 17540.561485962826, 17978.190981405736, 18203.908980455013, 18848.62302753951, 19214.13536390866, 19331.130099145572, 19350.709739353922, 15055.473058442902, 15272.31274592646, 15286.464973725866, 15305.693886122215, 15309.61725956849, 3476.200473891019, 3525.365434221839, 3583.33708263972, 3593.047842321787, 3602.1354874830113, 87596.0, 89885.99999999935, 89890.0, 90867.09132908718, 91366.54316728374, 14166.291685415688, 14452.710945781026, 14569.053011554428, 14590.854091459161, 14605.269736513132, 23009.0, 23180.304590862303, 23246.418839529146, 24181.516369672507, 25880.870595646902, 8471.449355791978, 8585.828283434297, 8629.266512346521, 8686.78283042929, 8711.869321960176, 3803.904902377463, 3878.4764056852528, 3950.802459876995, 3986.6412022918075, 4132.504099508078, 4059.5331536873637, 4142.606452387018, 4179.373094035858, 4182.53992060873, 4190.078182799779, 851.3104385447807, 885.2298500304776, 889.7997950461095, 890.5102193793388, 892.205936716323, 631.7630888416844, 652.9216494020653, 654.6203202142746, 660.9966950165218, 676.2966514824626, 10756.623518176826, 11063.502142403611, 11725.179237453467, 12090.395480225954, 12281.263124212575, 646.615263917968, 687.0964681443885, 691.5228492340269, 706.0503622627558, 723.8769409200448, 5356.757921965932, 5380.950714610613, 5521.1442226454965, 5769.865149894566, 5835.620684655484, 91379.0, 91725.08274917299, 92346.53826730823, 92960.0, 95409.0, 82582.58708706418, 82876.58561707153, 83233.0, 83419.16580834115, 84310.0, 67249.6637516819, 70857.0, 71146.28853711397, 73318.26681733222, 73360.0, 11520.251183673034, 12365.75268494643, 12489.0, 12663.366831658195, 12850.228986260854, 29539.261518462212, 29669.40661186721, 30242.0, 30502.237444064074, 30993.225169370948, 39075.609243907194, 39203.607963919996, 39280.410793837545, 39420.60579394284, 40239.597604024755, 16739.24673389676, 17234.741478877575, 17481.737773933146, 17685.734713979044, 17739.0, 18184.0, 18311.175997079896, 18445.631087377908, 18550.907245463688, 18878.15048322856, 17699.557511061812, 17801.376951806626, 17912.0, 18208.90895545514, 18364.0, 16723.163841807618, 16950.660986780444, 16983.49049528516, 17002.14989250557, 17236.396726114526, 16653.583660408585, 17185.226664799862, 17239.7414038787, 17285.481435556954, 17616.29534818593, 11043.834342484708, 11564.363959982282, 11610.825837612274, 11889.464974076014, 12137.878621214028, 12284.754304913673, 13370.331483425594, 13646.385912633757, 13682.825725420269, 13744.450221991008], "value": 8186.1397635699805, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 111.0, 110.0, 112.0, 112.0, 111.0, 110.0, 111.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 123.0, 171.0, 121.0, 123.0, 127.0, 121.0, 165.0, 128.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 166.0, 164.0, 167.0, 174.0, 166.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 119.0, 78.0, 73.0, 78.0, 74.0, 93.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 111.0, 84.0, 82.0, 81.0, 97.0, 83.0, 83.0, 110.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 154.0, 151.0, 151.0, 150.0, 151.0, 150.0, 153.0, 152.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 56.0, 62.0, 61.0, 56.0, 59.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 59.0, 56.0, 55.0, 55.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 88.0, 95.0, 87.0, 94.0, 90.0, 87.0, 113.0, 94.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 134.0, 138.0, 133.0, 133.0, 136.0, 131.0, 137.0, 139.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 199.0, 198.0, 199.0, 195.0, 195.0, 192.0, 194.0, 200.0, 191.0], "value": 194.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 73.0, 72.0, 72.0, 70.0, 73.0, 70.0, 69.0, 72.0], "value": 71.5, "unit": "score"}]}]} 03:05:41 INFO - Return code: 0 03:05:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:05:41 INFO - # TBPL SUCCESS # 03:05:41 INFO - Running post-action listener: _resource_record_post_action 03:05:41 INFO - [mozharness: 2017-06-05 10:05:41.242930Z] Finished run-tests step (success) 03:05:41 INFO - Running post-run listener: _resource_record_post_run 03:05:41 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432738304; Read time: 28; Write time: 308584 03:05:41 INFO - TinderboxPrint: CPU usage
12.7% 03:05:41 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 03:05:41 INFO - TinderboxPrint: I/O write bytes / time
432,738,304 / 308,584 03:05:41 INFO - TinderboxPrint: CPU idle
8,737.0 (87.3%) 03:05:41 INFO - TinderboxPrint: CPU user
1,214.5 (12.1%) 03:05:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:05:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103841792; Read time: 0; Write time: 92100 03:05:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:05:41 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 8192; Write bytes: 328896512; Read time: 28; Write time: 216484 03:05:41 INFO - Running post-run listener: _upload_blobber_files 03:05:41 INFO - Blob upload gear active. 03:05:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:05:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:43 INFO - (blobuploader) - INFO - Done attempting. 03:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:44 INFO - (blobuploader) - INFO - Done attempting. 03:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:44 INFO - (blobuploader) - INFO - Done attempting. 03:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:05:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:48 INFO - (blobuploader) - INFO - Done attempting. 03:05:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:05:48 INFO - Return code: 0 03:05:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:05:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:05:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8cee33a30411785d6b468cbdca7609ee561365b3d244db33bf48b059214023689ac278576e2256710d69cf73f40f4c81989ac3cbc71cd77149c6caf650d054a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbb944402d227343036120e828955f57b84179443c364b35e72a9529c219d7df4dac37dc4e3d3d570a9f879fd0908b8933d3f07165465db90f2a4b0b15f7829e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101b13ce8e01fd5ebca1c6db9994773df9a67ba63d235da1945b0bd72d51a4875e224178ca145b9fc484d95ea7f86f740280b34a5d4213728add6df2d4ad3256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823fd2785fa2b138b0b8eec07e595afa1493580227ffdc8a8def904155dccd54dd1e74a003d0cdf33513cff8aa53b8812af69837912a08c1a80f668138edd5df"} 03:05:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:05:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:05:48 INFO - Contents: 03:05:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8cee33a30411785d6b468cbdca7609ee561365b3d244db33bf48b059214023689ac278576e2256710d69cf73f40f4c81989ac3cbc71cd77149c6caf650d054a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbb944402d227343036120e828955f57b84179443c364b35e72a9529c219d7df4dac37dc4e3d3d570a9f879fd0908b8933d3f07165465db90f2a4b0b15f7829e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101b13ce8e01fd5ebca1c6db9994773df9a67ba63d235da1945b0bd72d51a4875e224178ca145b9fc484d95ea7f86f740280b34a5d4213728add6df2d4ad3256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823fd2785fa2b138b0b8eec07e595afa1493580227ffdc8a8def904155dccd54dd1e74a003d0cdf33513cff8aa53b8812af69837912a08c1a80f668138edd5df"} 03:05:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:05:48 INFO - Copying logs to upload dir... 03:05:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:05:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.826843 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-06-05 03:05:48.148718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:05:48.156279) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431 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/f8cee33a30411785d6b468cbdca7609ee561365b3d244db33bf48b059214023689ac278576e2256710d69cf73f40f4c81989ac3cbc71cd77149c6caf650d054a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbb944402d227343036120e828955f57b84179443c364b35e72a9529c219d7df4dac37dc4e3d3d570a9f879fd0908b8933d3f07165465db90f2a4b0b15f7829e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101b13ce8e01fd5ebca1c6db9994773df9a67ba63d235da1945b0bd72d51a4875e224178ca145b9fc484d95ea7f86f740280b34a5d4213728add6df2d4ad3256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823fd2785fa2b138b0b8eec07e595afa1493580227ffdc8a8def904155dccd54dd1e74a003d0cdf33513cff8aa53b8812af69837912a08c1a80f668138edd5df"} build_url:https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8cee33a30411785d6b468cbdca7609ee561365b3d244db33bf48b059214023689ac278576e2256710d69cf73f40f4c81989ac3cbc71cd77149c6caf650d054a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbb944402d227343036120e828955f57b84179443c364b35e72a9529c219d7df4dac37dc4e3d3d570a9f879fd0908b8933d3f07165465db90f2a4b0b15f7829e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101b13ce8e01fd5ebca1c6db9994773df9a67ba63d235da1945b0bd72d51a4875e224178ca145b9fc484d95ea7f86f740280b34a5d4213728add6df2d4ad3256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/823fd2785fa2b138b0b8eec07e595afa1493580227ffdc8a8def904155dccd54dd1e74a003d0cdf33513cff8aa53b8812af69837912a08c1a80f668138edd5df"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:05:48.183422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:05:48.183766) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1496645921.153757-644869431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:05:48.269067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:05:48.269423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:05:48.269734) ========= ========= Total master_lag: 1.61 =========