builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1496745806.91 results: success (0) revision: 4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:26.910559) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:26.911000) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:26.911285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:26.974172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:26.974425) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 03:43:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.1M=0.001s 2017-06-06 03:43:28 (22.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.201473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.201043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.201321) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.251149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.251506) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b --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 4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b --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=5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 03:43:28,378 truncating revision to first 12 chars 2017-06-06 03:43:28,378 Setting DEBUG logging. 2017-06-06 03:43:28,378 attempt 1/10 2017-06-06 03:43:28,378 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4dd1d17ba226?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 03:43:28,701 unpacking tar archive at: mozilla-central-4dd1d17ba226/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.899891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.900180) ========= script_repo_revision: 4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.900545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.900814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 03:43:27.908391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-06 03:43:27.908670) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:43:29 INFO - MultiFileLogger online at 20170606 03:43:29 in /builds/slave/test 03:43:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:43:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:29 INFO - {'append_to_log': False, 03:43:29 INFO - 'base_work_dir': '/builds/slave/test', 03:43:29 INFO - 'blob_upload_branch': 'Firefox', 03:43:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:29 INFO - 'branch': 'Firefox', 03:43:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:29 INFO - 'config_files': ('talos/linux_config.py',), 03:43:29 INFO - 'default_actions': ('clobber', 03:43:29 INFO - 'read-buildbot-config', 03:43:29 INFO - 'download-and-extract', 03:43:29 INFO - 'populate-webroot', 03:43:29 INFO - 'create-virtualenv', 03:43:29 INFO - 'install', 03:43:29 INFO - 'setup-mitmproxy', 03:43:29 INFO - 'run-tests'), 03:43:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:29 INFO - 'download_minidump_stackwalk': True, 03:43:29 INFO - 'download_symbols': 'ondemand', 03:43:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:29 INFO - 'gecko_profile': False, 03:43:29 INFO - 'gecko_profile_interval': 0, 03:43:29 INFO - 'installer_path': 'installer.exe', 03:43:29 INFO - 'log_level': 'info', 03:43:29 INFO - 'log_name': 'talos', 03:43:29 INFO - 'log_to_console': True, 03:43:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:43:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:43:29 INFO - 'opt_config_files': (), 03:43:29 INFO - 'pip_index': False, 03:43:29 INFO - 'suite': 'dromaeojs-e10s', 03:43:29 INFO - 'system_bits': '32', 03:43:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:29 INFO - 'title': 'talos-linux64-ix-051', 03:43:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:29 INFO - 'use_talos_json': True, 03:43:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:29 INFO - 'work_dir': 'build'} 03:43:29 INFO - [mozharness: 2017-06-06 10:43:29.130242Z] Running clobber step. 03:43:29 INFO - Running pre-action listener: _resource_record_pre_action 03:43:29 INFO - Running main action method: clobber 03:43:29 INFO - rmtree: /builds/slave/test/build 03:43:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:30 INFO - Running post-action listener: _resource_record_post_action 03:43:30 INFO - [mozharness: 2017-06-06 10:43:30.176484Z] Finished clobber step (success) 03:43:30 INFO - [mozharness: 2017-06-06 10:43:30.176585Z] Running read-buildbot-config step. 03:43:30 INFO - Running pre-action listener: _resource_record_pre_action 03:43:30 INFO - Running main action method: read_buildbot_config 03:43:30 INFO - Using buildbot properties: 03:43:30 INFO - { 03:43:30 INFO - "project": "", 03:43:30 INFO - "product": "firefox", 03:43:30 INFO - "who": "ffxbld@noreply.mozilla.org", 03:43:30 INFO - "installer_path": "public/build/target.tar.bz2", 03:43:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:43:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:43:30 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:43:30 INFO - "stage_platform": "linux64-stylo", 03:43:30 INFO - "basedir": "/builds/slave/test", 03:43:30 INFO - "buildnumber": 139, 03:43:30 INFO - "platform": "ubuntu64_hw_stylo", 03:43:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:43:30 INFO - "slavebuilddir": "test", 03:43:30 INFO - "taskId": "Fg27CzUVTAuqCcK1xgpmkg", 03:43:30 INFO - "branch": "mozilla-central", 03:43:30 INFO - "script_repo_revision": "production", 03:43:30 INFO - "revision": "4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b", 03:43:30 INFO - "slavename": "talos-linux64-ix-051", 03:43:30 INFO - "repo_path": "mozilla-central" 03:43:30 INFO - } 03:43:30 INFO - Finding installer, test and symbols from parent task. 03:43:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg27CzUVTAuqCcK1xgpmkg'}, attempt #1 03:43:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg27CzUVTAuqCcK1xgpmkg'}, attempt #1 03:43:31 INFO - Task dependencies: WM5A4yj8QemamlrfNXrBeA 03:43:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA'}, attempt #1 03:43:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2 03:43:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/test_packages.json 03:43:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.crashreporter-symbols.zip 03:43:31 INFO - Running post-action listener: _resource_record_post_action 03:43:31 INFO - [mozharness: 2017-06-06 10:43:31.635359Z] Finished read-buildbot-config step (success) 03:43:31 INFO - [mozharness: 2017-06-06 10:43:31.635580Z] Running download-and-extract step. 03:43:31 INFO - Running pre-action listener: _resource_record_pre_action 03:43:31 INFO - Running main action method: download_and_extract 03:43:31 INFO - mkdir: /builds/slave/test/build/tests 03:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:31 INFO - trying https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.test_packages.json 03:43:31 INFO - Downloading https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:43:32 INFO - Downloaded 989 bytes. 03:43:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:43:32 INFO - Using the following test package requirements: 03:43:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:43:32 INFO - u'common': [u'target.common.tests.zip'], 03:43:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:43:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:43:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:43:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:43:32 INFO - u'mozbase': [u'target.common.tests.zip'], 03:43:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:43:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:43:32 INFO - u'web-platform': [u'target.common.tests.zip', 03:43:32 INFO - u'target.web-platform.tests.tar.gz'], 03:43:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:43:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:43:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.common.tests.zip 03:43:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:43:32 INFO - Fetch https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.common.tests.zip into memory 03:43:34 INFO - Content-Length response header: 65103832 03:43:34 INFO - Bytes received: 65103832 03:43:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:43:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.common.tests.zip 03:43:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:43:45 INFO - Fetch https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.common.tests.zip into memory 03:43:47 INFO - Content-Length response header: 65103832 03:43:47 INFO - Bytes received: 65103832 03:43:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.talos.tests.zip 03:43:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:43:59 INFO - Fetch https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.talos.tests.zip into memory 03:44:00 INFO - Content-Length response header: 14447479 03:44:00 INFO - Bytes received: 14447479 03:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:00 INFO - trying https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2 03:44:00 INFO - Downloading https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:44:02 INFO - Downloaded 60569642 bytes. 03:44:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2 03:44:02 INFO - mkdir: /builds/slave/test/properties 03:44:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:02 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:02 INFO - Contents: 03:44:02 INFO - build_url:https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2 03:44:02 INFO - Running post-action listener: _resource_record_post_action 03:44:02 INFO - Running post-action listener: set_extra_try_arguments 03:44:02 INFO - [mozharness: 2017-06-06 10:44:02.794719Z] Finished download-and-extract step (success) 03:44:02 INFO - [mozharness: 2017-06-06 10:44:02.794945Z] Running populate-webroot step. 03:44:02 INFO - Running pre-action listener: _resource_record_pre_action 03:44:02 INFO - Running main action method: populate_webroot 03:44:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:02 INFO - '--tppagecycles', 03:44:02 INFO - '7'], 03:44:02 INFO - 'tests': ['tsvgm']}}, 03:44:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['damp', 'tps']}, 03:44:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'tests': ['damp', 'tps']}, 03:44:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['dromaeo_dom']}, 03:44:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:44:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:44:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:44:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['a11yr', 03:44:02 INFO - 'ts_paint', 03:44:02 INFO - 'tpaint', 03:44:02 INFO - 'sessionrestore', 03:44:02 INFO - 'sessionrestore_no_auto_restore', 03:44:02 INFO - 'tabpaint']}, 03:44:02 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:02 INFO - 'ts_paint', 03:44:02 INFO - 'tpaint', 03:44:02 INFO - 'sessionrestore', 03:44:02 INFO - 'sessionrestore_no_auto_restore', 03:44:02 INFO - 'tabpaint']}, 03:44:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:02 INFO - 'ts_paint', 03:44:02 INFO - 'tpaint', 03:44:02 INFO - 'sessionrestore', 03:44:02 INFO - 'sessionrestore_no_auto_restore', 03:44:02 INFO - 'tabpaint']}, 03:44:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:02 INFO - 'ts_paint', 03:44:02 INFO - 'tpaint', 03:44:02 INFO - 'sessionrestore', 03:44:02 INFO - 'sessionrestore_no_auto_restore', 03:44:02 INFO - 'tabpaint']}, 03:44:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['a11yr', 03:44:02 INFO - 'ts_paint', 03:44:02 INFO - 'tpaint', 03:44:02 INFO - 'sessionrestore', 03:44:02 INFO - 'sessionrestore_no_auto_restore', 03:44:02 INFO - 'tabpaint']}, 03:44:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['a11yr', 03:44:02 INFO - 'ts_paint', 03:44:02 INFO - 'tpaint', 03:44:02 INFO - 'sessionrestore', 03:44:02 INFO - 'sessionrestore_no_auto_restore', 03:44:02 INFO - 'tabpaint']}, 03:44:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:44:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:44:02 INFO - 'bloom_basic_ref']}, 03:44:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:44:02 INFO - 'talos_options': ['--mitmproxy', 03:44:02 INFO - 'mitmproxy-recording-1.mp', 03:44:02 INFO - '--firstNonBlankPaint'], 03:44:02 INFO - 'tests': ['Quantum_1']}, 03:44:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['tsvgx', 03:44:02 INFO - 'tsvgr_opacity', 03:44:02 INFO - 'tart', 03:44:02 INFO - 'tscrollx', 03:44:02 INFO - 'cart', 03:44:02 INFO - 'tsvg_static']}, 03:44:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:02 INFO - 'tsvgr_opacity', 03:44:02 INFO - 'tart', 03:44:02 INFO - 'tscrollx', 03:44:02 INFO - 'cart', 03:44:02 INFO - 'tsvg_static']}, 03:44:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'talos_options': ['--disable-e10s'], 03:44:02 INFO - 'tests': ['tp5o']}, 03:44:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:44:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'talos_options': ['--disable-e10s', 03:44:02 INFO - '--xperf_path', 03:44:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:02 INFO - 'tests': ['tp5n']}, 03:44:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:44:02 INFO - 'talos_options': ['--xperf_path', 03:44:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:02 INFO - 'tests': ['tp5n']}}, 03:44:02 INFO - 'talos.zip': {'path': '', 03:44:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:02 INFO - Running post-action listener: _resource_record_post_action 03:44:02 INFO - [mozharness: 2017-06-06 10:44:02.818344Z] Finished populate-webroot step (success) 03:44:02 INFO - [mozharness: 2017-06-06 10:44:02.818439Z] Running create-virtualenv step. 03:44:02 INFO - Running pre-action listener: _resource_record_pre_action 03:44:02 INFO - Running main action method: create_virtualenv 03:44:02 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:02 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 03:44:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:44:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:02 INFO - Using real prefix '/usr' 03:44:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:05 INFO - Installing pip.................done. 03:44:05 INFO - Return code: 0 03:44:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:44:05 INFO - Reading from file tmpfile_stdout 03:44:05 INFO - Output received: 03:44:05 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) 03:44:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:05 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')]} 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:05 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')]} 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:05 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:05 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 03:44:05 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 03:44:05 INFO - Using env: {'DISPLAY': ':0', 03:44:05 INFO - 'HOME': '/home/cltbld', 03:44:05 INFO - 'LANG': 'en_US.UTF-8', 03:44:05 INFO - 'LANGUAGE': 'en_US:en', 03:44:05 INFO - 'LOGNAME': 'cltbld', 03:44:05 INFO - 'MAIL': '/var/mail/cltbld', 03:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:05 INFO - 'MOZ_NO_REMOTE': '1', 03:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:05 INFO - 'NO_EM_RESTART': '1', 03:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:05 INFO - 'PWD': '/builds/slave/test', 03:44:05 INFO - 'SHELL': '/bin/bash', 03:44:05 INFO - 'SHLVL': '1', 03:44:05 INFO - 'TERM': 'linux', 03:44:05 INFO - 'TMOUT': '86400', 03:44:05 INFO - 'USER': 'cltbld', 03:44:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:05 INFO - '_': '/tools/buildbot/bin/python'} 03:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:05 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 03:44:05 INFO - Cleaning up... 03:44:05 INFO - Return code: 0 03:44:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:44:05 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')]} 03:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:05 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')]} 03:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:05 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:05 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 03:44:05 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 03:44:05 INFO - Using env: {'DISPLAY': ':0', 03:44:05 INFO - 'HOME': '/home/cltbld', 03:44:05 INFO - 'LANG': 'en_US.UTF-8', 03:44:05 INFO - 'LANGUAGE': 'en_US:en', 03:44:05 INFO - 'LOGNAME': 'cltbld', 03:44:05 INFO - 'MAIL': '/var/mail/cltbld', 03:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:05 INFO - 'MOZ_NO_REMOTE': '1', 03:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:05 INFO - 'NO_EM_RESTART': '1', 03:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:05 INFO - 'PWD': '/builds/slave/test', 03:44:05 INFO - 'SHELL': '/bin/bash', 03:44:05 INFO - 'SHLVL': '1', 03:44:05 INFO - 'TERM': 'linux', 03:44:05 INFO - 'TMOUT': '86400', 03:44:05 INFO - 'USER': 'cltbld', 03:44:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:05 INFO - '_': '/tools/buildbot/bin/python'} 03:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:06 INFO - Downloading/unpacking psutil>=3.1.1 03:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:07 INFO - Installing collected packages: psutil 03:44:07 INFO - Running setup.py install for psutil 03:44:07 INFO - building 'psutil._psutil_linux' extension 03:44:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:44:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:44:07 INFO - building 'psutil._psutil_posix' extension 03:44:07 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 03:44:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:44:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:07 INFO - Successfully installed psutil 03:44:07 INFO - Cleaning up... 03:44:07 INFO - Return code: 0 03:44:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:44:07 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')]} 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:07 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')]} 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:07 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:07 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 03:44:07 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 03:44:07 INFO - Using env: {'DISPLAY': ':0', 03:44:07 INFO - 'HOME': '/home/cltbld', 03:44:07 INFO - 'LANG': 'en_US.UTF-8', 03:44:07 INFO - 'LANGUAGE': 'en_US:en', 03:44:07 INFO - 'LOGNAME': 'cltbld', 03:44:07 INFO - 'MAIL': '/var/mail/cltbld', 03:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:07 INFO - 'MOZ_NO_REMOTE': '1', 03:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:07 INFO - 'NO_EM_RESTART': '1', 03:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:07 INFO - 'PWD': '/builds/slave/test', 03:44:07 INFO - 'SHELL': '/bin/bash', 03:44:07 INFO - 'SHLVL': '1', 03:44:07 INFO - 'TERM': 'linux', 03:44:07 INFO - 'TMOUT': '86400', 03:44:07 INFO - 'USER': 'cltbld', 03:44:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:07 INFO - '_': '/tools/buildbot/bin/python'} 03:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:44:09 INFO - Installing collected packages: mozsystemmonitor 03:44:09 INFO - Running setup.py install for mozsystemmonitor 03:44:09 INFO - Successfully installed mozsystemmonitor 03:44:09 INFO - Cleaning up... 03:44:09 INFO - Return code: 0 03:44:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:44:09 INFO - Using env: {'DISPLAY': ':0', 03:44:09 INFO - 'HOME': '/home/cltbld', 03:44:09 INFO - 'LANG': 'en_US.UTF-8', 03:44:09 INFO - 'LANGUAGE': 'en_US:en', 03:44:09 INFO - 'LOGNAME': 'cltbld', 03:44:09 INFO - 'MAIL': '/var/mail/cltbld', 03:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:09 INFO - 'MOZ_NO_REMOTE': '1', 03:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:09 INFO - 'NO_EM_RESTART': '1', 03:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:09 INFO - 'PWD': '/builds/slave/test', 03:44:09 INFO - 'SHELL': '/bin/bash', 03:44:09 INFO - 'SHLVL': '1', 03:44:09 INFO - 'TERM': 'linux', 03:44:09 INFO - 'TMOUT': '86400', 03:44:09 INFO - 'USER': 'cltbld', 03:44:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:09 INFO - '_': '/tools/buildbot/bin/python'} 03:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:10 INFO - warning: no files found matching '*.txt' 03:44:10 INFO - no previously-included directories found matching 'build' 03:44:10 INFO - no previously-included directories found matching 'dist' 03:44:10 INFO - no previously-included directories found matching '.git*' 03:44:10 INFO - Installing collected packages: jsonschema, functools32 03:44:10 INFO - Running setup.py install for functools32 03:44:10 INFO - warning: no files found matching '*.txt' 03:44:10 INFO - no previously-included directories found matching 'build' 03:44:10 INFO - no previously-included directories found matching 'dist' 03:44:10 INFO - no previously-included directories found matching '.git*' 03:44:10 INFO - Successfully installed jsonschema functools32 03:44:10 INFO - Cleaning up... 03:44:10 INFO - Return code: 0 03:44:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:44:10 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')]} 03:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:10 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')]} 03:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:10 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:10 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 03:44:10 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 03:44:10 INFO - Using env: {'DISPLAY': ':0', 03:44:10 INFO - 'HOME': '/home/cltbld', 03:44:10 INFO - 'LANG': 'en_US.UTF-8', 03:44:10 INFO - 'LANGUAGE': 'en_US:en', 03:44:10 INFO - 'LOGNAME': 'cltbld', 03:44:10 INFO - 'MAIL': '/var/mail/cltbld', 03:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:10 INFO - 'MOZ_NO_REMOTE': '1', 03:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:10 INFO - 'NO_EM_RESTART': '1', 03:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:10 INFO - 'PWD': '/builds/slave/test', 03:44:10 INFO - 'SHELL': '/bin/bash', 03:44:10 INFO - 'SHLVL': '1', 03:44:10 INFO - 'TERM': 'linux', 03:44:10 INFO - 'TMOUT': '86400', 03:44:10 INFO - 'USER': 'cltbld', 03:44:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:10 INFO - '_': '/tools/buildbot/bin/python'} 03:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:44:11 INFO - Cleaning up... 03:44:11 INFO - Return code: 0 03:44:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:44:11 INFO - Using env: {'DISPLAY': ':0', 03:44:11 INFO - 'HOME': '/home/cltbld', 03:44:11 INFO - 'LANG': 'en_US.UTF-8', 03:44:11 INFO - 'LANGUAGE': 'en_US:en', 03:44:11 INFO - 'LOGNAME': 'cltbld', 03:44:11 INFO - 'MAIL': '/var/mail/cltbld', 03:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:11 INFO - 'MOZ_NO_REMOTE': '1', 03:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:11 INFO - 'NO_EM_RESTART': '1', 03:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:11 INFO - 'PWD': '/builds/slave/test', 03:44:11 INFO - 'SHELL': '/bin/bash', 03:44:11 INFO - 'SHLVL': '1', 03:44:11 INFO - 'TERM': 'linux', 03:44:11 INFO - 'TMOUT': '86400', 03:44:11 INFO - 'USER': 'cltbld', 03:44:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:11 INFO - '_': '/tools/buildbot/bin/python'} 03:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:11 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:12 INFO - Downloading docopt-0.6.1.tar.gz 03:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:13 INFO - Running setup.py install for blobuploader 03:44:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:13 INFO - Running setup.py install for requests 03:44:13 INFO - Running setup.py install for docopt 03:44:13 INFO - Successfully installed blobuploader requests docopt 03:44:13 INFO - Cleaning up... 03:44:13 INFO - Return code: 0 03:44:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:13 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:13 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 03:44:13 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 03:44:13 INFO - Using env: {'DISPLAY': ':0', 03:44:13 INFO - 'HOME': '/home/cltbld', 03:44:13 INFO - 'LANG': 'en_US.UTF-8', 03:44:13 INFO - 'LANGUAGE': 'en_US:en', 03:44:13 INFO - 'LOGNAME': 'cltbld', 03:44:13 INFO - 'MAIL': '/var/mail/cltbld', 03:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:13 INFO - 'MOZ_NO_REMOTE': '1', 03:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:13 INFO - 'NO_EM_RESTART': '1', 03:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:13 INFO - 'PWD': '/builds/slave/test', 03:44:13 INFO - 'SHELL': '/bin/bash', 03:44:13 INFO - 'SHLVL': '1', 03:44:13 INFO - 'TERM': 'linux', 03:44:13 INFO - 'TMOUT': '86400', 03:44:13 INFO - 'USER': 'cltbld', 03:44:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:13 INFO - '_': '/tools/buildbot/bin/python'} 03:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:13 INFO - Running setup.py (path:/tmp/pip-wITsJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:13 INFO - Running setup.py (path:/tmp/pip-qyOeq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:14 INFO - Running setup.py (path:/tmp/pip-yXChoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:14 INFO - Running setup.py (path:/tmp/pip-QC4ffk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:14 INFO - Running setup.py (path:/tmp/pip-jaBA8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:14 INFO - Running setup.py (path:/tmp/pip-6CuTjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:14 INFO - Running setup.py (path:/tmp/pip-_qYy_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:14 INFO - Running setup.py (path:/tmp/pip-zupJJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:14 INFO - Running setup.py (path:/tmp/pip-Fphdli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:14 INFO - Running setup.py (path:/tmp/pip-hFdZn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:14 INFO - Running setup.py (path:/tmp/pip-FNGE2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:14 INFO - Running setup.py (path:/tmp/pip-fZ51gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:14 INFO - Running setup.py (path:/tmp/pip-mhkzjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:14 INFO - Running setup.py (path:/tmp/pip-6Cpawe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:14 INFO - Running setup.py (path:/tmp/pip-qPbTfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:14 INFO - Running setup.py (path:/tmp/pip-iW_qH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:14 INFO - Running setup.py (path:/tmp/pip-xQzhuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:15 INFO - Running setup.py install for manifestparser 03:44:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Running setup.py install for mozcrash 03:44:15 INFO - Running setup.py install for mozdebug 03:44:15 INFO - Running setup.py install for mozdevice 03:44:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Running setup.py install for mozfile 03:44:15 INFO - Running setup.py install for mozhttpd 03:44:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Running setup.py install for mozinfo 03:44:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Running setup.py install for mozInstall 03:44:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:15 INFO - Running setup.py install for mozleak 03:44:15 INFO - Running setup.py install for mozlog 03:44:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Running setup.py install for moznetwork 03:44:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Running setup.py install for mozprocess 03:44:16 INFO - Running setup.py install for mozprofile 03:44:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Running setup.py install for mozrunner 03:44:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Running setup.py install for mozscreenshot 03:44:16 INFO - Running setup.py install for moztest 03:44:16 INFO - Running setup.py install for mozversion 03:44:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:16 INFO - Cleaning up... 03:44:16 INFO - Return code: 0 03:44:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:16 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')]} 03:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:16 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')]} 03:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:16 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:16 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 03:44:16 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 03:44:16 INFO - Using env: {'DISPLAY': ':0', 03:44:16 INFO - 'HOME': '/home/cltbld', 03:44:16 INFO - 'LANG': 'en_US.UTF-8', 03:44:16 INFO - 'LANGUAGE': 'en_US:en', 03:44:16 INFO - 'LOGNAME': 'cltbld', 03:44:16 INFO - 'MAIL': '/var/mail/cltbld', 03:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:16 INFO - 'MOZ_NO_REMOTE': '1', 03:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:16 INFO - 'NO_EM_RESTART': '1', 03:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:16 INFO - 'PWD': '/builds/slave/test', 03:44:16 INFO - 'SHELL': '/bin/bash', 03:44:16 INFO - 'SHLVL': '1', 03:44:16 INFO - 'TERM': 'linux', 03:44:16 INFO - 'TMOUT': '86400', 03:44:16 INFO - 'USER': 'cltbld', 03:44:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:16 INFO - '_': '/tools/buildbot/bin/python'} 03:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:17 INFO - Running setup.py (path:/tmp/pip-PAgxf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:17 INFO - Running setup.py (path:/tmp/pip-nKa51n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:17 INFO - Running setup.py (path:/tmp/pip-oWwklm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:17 INFO - Running setup.py (path:/tmp/pip-9r08r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:17 INFO - Running setup.py (path:/tmp/pip-3aTFi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:17 INFO - Running setup.py (path:/tmp/pip-U6Kxyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:17 INFO - Running setup.py (path:/tmp/pip-0fPgxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:17 INFO - Running setup.py (path:/tmp/pip-O_CK_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:17 INFO - Running setup.py (path:/tmp/pip-TYwPYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:17 INFO - Running setup.py (path:/tmp/pip-WxmWJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:17 INFO - Running setup.py (path:/tmp/pip-H8G3jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:17 INFO - Running setup.py (path:/tmp/pip-SVUZTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:17 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)) 03:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:17 INFO - Running setup.py (path:/tmp/pip-UVH90i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:18 INFO - Running setup.py (path:/tmp/pip-SvVear-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:18 INFO - Running setup.py (path:/tmp/pip-zRro8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:18 INFO - Running setup.py (path:/tmp/pip-cPhT1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:18 INFO - Running setup.py (path:/tmp/pip-q7acED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:44:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:19 INFO - Downloading blessings-1.6.tar.gz 03:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:19 INFO - Installing collected packages: blessings 03:44:19 INFO - Running setup.py install for blessings 03:44:19 INFO - Successfully installed blessings 03:44:19 INFO - Cleaning up... 03:44:19 INFO - Return code: 0 03:44:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:19 INFO - Reading from file tmpfile_stdout 03:44:19 INFO - Current package versions: 03:44:19 INFO - argparse == 1.2.1 03:44:19 INFO - blessings == 1.6 03:44:19 INFO - blobuploader == 1.2.4 03:44:19 INFO - docopt == 0.6.1 03:44:19 INFO - functools32 == 3.2.3-2 03:44:19 INFO - jsonschema == 2.5.1 03:44:19 INFO - manifestparser == 1.1 03:44:19 INFO - mozInstall == 1.12 03:44:19 INFO - mozcrash == 1.0 03:44:19 INFO - mozdebug == 0.1 03:44:19 INFO - mozdevice == 0.51 03:44:19 INFO - mozfile == 1.2 03:44:19 INFO - mozhttpd == 0.7 03:44:19 INFO - mozinfo == 0.10 03:44:19 INFO - mozleak == 0.1 03:44:19 INFO - mozlog == 3.4 03:44:19 INFO - moznetwork == 0.27 03:44:19 INFO - mozprocess == 0.25 03:44:19 INFO - mozprofile == 0.28 03:44:19 INFO - mozrunner == 6.13 03:44:19 INFO - mozscreenshot == 0.1 03:44:19 INFO - mozsystemmonitor == 0.3 03:44:19 INFO - moztest == 0.8 03:44:19 INFO - mozversion == 1.4 03:44:19 INFO - psutil == 3.1.1 03:44:19 INFO - requests == 1.2.3 03:44:19 INFO - wsgiref == 0.1.2 03:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:19 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')]} 03:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:19 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')]} 03:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:19 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:19 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 03:44:19 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 03:44:19 INFO - Using env: {'DISPLAY': ':0', 03:44:19 INFO - 'HOME': '/home/cltbld', 03:44:19 INFO - 'LANG': 'en_US.UTF-8', 03:44:19 INFO - 'LANGUAGE': 'en_US:en', 03:44:19 INFO - 'LOGNAME': 'cltbld', 03:44:19 INFO - 'MAIL': '/var/mail/cltbld', 03:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:19 INFO - 'MOZ_NO_REMOTE': '1', 03:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:19 INFO - 'NO_EM_RESTART': '1', 03:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:19 INFO - 'PWD': '/builds/slave/test', 03:44:19 INFO - 'SHELL': '/bin/bash', 03:44:19 INFO - 'SHLVL': '1', 03:44:19 INFO - 'TERM': 'linux', 03:44:19 INFO - 'TMOUT': '86400', 03:44:19 INFO - 'USER': 'cltbld', 03:44:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:19 INFO - '_': '/tools/buildbot/bin/python'} 03:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:44:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:21 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:44:21 INFO - Installing collected packages: marionette-driver 03:44:21 INFO - Running setup.py install for marionette-driver 03:44:21 INFO - Successfully installed marionette-driver 03:44:21 INFO - Cleaning up... 03:44:21 INFO - Return code: 0 03:44:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:21 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 0x101a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1398dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', '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 03:44:21 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 03:44:21 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 03:44:21 INFO - Using env: {'DISPLAY': ':0', 03:44:21 INFO - 'HOME': '/home/cltbld', 03:44:21 INFO - 'LANG': 'en_US.UTF-8', 03:44:21 INFO - 'LANGUAGE': 'en_US:en', 03:44:21 INFO - 'LOGNAME': 'cltbld', 03:44:21 INFO - 'MAIL': '/var/mail/cltbld', 03:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:21 INFO - 'MOZ_NO_REMOTE': '1', 03:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:21 INFO - 'NO_EM_RESTART': '1', 03:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:21 INFO - 'PWD': '/builds/slave/test', 03:44:21 INFO - 'SHELL': '/bin/bash', 03:44:21 INFO - 'SHLVL': '1', 03:44:21 INFO - 'TERM': 'linux', 03:44:21 INFO - 'TMOUT': '86400', 03:44:21 INFO - 'USER': 'cltbld', 03:44:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:21 INFO - '_': '/tools/buildbot/bin/python'} 03:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:21 INFO - Cleaning up... 03:44:21 INFO - Return code: 0 03:44:21 INFO - Running post-action listener: _resource_record_post_action 03:44:21 INFO - Running post-action listener: _start_resource_monitoring 03:44:21 INFO - Starting resource monitoring. 03:44:21 INFO - [mozharness: 2017-06-06 10:44:21.630612Z] Finished create-virtualenv step (success) 03:44:21 INFO - [mozharness: 2017-06-06 10:44:21.631088Z] Running install step. 03:44:21 INFO - Running pre-action listener: _resource_record_pre_action 03:44:21 INFO - Running main action method: install 03:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:21 INFO - Reading from file tmpfile_stdout 03:44:21 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:21 INFO - Reading from file tmpfile_stdout 03:44:21 INFO - Output received: 03:44:21 INFO - Usage: mozinstall [options] installer 03:44:21 INFO - Options: 03:44:21 INFO - -h, --help show this help message and exit 03:44:21 INFO - -d DEST, --destination=DEST 03:44:21 INFO - Directory to install application into. [default: 03:44:21 INFO - "/builds/slave/test"] 03:44:21 INFO - --app=APP Application being installed. [default: firefox] 03:44:21 INFO - mkdir: /builds/slave/test/build/application 03:44:21 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'] 03:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:44:39 INFO - Reading from file tmpfile_stdout 03:44:39 INFO - Output received: 03:44:39 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:39 INFO - Running post-action listener: _resource_record_post_action 03:44:39 INFO - [mozharness: 2017-06-06 10:44:39.477842Z] Finished install step (success) 03:44:39 INFO - [mozharness: 2017-06-06 10:44:39.478117Z] Running setup-mitmproxy step. 03:44:39 INFO - Running pre-action listener: _resource_record_pre_action 03:44:39 INFO - Running main action method: setup_mitmproxy 03:44:39 INFO - Skipping: mitmproxy is not required 03:44:39 INFO - Running post-action listener: _resource_record_post_action 03:44:39 INFO - [mozharness: 2017-06-06 10:44:39.479247Z] Finished setup-mitmproxy step (success) 03:44:39 INFO - [mozharness: 2017-06-06 10:44:39.479468Z] Running run-tests step. 03:44:39 INFO - Running pre-action listener: _resource_record_pre_action 03:44:39 INFO - Running main action method: run_tests 03:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:39 INFO - Python 2.7.3 03:44:39 INFO - Return code: 0 03:44:39 INFO - grabbing minidump binary from tooltool 03:44:39 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')]} 03:44:39 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 0x1395840>, '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 0x1396740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:39 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 03:44:39 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 03:44:39 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 03:44:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:39 INFO - Return code: 0 03:44:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:39 INFO - ENV: RUST_BACKTRACE is now 1 03:44:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:39 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/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 03:44:39 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/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 03:44:39 INFO - Using env: {'DISPLAY': ':0', 03:44:39 INFO - 'HOME': '/home/cltbld', 03:44:39 INFO - 'LANG': 'en_US.UTF-8', 03:44:39 INFO - 'LANGUAGE': 'en_US:en', 03:44:39 INFO - 'LOGNAME': 'cltbld', 03:44:39 INFO - 'MAIL': '/var/mail/cltbld', 03:44:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:39 INFO - 'MOZ_NO_REMOTE': '1', 03:44:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:39 INFO - 'NO_EM_RESTART': '1', 03:44:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:39 INFO - 'PWD': '/builds/slave/test', 03:44:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:39 INFO - 'RUST_BACKTRACE': '1', 03:44:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:39 INFO - 'SHELL': '/bin/bash', 03:44:39 INFO - 'SHLVL': '1', 03:44:39 INFO - 'TERM': 'linux', 03:44:39 INFO - 'TMOUT': '86400', 03:44:39 INFO - 'USER': 'cltbld', 03:44:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323', 03:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:39 INFO - '_': '/tools/buildbot/bin/python'} 03:44:39 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/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 03:44:39 INFO - mozversion application_buildid: 20170606100045 03:44:39 INFO - mozversion application_changeset: 4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b 03:44:39 INFO - mozversion application_display_name: Nightly 03:44:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:39 INFO - mozversion application_name: Firefox 03:44:39 INFO - mozversion application_remotingname: firefox 03:44:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:39 INFO - mozversion application_vendor: Mozilla 03:44:39 INFO - mozversion application_version: 55.0a1 03:44:39 INFO - mozversion platform_buildid: 20170606100045 03:44:39 INFO - mozversion platform_changeset: 4dd1d17ba22660b8f5869a707f2e4e9f9dd5be5b 03:44:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:39 INFO - mozversion platform_version: 55.0a1 03:44:39 INFO - using testdate: 1496745879 03:44:39 INFO - actual date: 1496745879 03:44:39 INFO - starting webserver on 'localhost:38365' 03:44:39 INFO - SUITE-START | Running 2 tests 03:44:39 INFO - TEST-START | dromaeo_css 03:44:39 INFO - operating with platform_type : linux_ 03:44:39 INFO - Initialising browser for dromaeo_css test... 03:44:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38365/getInfo.html -profile /tmp/tmpRCamJK/profile 03:44:39 INFO - TEST-INFO | started process 20646 (/builds/slave/test/build/application/firefox/firefox http://localhost:38365/getInfo.html) 03:45:14 INFO - TEST-INFO | 20646: killed by SIGTERM 03:45:14 INFO - Browser initialized. 03:45:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:14 INFO - TEST-INFO | started process 20875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRCamJK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:26 INFO - PID 20875 | RSS: Main: 199880704 03:45:26 INFO - PID 20875 | 03:48:28 INFO - PID 20875 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38365/tests/dromaeo/cssquery-ext.html) 03:48:29 INFO - PID 20875 | RSS: Main: 185995264 03:48:29 INFO - PID 20875 | 03:51:31 INFO - PID 20875 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-ext.html (next: http://localhost:38365/tests/dromaeo/cssquery-jquery.html) 03:51:32 INFO - PID 20875 | RSS: Main: 191803392 03:51:32 INFO - PID 20875 | 03:54:33 INFO - PID 20875 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38365/tests/dromaeo/cssquery-mootools.html) 03:54:34 INFO - PID 20875 | RSS: Main: 190787584 03:54:34 INFO - PID 20875 | 03:57:36 INFO - PID 20875 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38365/tests/dromaeo/cssquery-prototype.html) 03:57:36 INFO - PID 20875 | RSS: Main: 193318912 03:57:36 INFO - PID 20875 | 04:00:39 INFO - PID 20875 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38365/tests/dromaeo/cssquery-yui.html) 04:00:40 INFO - PID 20875 | RSS: Main: 192397312 04:00:40 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | Cycle 1(1): loaded http://localhost:38365/tests/dromaeo/cssquery-yui.html (next: http://localhost:38365/tests/dromaeo/cssquery-dojo.html) 04:03:42 INFO - PID 20875 | RSS: Main: 192598016 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | __start_tp_report 04:03:42 INFO - PID 20875 | _x_x_mozilla_page_load 04:03:42 INFO - PID 20875 | _x_x_mozilla_page_load_details 04:03:42 INFO - PID 20875 | |i|pagename|runs| 04:03:42 INFO - PID 20875 | |0;dojo.html;3065.478868592339;3105.2392163919817;3107.456195165845;3123.5470856725783;3128.1084890806123;5917.674527900964;6044.093385992098;6053.576249662526;6058.757649694013;6064.636121832693;5940.673262970535;5953.583249172549;5981.671008094553;6005.549583781212;6019.428154325343;5448.754806033738;5530.834074977737;5603.215549823028;5606.159076138571;5629.8592535186535;5484.506394424501;5622.634528755638;5666.744996475148;5685.744141513642;5715.714214289269;5590.2732644756325;5676.091825307952;5709.714514274269;5716.256886604736;5756.510696590794;5431.619786614939;5484.643498172606;5506.394296627368;5529.834104976857;5606.859828504279;5552.250446189753;5570;5583.4974852263085;5591.3569939456665;5592.7762889484775;5971.134185543116;5973.283206015262;6010.128531362971;6013.909791353133;6024.638521688713;6267.028610565324;6474.1583594132935;6486.059521369375;6497.772577959749;6515.4787616990525;6398.488120950313;6455.193100862392;6477.481801455872;6487.22153341602;6516.706748196342;6039.63762174271;6067.24159480065;6067.453929146398;6085.9087113692885;6094.623096992176;6271.874562508724;6614.768483103068;6634.170728658918;6645.501587380966;6679.799606011828;6122.581127188521;6283.3088360280335;6343.651099189589;6360.554761166674;6385.042243663488;6288.088227207029;6315.905261421082;6330.177076979963;6467.159269295055;6467.902981455282;6370.840728981812;6375.71309291083;6437.645929473924;6437.742490300336;6445.806625801233;6446.323136070739;6468.450181734605;6468.741250350027;6471.870562588721;6475.287718350977;5129.12804823181;5193.792248310026;5205;5243.659162154448;5278.366596008426;4516.23224051912;4547.113312903952;4558.703684260512;4573.954260457353;4626.653001024936;5661.801836935688;5669.121286200645;5671;5676.77292908279;5680.744366503517;6305.369463053658;6408.1349017881985;6418.711157997901;6556.672166391757;6567.211934567882;5708.229389032427;5718.971405142947;5729.197912292282;5754.021816291241;5770.2498675171955;5763.4812866842185;5808.128780682931;5813.854653633693;5819.79630712923;5822.505087067647;6139.5228034422325;6379.3301703320485;6402.519811014099;6405.967970160119;6413.3266007069515;6428.260750013808;6464;6546.901796473152;6549.181352330958;6552.475801935929;6295.5907865988565;6349.6507692077375;6361.236651601837;6361.840953976188;6373.267074286517;6353.523485738496;6374.553781235269;6391.009393544008;6405.967970160119;6416.679166041586;6324.936750632435;6435.549511534335;6442.098106265033;6567.934320656924;6588.242352129567;6324.146240257506;6338.302786693553;6368.617882927039;6379.457746091634;6394.680265986589;6134.957077261001;6156.230471191101;6242.781502647385;6366.395192456709;6367.522435817425;6284.3087260402235;6289.779857704958;6306.369363063657;6321.589096708699;6336.778212762531;6162.969185154046;6301.527385446018;6328.398802113792;6354.17395738551;6375.6174629522375;6173.290071641819;6182.381761823782;6224.564280500322;6229.408206220583;6250.343713909974 04:03:42 INFO - PID 20875 | |1;ext.html;695.1415002471946;741.4735537768186;761.185531481315;1150.6490520391278;1154.867190273119;36908.446373304425;37757.433638495444;37909;37934.81032594833;37962.62037379626;40017.39973900394;40553;40557.18885622293;40579.594204057954;40658.7967060165;7262.527935684164;7391.186969433372;7420.443466740016;7530.811729706774;7531.548107113564;7354.70581176755;7355.264473552628;7437.619961612286;7438.702451901918;7446.515976461513;7383.704651813921;7459.440541959348;7465.328120469157;7480.8877866832045;7482.8877566836545;7418.146913105008;7438;7454.925450745477;7468.701251949943;7471.7011319547155;7260.7458738944415;7291.9270807292305;7309.671064802096;7326.084239470067;7326.3040011198855;36280.274394511966;36311.4553281701;36457.270854583025;36635.81682091572;36759.81620091909;3409.7954122752467;3414.334204830059;3426.9657303427143;3434.845431955543;3448.9655103449145;27662.723372766417;27830.721692783016;27911.860440697666;27927.860360698065;27983.440331193466;3565.4295312750096;3577.83899724513;3589.4436362363613;3598.1004748812798;3607.4769158472136;134432;135176.32411837878;152087.23956380258;165717;165884;42847.35728964068;42999.78500107479;43164;43465;43494;44502.55497445049;44512.55487445084;44568;44589.55410445919;44611;14543;14587.708245835023;14649.853501465062;14669.853301467063;14735.410583576751;12084.214526055779;12108.152429330039;12115.878841211652;12116.81824772629;12147;13548.322583870964;13570.457181712818;13650.385732641857;13684.384202710902;13935;5530.364008139035;5615.691136987505;5631.493165615114;5742.971285143548;5789.334226563915;977.1840513171582;986.4180133721139;1004.1113614451264;1006.713086770267;1009.2884516415909;21695.891520542296;22256.55486890253;22318.335675686594;22869.88565057164;23019.42451438694;1068.70610582089;1079.5357996061769;1082.6427278997912;1083.3175099687146;1099.4173088263233;11621.709457263467;11877.524899004116;12294.20087694297;12831.294278814756;12931.224126552437;177735;180203;180271;181113;197036;53133;53290.20064699033;53474.46525534773;53705;53958.730206348715;1425.3728359521776;1446.2500374546917;1456;1462.4954390735393;1465.8094447721728;25510.362240944123;27602.585961210196;28301;28772.136835894955;29169.854150729112;35680.28639427145;35731;35829.64170358367;35841.64158358383;35958.460623091196;181906;182250;182329;182458;182761;32513.67486325201;32705.18237044093;34381.484277735355;34460.48309275413;34583;41438.37842432426;41496.58503414927;41967.16065678608;42215;42404;29555.04449555027;31112.84443577858;31151.688483115784;32013.35973280568;32727.509087364186;30148.397032059675;30290;30451.695483045773;31019.379612408076;31965.520517191795;34326.48510272398;34596.481052783725;35072.29855402929;35074.82462587671;35205;28838.279043024093;29412.11763647094;29655.258618533848;30163.849180754834;31219.37561248808;21830.78169218351;24530.754692452847;24575.50848983046;25225;25228.62157067609 04:03:42 INFO - PID 20875 | |2;jquery.html;409.98770036898884;416.8811888611746;421.91561687662465;422.8541153302111;442.8007396671497;20211.39365819026;21016.474588135305;21042.473938151536;22092.447688807788;22734;24463;25092.623610645856;25125.497490050187;25139.120130795425;25151.62272565913;6824.965875170629;7012.964935175317;7018.122734658168;7029.89455158173;7059.682314295844;6211.534134939875;6540.803775886708;6813.2164801047775;6900.275471075515;6915.585064896122;6562.475001999828;6572.277049524549;6586.604803711769;6590.011498275273;6590.275069742324;6576.835579110537;6583.07836902834;6596.637184954826;6599.307072757388;6600.603963762165;6359.618422894595;6412.294647588761;6441.323661015573;6455.354464553554;6466.838329041764;27470;27599.034033808923;27731.168064958085;27876.16371508858;28202.43595128086;1933.690609502487;1958.4614231086423;1970.5861769028522;1976.0613708488354;1980.6830907054946;18306.26774929001;18751.62496750071;18766.715824730618;18869.62260754777;18907.05464726772;2281.8744969026698;2347.3896786835544;2411.46947671512;2413.80689544836;2433.902643894242;114618;115401.4229928845;116630.41684791521;124784;125186.99999999908;19971.60056798856;20226.59546809085;20821.75069495835;20940.696523382416;20961.63749356287;39740.80129599333;39912.401313980314;40057;40176;40182;10384;10453;10537.209709271836;10548.683539493828;10658.893411065945;8401.789955251168;8437.114103019094;8507.744767656981;8578.142185781497;8582.914170858336;10547.472626368652;10750.73123171927;10796.249650153906;10864.837027444595;10998.835017474745;4013.337799263089;4114.835406583763;4130.359794231899;4263.914721705611;4308.353746937984;916.1754421021134;920.5305294299956;927.5130556457779;959.9904000960041;985.2462865907443;18415.447536573924;18611.441656750318;18984.240630374905;19176.137073831433;19270.32553860608;957.8898426680881;976.8485884687884;978.1929907826072;984.7488890332919;999.6501224571488;9887.555060022316;10306.742331441625;10443.216758743125;10937.617183398543;10950.671479855617;390907;405115;406431;414108;416784;96538;100174.49912750535;100881;101120.49439752901;102464;1139.581256231306;1152.5389844062443;1174.2836869509592;1184.7748927703708;1191.952321907114;17898.821011790238;18586.44240672782;19239.326623568108;19466;19899.104540295433;45304.77347613241;45602.315965259884;45996.31005534853;46484.53515464802;47817;58798.70600646969;59464;59640.70179649074;59879.70060149671;59974;9641.084097010773;10155.543000564845;10309.587616495257;10314;10321.74195645085;15546.766798497805;15615.141167235912;15884.60288492797;16898.66202675964;17085.57286067858;12816.295103769382;12817.551385701829;12901.935490322488;13041.087123901616;13094.607161785161;11487.770244595229;11915.259490317449;12360.690982725144;12440.68898277514;12451.128421010442;13039.739205216032;13262.336883155996;13267.402966866708;13308.800367994294;13311.80032299497;9555.331126821056;10081.949590252001;10082.243831712798;10130.746731331776;10159.7460063499;13325;13380.330983450984;13403.128796628189;13484;13534.187948723109 04:03:42 INFO - PID 20875 | |3;mootools.html;1300.1938797945274;1350.5273154395968;1354.5259159294249;1364.4678575355613;1365.3309878159703;10714.303570267937;11148.888511114887;11186.608468703607;11214;11436.942815285913;11151.553937842476;11343.943280283587;11370.204085714004;11377.715557111076;11396.658100257006;2264.6942662740485;2307.3308740465327;2309.607366747657;2309.930702078932;2313.201945328859;2279.0855681227767;2338.9649155262687;2339.836211465198;2342.273895092527;2343.414146463384;2231.1856172497082;2239.0595949701083;2255.23322070496;2259.514204446052;2272.306946381353;2182.530755887476;2183.858049226795;2197.604431202391;2214.4906671465574;2222.8777417242045;1768.9386368179119;1853.7404763333145;2165.8375621828427;2172.2722887832597;2217.057750456066;10196;10208.74478138045;10218.335808172445;10242.590296388136;10245.590176392936;6163.84590385244;6426.775062872824;6427.100205971168;6444.581102228387;6451.29035806061;3436.1924947637285;3629.0927268182954;3676.3015027144756;3693.7045036397026;3697.7226707997006;1117.1788735279563;1142.0863309352485;1157.3981529604644;1206.9180663355642;1216.7201543644924;15817.130057846814;15866.52400427989;16003.039817610981;16019.11894845783;16084.517464475968;5100.642954993189;5125.1287281162295;5269.394019687708;5282.366116066097;5293.200311893975;12098.213616114925;12099.33453660057;12111.152219344562;12113.454894529767;12115.454804533818;6086.513078953673;6188.690565471708;6203.8138855834395;6212.912740270525;6214.782482613087;5620.241267428926;5785.82642520725;5803.390643982406;5812.709364531756;5846;3934.488516492838;3992.680585553149;4080.367543030835;4102.774347410861;4155.501339839178;1153.0487347937985;1162.5175552145765;1173.6244401791516;1178.157617303632;1204.2172587817813;819.4059307002494;823.8928939237861;830.7258604660448;833.5373867503594;856.5417501636595;5920.671326454278;5925.318588362307;5983.311919129269;6014.308354539196;6154.692265386802;598.5361344957693;613.7913109542777;619.755196697311;633.5976654824128;633.6578247746257;3753.2868754936476;3839.616038396138;4167.374893765898;4268.40242366069;4292.681951746023;12826.551070712667;14073;14130.646733831736;14152.575422737129;14175.362108704927;13487.123336983064;13497.595072147851;13636.045476816726;14045.78931316031;14071.085379450304;8257.752267431986;8290.917090829134;8346.081930987586;8355.874661880076;8440.57797110142;6345.904811427925;6448.677566121769;6454.548181627241;6607.665491304744;6859.382655561023;12280.938595306967;12600;12811.295378754257;12814.807777883152;12885.162464439782;12869.67825804325;12960;12986.805197921849;13026.153300035467;13161.012924030545;8862.689805856764;9030.096990301181;9077.046910074347;9098.545072746203;9129.680461183827;9874.950625246827;10003.29976901639;10003.749906252402;10021.749456263651;10042.849357259502;8255.25702686761;8288.018375652406;8489.53307568065;8654.78363040929;8655.783605409662;7839.294463498312;7894.763157105296;7924.524528528307;8162.18378162179;8194.139615340304;7234.493585449179;7312.341889229995;7328.267173282629;7352.0442342495135;7366;5454.781808727606;5641.887162256814;5869.618474799125;5937.139114828239;6235;5604.131359639263;5721.57088218377;5748.425157484386;5762.884742305214;5942.7920022799 04:03:42 INFO - PID 20875 | |4;prototype.html;393.43934892777787;398.3547946978977;402.5913697596938;403.576522979508;403.98990025249344;6117.632942023471;6166.845828854281;6167.568270221086;6174.9382506174925;6280.3936366408;6029.457348838604;6160.199174107371;6171.7531298748;6172.783952561661;6193.69031548423;4886.877828054309;4985.451600323961;5020.623453241022;5030.320906677588;5066.06277838601;5035.093683137052;5058.645894787366;5075.898482030358;5079.187330027196;5086.643934924557;5013.724245166514;5018.372703412074;5028.120078986181;5048.368953880765;5049.64652474327;5020.573251273628;5032.320636714034;5046.419661738911;5046.763542931987;5051.116054690415;4561.338605902126;4566.840160594396;4580.221362368372;4580.450345958507;4589.429919245234;6057.757689692407;6130.877382452326;6151.446369826737;6154.938450615481;6168.907466388007;5747.856303592402;5753.597248192628;5759.798407055733;5765.53875689948;5768.509676677488;6504.406420427025;6508.934910650928;6553.180852393451;6594.86810263792;6605.834854128685;4921.581665558432;4926.275803468793;4933.407991041062;4934.851954441372;4944.208926571731;6502.934970650327;6830.99999999995;6873.803681288225;6894.310568943116;6954.165500140016;4751.786169622375;4807.399075115611;4810.831620893252;4826.662133650681;4836.274558816206;4841.225403935424;4851.490593487703;4878.780454879539;4879.951200488021;4888.291197776302;5417.6478528895495;5483.917741233885;5515.61390702655;5575.637583557137;5582.944170558324;6529.118568993125;6538.313477084933;6557.770478033246;6559.508036897252;6563.474922006228;1738.9565260868326;1774.7754049705661;1775.334249656379;1777.2002598830577;1792.0681245752137;1160.257435241446;1207.275634619239;1210.3040751567883;1212.2362911365783;1258.9622311330675;5699.430056994351;5730.6819431530985;5738.655680659173;5753.798617048383;5767.163761254595;6663.733450662016;6678.666066696645;6682.164729408824;6693.397594216543;6723.428508576826;5716.57125715573;5717.284814555616;5727.398623144593;5748.885022299531;5761.0124507045;3524.3303772283184;3569.8750543730844;3589.353916295092;3596.478510615946;3622.42041273395;6468.126802881645;6516.185476815398;6522.315156908551;6522.771702990372;6524.151860258136;6820.35206655367;6839.153428574257;6864.279250678706;6872.347127022925;6882.8623427532175;6479.254885688112;6493.740250389931;6531.412172904366;6535.705893234721;6536.411722944958;6672.599644021374;6678.131842860397;6689;6716.328367163244;6719.428848547928;6633.303503132294;6640.103586015826;6647.268800432045;6668.499862510234;6694.464442844658;6102.4507794298725;6456.677166141768;6483.189601299838;6505.51208659343;6523.64119973387;4498.145352383168;4507.143642707875;4513.909721805479;4532.161550113239;4536.455625324982;6440.710168042356;6725;6726.477570910908;6741.764038258638;6743.224529179207;6487.643179625166;6515.609063456208;6521.152250207443;6536.444402225674;6536.542442029203;6498.155239818793;6510.414062734377;6549.770758023446;6551.6069035858;6553.475721942138;6328.145700330397;6397.72045590893;6475.661306924466;6481.708323125376;6493.512986525935;6452.9677351612945;6472.543677672486;6527.51043671717;6535.614500707303;6563.638999854863;6328.145700330397;6354.998175574679;6372.490200783834;6378.6810659467765;6386.872262554816 04:03:42 INFO - PID 20875 | |5;yui.html;819.5533434278318;845.8519759042167;848.626604294111;857.5626430520437;864.5504337744374;16735.916320418397;16852.915735421335;17343.219555120017;18821.529461763428;20245.493862653442;18701.625967480642;18881.90559047203;18950;19087;19157.042147892585;984.3208186351412;1012.8227560176977;1013.6097602423047;1015.9238057145743;1022.913052390544;973.2019743810079;1011.0496133634397;1014.5231741081717;1016.7458135466134;1020.066639025291;1056.4876035122998;1056.8837427882927;1057.7091299892513;1058.9311694739856;1058.957641694335;1047.1308813684623;1053.836655318427;1054.140875186724;1054.3515737821185;1058.841173823925;765.2041876448487;768.8654485465078;769.2230846844672;773.5899973014311;778.6612823421773;17099.487015389557;17318.39385621497;17410.564735881577;17548;17576;18683.34608288717;18769.812301876944;19026.048697565206;19032.71450928237;19143;14402.135871847619;14486.058406203563;14505.782413263809;14595.051321664057;14669.853301467063;3374.8481318340732;3403.710684591813;3429.416999110132;3525.1892064825233;3556.78659280444;84194;84419;84754.72867907048;85026.14973850244;85648.57175714144;14415.135091894519;14807.407703691732;14868.70262594742;14982.850171498145;15007.399704011717;25069.874650626996;25601.8719906403;25743.61384579233;26766.866165669046;26816.865915670685;7926.365890728728;8021.719239826695;8170.3872209584515;8238.670453181925;8242.29940455056;3737.9065523362133;3829.4064420014943;3835.3096442640594;3847.6537111659527;3852.749571277858;4045.4336392905016;4072.450219220427;4119;4128.8348466061625;4208.642265407413;822.6298165825402;838.9496630202208;840.8696652018947;842.5576572299469;844.6452489954233;651.3031056769212;666.0841343153164;676.9187697476236;678.2064983968768;689.2969171445199;9669.468179250069;9993.80012399748;10139.239557033252;10545.261831671864;10885.619003335003;664.3655309179721;667.4193451697055;677.8745932002595;681.9147606549182;689.3520091114436;4742.691725037862;4764.071006153836;4882.438519570295;4897.4857639948;5030.094582975026;93591.19226423219;95077;95850.52074739581;96324.51837740766;96664.51667741757;81479;82163.17836821555;82259.00798432081;82296;82318.4145268377;64157.358426415136;64194.11126499319;64342.678286608265;65022.67488662527;65889;9860.862651560212;10661.680149595524;10798.946005269923;10977.12183025372;11117.27737697047;27827.44345113046;27872.581911270943;28156.296092597848;29042.564361534172;29640.588373475937;35611.64388356187;35862.820685896404;35985.82007089948;36642.45036324404;37215.62784372122;14202.147871127765;14267.286635668383;14305.785413218602;14461.276936152939;14494.63763405881;16802.24389902482;17354.652906942043;17521.21154548074;17965.461036168937;18060.277588896297;14588.12471251686;14653.12081275127;14731.705365892836;14864.554063378117;15011.17438540847;15993.920030400239;16187;16369.590760230612;16558.751618725968;16606.418775342805;14504.129752214902;14556.63608409756;14768.409263629765;15366.462173823862;15571.221438927781;11002;11389.430528473378;11856.525738970344;11869.287842729464;11968.820467693165;11678.357690327113;11683.240589361665;12144.332061736335;12180.634580962585;12208.572699955459 04:03:42 INFO - PID 20875 | __end_tp_report 04:03:42 INFO - PID 20875 | __start_cc_report 04:03:42 INFO - PID 20875 | _x_x_mozilla_cycle_collect,383 04:03:42 INFO - PID 20875 | __end_cc_report 04:03:42 INFO - PID 20875 | __startTimestamp1496747022489__endTimestamp 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | ------- Summary: start ------- 04:03:42 INFO - PID 20875 | Number of tests: 6 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | [#0] dojo.html Cycles:165 Average:5973.99 Median:6224.56 stddev:678.24 (10.9%) stddev-sans-first:640.79 04:03:42 INFO - PID 20875 | Values: 3065.5 3105.2 3107.5 3123.5 3128.1 5917.7 6044.1 6053.6 6058.8 6064.6 5940.7 5953.6 5981.7 6005.5 6019.4 5448.8 5530.8 5603.2 5606.2 5629.9 5484.5 5622.6 5666.7 5685.7 5715.7 5590.3 5676.1 5709.7 5716.3 5756.5 5431.6 5484.6 5506.4 5529.8 5606.9 5552.3 5570.0 5583.5 5591.4 5592.8 5971.1 5973.3 6010.1 6013.9 6024.6 6267.0 6474.2 6486.1 6497.8 6515.5 6398.5 6455.2 6477.5 6487.2 6516.7 6039.6 6067.2 6067.5 6085.9 6094.6 6271.9 6614.8 6634.2 6645.5 6679.8 6122.6 6283.3 6343.7 6360.6 6385.0 6288.1 6315.9 6330.2 6467.2 6467.9 6370.8 6375.7 6437.6 6437.7 6445.8 6446.3 6468.5 6468.7 6471.9 6475.3 5129.1 5193.8 5205.0 5243.7 5278.4 4516.2 4547.1 4558.7 4574.0 4626.7 5661.8 5669.1 5671.0 5676.8 5680.7 6305.4 6408.1 6418.7 6556.7 6567.2 5708.2 5719.0 5729.2 5754.0 5770.2 5763.5 5808.1 5813.9 5819.8 5822.5 6139.5 6379.3 6402.5 6406.0 6413.3 6428.3 6464.0 6546.9 6549.2 6552.5 6295.6 6349.7 6361.2 6361.8 6373.3 6353.5 6374.6 6391.0 6406.0 6416.7 6324.9 6435.5 6442.1 6567.9 6588.2 6324.1 6338.3 6368.6 6379.5 6394.7 6135.0 6156.2 6242.8 6366.4 6367.5 6284.3 6289.8 6306.4 6321.6 6336.8 6163.0 6301.5 6328.4 6354.2 6375.6 6173.3 6182.4 6224.6 6229.4 6250.3 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | [#1] ext.html Cycles:180 Average:33882.42 Median:18880.67 stddev:44674.98 (236.6%) stddev-sans-first:44730.80 04:03:42 INFO - PID 20875 | Values: 695.1 741.5 761.2 1150.6 1154.9 36908.4 37757.4 37909.0 37934.8 37962.6 40017.4 40553.0 40557.2 40579.6 40658.8 7262.5 7391.2 7420.4 7530.8 7531.5 7354.7 7355.3 7437.6 7438.7 7446.5 7383.7 7459.4 7465.3 7480.9 7482.9 7418.1 7438.0 7454.9 7468.7 7471.7 7260.7 7291.9 7309.7 7326.1 7326.3 36280.3 36311.5 36457.3 36635.8 36759.8 3409.8 3414.3 3427.0 3434.8 3449.0 27662.7 27830.7 27911.9 27927.9 27983.4 3565.4 3577.8 3589.4 3598.1 3607.5 134432.0 135176.3 152087.2 165717.0 165884.0 42847.4 42999.8 43164.0 43465.0 43494.0 44502.6 44512.6 44568.0 44589.6 44611.0 14543.0 14587.7 14649.9 14669.9 14735.4 12084.2 12108.2 12115.9 12116.8 12147.0 13548.3 13570.5 13650.4 13684.4 13935.0 5530.4 5615.7 5631.5 5743.0 5789.3 977.2 986.4 1004.1 1006.7 1009.3 21695.9 22256.6 22318.3 22869.9 23019.4 1068.7 1079.5 1082.6 1083.3 1099.4 11621.7 11877.5 12294.2 12831.3 12931.2 177735.0 180203.0 180271.0 181113.0 197036.0 53133.0 53290.2 53474.5 53705.0 53958.7 1425.4 1446.3 1456.0 1462.5 1465.8 25510.4 27602.6 28301.0 28772.1 29169.9 35680.3 35731.0 35829.6 35841.6 35958.5 181906.0 182250.0 182329.0 182458.0 182761.0 32513.7 32705.2 34381.5 34460.5 34583.0 41438.4 41496.6 41967.2 42215.0 42404.0 29555.0 31112.8 31151.7 32013.4 32727.5 30148.4 30290.0 30451.7 31019.4 31965.5 34326.5 34596.5 35072.3 35074.8 35205.0 28838.3 29412.1 29655.3 30163.8 31219.4 21830.8 24530.8 24575.5 25225.0 25228.6 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | [#2] jquery.html Cycles:180 Average:30475.64 Median:12507.94 stddev:68660.62 (548.9%) stddev-sans-first:68816.12 04:03:42 INFO - PID 20875 | Values: 410.0 416.9 421.9 422.9 442.8 20211.4 21016.5 21042.5 22092.4 22734.0 24463.0 25092.6 25125.5 25139.1 25151.6 6825.0 7013.0 7018.1 7029.9 7059.7 6211.5 6540.8 6813.2 6900.3 6915.6 6562.5 6572.3 6586.6 6590.0 6590.3 6576.8 6583.1 6596.6 6599.3 6600.6 6359.6 6412.3 6441.3 6455.4 6466.8 27470.0 27599.0 27731.2 27876.2 28202.4 1933.7 1958.5 1970.6 1976.1 1980.7 18306.3 18751.6 18766.7 18869.6 18907.1 2281.9 2347.4 2411.5 2413.8 2433.9 114618.0 115401.4 116630.4 124784.0 125187.0 19971.6 20226.6 20821.8 20940.7 20961.6 39740.8 39912.4 40057.0 40176.0 40182.0 10384.0 10453.0 10537.2 10548.7 10658.9 8401.8 8437.1 8507.7 8578.1 8582.9 10547.5 10750.7 10796.2 10864.8 10998.8 4013.3 4114.8 4130.4 4263.9 4308.4 916.2 920.5 927.5 960.0 985.2 18415.4 18611.4 18984.2 19176.1 19270.3 957.9 976.8 978.2 984.7 999.7 9887.6 10306.7 10443.2 10937.6 10950.7 390907.0 405115.0 406431.0 414108.0 416784.0 96538.0 100174.5 100881.0 101120.5 102464.0 1139.6 1152.5 1174.3 1184.8 1192.0 17898.8 18586.4 19239.3 19466.0 19899.1 45304.8 45602.3 45996.3 46484.5 47817.0 58798.7 59464.0 59640.7 59879.7 59974.0 9641.1 10155.5 10309.6 10314.0 10321.7 15546.8 15615.1 15884.6 16898.7 17085.6 12816.3 12817.6 12901.9 13041.1 13094.6 11487.8 11915.3 12360.7 12440.7 12451.1 13039.7 13262.3 13267.4 13308.8 13311.8 9555.3 10081.9 10082.2 10130.7 10159.7 13325.0 13380.3 13403.1 13484.0 13534.2 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | [#3] mootools.html Cycles:180 Average:6691.48 Median:3652.70 stddev:4295.15 (117.6%) stddev-sans-first:4288.10 04:03:42 INFO - PID 20875 | Values: 1300.2 1350.5 1354.5 1364.5 1365.3 10714.3 11148.9 11186.6 11214.0 11436.9 11151.6 11343.9 11370.2 11377.7 11396.7 2264.7 2307.3 2309.6 2309.9 2313.2 2279.1 2339.0 2339.8 2342.3 2343.4 2231.2 2239.1 2255.2 2259.5 2272.3 2182.5 2183.9 2197.6 2214.5 2222.9 1768.9 1853.7 2165.8 2172.3 2217.1 10196.0 10208.7 10218.3 10242.6 10245.6 6163.8 6426.8 6427.1 6444.6 6451.3 3436.2 3629.1 3676.3 3693.7 3697.7 1117.2 1142.1 1157.4 1206.9 1216.7 15817.1 15866.5 16003.0 16019.1 16084.5 5100.6 5125.1 5269.4 5282.4 5293.2 12098.2 12099.3 12111.2 12113.5 12115.5 6086.5 6188.7 6203.8 6212.9 6214.8 5620.2 5785.8 5803.4 5812.7 5846.0 3934.5 3992.7 4080.4 4102.8 4155.5 1153.0 1162.5 1173.6 1178.2 1204.2 819.4 823.9 830.7 833.5 856.5 5920.7 5925.3 5983.3 6014.3 6154.7 598.5 613.8 619.8 633.6 633.7 3753.3 3839.6 4167.4 4268.4 4292.7 12826.6 14073.0 14130.6 14152.6 14175.4 13487.1 13497.6 13636.0 14045.8 14071.1 8257.8 8290.9 8346.1 8355.9 8440.6 6345.9 6448.7 6454.5 6607.7 6859.4 12280.9 12600.0 12811.3 12814.8 12885.2 12869.7 12960.0 12986.8 13026.2 13161.0 8862.7 9030.1 9077.0 9098.5 9129.7 9875.0 10003.3 10003.7 10021.7 10042.8 8255.3 8288.0 8489.5 8654.8 8655.8 7839.3 7894.8 7924.5 8162.2 8194.1 7234.5 7312.3 7328.3 7352.0 7366.0 5454.8 5641.9 5869.6 5937.1 6235.0 5604.1 5721.6 5748.4 5762.9 5942.8 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | [#4] prototype.html Cycles:180 Average:5480.35 Median:6153.19 stddev:1553.51 (25.2%) stddev-sans-first:1510.22 04:03:42 INFO - PID 20875 | Values: 393.4 398.4 402.6 403.6 404.0 6117.6 6166.8 6167.6 6174.9 6280.4 6029.5 6160.2 6171.8 6172.8 6193.7 4886.9 4985.5 5020.6 5030.3 5066.1 5035.1 5058.6 5075.9 5079.2 5086.6 5013.7 5018.4 5028.1 5048.4 5049.6 5020.6 5032.3 5046.4 5046.8 5051.1 4561.3 4566.8 4580.2 4580.5 4589.4 6057.8 6130.9 6151.4 6154.9 6168.9 5747.9 5753.6 5759.8 5765.5 5768.5 6504.4 6508.9 6553.2 6594.9 6605.8 4921.6 4926.3 4933.4 4934.9 4944.2 6502.9 6831.0 6873.8 6894.3 6954.2 4751.8 4807.4 4810.8 4826.7 4836.3 4841.2 4851.5 4878.8 4880.0 4888.3 5417.6 5483.9 5515.6 5575.6 5582.9 6529.1 6538.3 6557.8 6559.5 6563.5 1739.0 1774.8 1775.3 1777.2 1792.1 1160.3 1207.3 1210.3 1212.2 1259.0 5699.4 5730.7 5738.7 5753.8 5767.2 6663.7 6678.7 6682.2 6693.4 6723.4 5716.6 5717.3 5727.4 5748.9 5761.0 3524.3 3569.9 3589.4 3596.5 3622.4 6468.1 6516.2 6522.3 6522.8 6524.2 6820.4 6839.2 6864.3 6872.3 6882.9 6479.3 6493.7 6531.4 6535.7 6536.4 6672.6 6678.1 6689.0 6716.3 6719.4 6633.3 6640.1 6647.3 6668.5 6694.5 6102.5 6456.7 6483.2 6505.5 6523.6 4498.1 4507.1 4513.9 4532.2 4536.5 6440.7 6725.0 6726.5 6741.8 6743.2 6487.6 6515.6 6521.2 6536.4 6536.5 6498.2 6510.4 6549.8 6551.6 6553.5 6328.1 6397.7 6475.7 6481.7 6493.5 6453.0 6472.5 6527.5 6535.6 6563.6 6328.1 6355.0 6372.5 6378.7 6386.9 04:03:42 INFO - PID 20875 | 04:03:42 INFO - PID 20875 | [#5] yui.html Cycles:180 Average:18758.89 Median:25335.87 stddev:24230.98 (95.6%) stddev-sans-first:24261.51 04:03:42 INFO - PID 20875 | Values: 819.6 845.9 848.6 857.6 864.6 16735.9 16852.9 17343.2 18821.5 20245.5 18701.6 18881.9 18950.0 19087.0 19157.0 984.3 1012.8 1013.6 1015.9 1022.9 973.2 1011.0 1014.5 1016.7 1020.1 1056.5 1056.9 1057.7 1058.9 1059.0 1047.1 1053.8 1054.1 1054.4 1058.8 765.2 768.9 769.2 773.6 778.7 17099.5 17318.4 17410.6 17548.0 17576.0 18683.3 18769.8 19026.0 19032.7 19143.0 14402.1 14486.1 14505.8 14595.1 14669.9 3374.8 3403.7 3429.4 3525.2 3556.8 84194.0 84419.0 84754.7 85026.1 85648.6 14415.1 14807.4 14868.7 14982.9 15007.4 25069.9 25601.9 25743.6 26766.9 26816.9 7926.4 8021.7 8170.4 8238.7 8242.3 3737.9 3829.4 3835.3 3847.7 3852.7 4045.4 4072.5 4119.0 4128.8 4208.6 822.6 838.9 840.9 842.6 844.6 651.3 666.1 676.9 678.2 689.3 9669.5 9993.8 10139.2 10545.3 10885.6 664.4 667.4 677.9 681.9 689.4 4742.7 4764.1 4882.4 4897.5 5030.1 93591.2 95077.0 95850.5 96324.5 96664.5 81479.0 82163.2 82259.0 82296.0 82318.4 64157.4 64194.1 64342.7 65022.7 65889.0 9860.9 10661.7 10798.9 10977.1 11117.3 27827.4 27872.6 28156.3 29042.6 29640.6 35611.6 35862.8 35985.8 36642.5 37215.6 14202.1 14267.3 14305.8 14461.3 14494.6 16802.2 17354.7 17521.2 17965.5 18060.3 14588.1 14653.1 14731.7 14864.6 15011.2 15993.9 16187.0 16369.6 16558.8 16606.4 14504.1 14556.6 14768.4 15366.5 15571.2 11002.0 11389.4 11856.5 11869.3 11968.8 11678.4 11683.2 12144.3 12180.6 12208.6 04:03:42 INFO - PID 20875 | -------- Summary: end -------- 04:03:42 INFO - PID 20875 | 04:03:43 INFO - TEST-INFO | 20875: exit 0 04:03:43 INFO - TEST-OK | dromaeo_css | took 1143622ms 04:03:43 INFO - TEST-START | kraken 04:03:43 INFO - operating with platform_type : linux_ 04:03:43 INFO - Initialising browser for kraken test... 04:03:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38365/getInfo.html -profile /tmp/tmpeUgX9l/profile 04:03:43 INFO - TEST-INFO | started process 21287 (/builds/slave/test/build/application/firefox/firefox http://localhost:38365/getInfo.html) 04:04:18 INFO - TEST-INFO | 21287: killed by SIGTERM 04:04:18 INFO - Browser initialized. 04:04:18 INFO - Running cycle 1/1 for kraken test... 04:04:18 INFO - TEST-INFO | started process 21518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeUgX9l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:30 INFO - PID 21518 | RSS: Main: 191668224 04:04:30 INFO - PID 21518 | 04:04:32 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:33 INFO - PID 21518 | RSS: Main: 196034560 04:04:33 INFO - PID 21518 | 04:04:36 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-dft) 04:04:36 INFO - PID 21518 | RSS: Main: 194437120 04:04:36 INFO - PID 21518 | 04:04:39 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-fft) 04:04:40 INFO - PID 21518 | RSS: Main: 189534208 04:04:40 INFO - PID 21518 | 04:04:42 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38365/tests/kraken/driver.html?testName=audio-oscillator) 04:04:43 INFO - PID 21518 | RSS: Main: 190337024 04:04:43 INFO - PID 21518 | 04:04:45 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:45 INFO - PID 21518 | RSS: Main: 190713856 04:04:45 INFO - PID 21518 | 04:04:48 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38365/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:49 INFO - PID 21518 | RSS: Main: 191578112 04:04:49 INFO - PID 21518 | 04:04:53 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38365/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:53 INFO - PID 21518 | RSS: Main: 190816256 04:04:53 INFO - PID 21518 | 04:04:56 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38365/tests/kraken/driver.html?testName=json-parse-financial) 04:04:57 INFO - PID 21518 | RSS: Main: 191475712 04:04:57 INFO - PID 21518 | 04:04:58 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:59 INFO - PID 21518 | RSS: Main: 191512576 04:04:59 INFO - PID 21518 | 04:05:01 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:01 INFO - PID 21518 | RSS: Main: 191041536 04:05:01 INFO - PID 21518 | 04:05:04 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:04 INFO - PID 21518 | RSS: Main: 191557632 04:05:04 INFO - PID 21518 | 04:05:07 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:08 INFO - PID 21518 | RSS: Main: 191115264 04:05:08 INFO - PID 21518 | 04:05:11 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:12 INFO - PID 21518 | RSS: Main: 191184896 04:05:12 INFO - PID 21518 | 04:05:13 INFO - PID 21518 | Cycle 1(1): loaded http://localhost:38365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38365/tests/kraken/driver.html?testName=ai-astar) 04:05:14 INFO - PID 21518 | RSS: Main: 192688128 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | __start_tp_report 04:05:14 INFO - PID 21518 | _x_x_mozilla_page_load 04:05:14 INFO - PID 21518 | _x_x_mozilla_page_load_details 04:05:14 INFO - PID 21518 | |i|pagename|runs| 04:05:14 INFO - PID 21518 | |0;ai-astar;102;110;113;112;111;112;112;113;114;113 04:05:14 INFO - PID 21518 | |1;audio-beat-detection;158;124;123;182;126;122;123;130;154;122 04:05:14 INFO - PID 21518 | |2;audio-dft;165;171;169;163;162;167;169;172;165;165 04:05:14 INFO - PID 21518 | |3;audio-fft;74;77;73;116;73;76;77;74;97;75 04:05:14 INFO - PID 21518 | |4;audio-oscillator;82;83;101;83;81;82;99;82;82;105 04:05:14 INFO - PID 21518 | |5;imaging-gaussian-blur;114;114;114;115;114;115;113;114;114;114 04:05:14 INFO - PID 21518 | |6;imaging-darkroom;152;152;151;151;155;149;150;150;151;155 04:05:14 INFO - PID 21518 | |7;imaging-desaturate;95;96;99;94;95;95;95;95;95;95 04:05:14 INFO - PID 21518 | |8;json-parse-financial;55;61;56;56;59;56;57;59;56;55 04:05:14 INFO - PID 21518 | |9;json-stringify-tinderbox;55;54;55;56;55;56;55;55;55;56 04:05:14 INFO - PID 21518 | |10;stanford-crypto-aes;96;88;87;88;87;98;88;87;112;88 04:05:14 INFO - PID 21518 | |11;stanford-crypto-ccm;132;137;135;135;144;129;139;141;130;133 04:05:14 INFO - PID 21518 | |12;stanford-crypto-pbkdf2;187;195;206;199;211;194;186;197;189;201 04:05:14 INFO - PID 21518 | |13;stanford-crypto-sha256-iterative;76;72;74;74;72;71;71;75;71;76 04:05:14 INFO - PID 21518 | __end_tp_report 04:05:14 INFO - PID 21518 | __start_cc_report 04:05:14 INFO - PID 21518 | _x_x_mozilla_cycle_collect,1004 04:05:14 INFO - PID 21518 | __end_cc_report 04:05:14 INFO - PID 21518 | __startTimestamp1496747114086__endTimestamp 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | ------- Summary: start ------- 04:05:14 INFO - PID 21518 | Number of tests: 14 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.50 stddev:3.43 (3.0%) stddev-sans-first:1.20 04:05:14 INFO - PID 21518 | Values: 102.0 110.0 113.0 112.0 111.0 112.0 112.0 113.0 114.0 113.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:128.00 stddev:20.90 (16.3%) stddev-sans-first:20.66 04:05:14 INFO - PID 21518 | Values: 158.0 124.0 123.0 182.0 126.0 122.0 123.0 130.0 154.0 122.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#2] audio-dft Cycles:10 Average:166.80 Median:168.00 stddev:3.36 (2.0%) stddev-sans-first:3.50 04:05:14 INFO - PID 21518 | Values: 165.0 171.0 169.0 163.0 162.0 167.0 169.0 172.0 165.0 165.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:14.14 (18.7%) stddev-sans-first:14.76 04:05:14 INFO - PID 21518 | Values: 74.0 77.0 73.0 116.0 73.0 76.0 77.0 74.0 97.0 75.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.00 stddev:9.56 (11.7%) stddev-sans-first:9.89 04:05:14 INFO - PID 21518 | Values: 82.0 83.0 101.0 83.0 81.0 82.0 99.0 82.0 82.0 105.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:05:14 INFO - PID 21518 | Values: 114.0 114.0 114.0 115.0 114.0 115.0 113.0 114.0 114.0 114.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:2.01 (1.3%) stddev-sans-first:2.13 04:05:14 INFO - PID 21518 | Values: 152.0 152.0 151.0 151.0 155.0 149.0 150.0 150.0 151.0 155.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 04:05:14 INFO - PID 21518 | Values: 95.0 96.0 99.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:2.00 (3.5%) stddev-sans-first:1.99 04:05:14 INFO - PID 21518 | Values: 55.0 61.0 56.0 56.0 59.0 56.0 57.0 59.0 56.0 55.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 04:05:14 INFO - PID 21518 | Values: 55.0 54.0 55.0 56.0 55.0 56.0 55.0 55.0 55.0 56.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:88.00 stddev:8.10 (9.2%) stddev-sans-first:8.46 04:05:14 INFO - PID 21518 | Values: 96.0 88.0 87.0 88.0 87.0 98.0 88.0 87.0 112.0 88.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:136.00 stddev:4.81 (3.5%) stddev-sans-first:4.94 04:05:14 INFO - PID 21518 | Values: 132.0 137.0 135.0 135.0 144.0 129.0 139.0 141.0 130.0 133.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.50 Median:198.00 stddev:8.11 (4.1%) stddev-sans-first:7.84 04:05:14 INFO - PID 21518 | Values: 187.0 195.0 206.0 199.0 211.0 194.0 186.0 197.0 189.0 201.0 04:05:14 INFO - PID 21518 | 04:05:14 INFO - PID 21518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:2.04 (2.8%) stddev-sans-first:1.90 04:05:14 INFO - PID 21518 | Values: 76.0 72.0 74.0 74.0 72.0 71.0 71.0 75.0 71.0 76.0 04:05:14 INFO - PID 21518 | -------- Summary: end -------- 04:05:14 INFO - PID 21518 | 04:05:15 INFO - TEST-INFO | 21518: exit 0 04:05:15 INFO - TEST-OK | kraken | took 91941ms 04:05:15 INFO - SUITE-END | took 1235s 04:05:15 INFO - Completed test suite (00:20:36) 04:05:15 INFO - javascript benchmark 04:05:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7732.462289100885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.478868592339, 3105.2392163919817, 3107.456195165845, 3123.5470856725783, 3128.1084890806123, 5917.674527900964, 6044.093385992098, 6053.576249662526, 6058.757649694013, 6064.636121832693, 5940.673262970535, 5953.583249172549, 5981.671008094553, 6005.549583781212, 6019.428154325343, 5448.754806033738, 5530.834074977737, 5603.215549823028, 5606.159076138571, 5629.8592535186535, 5484.506394424501, 5622.634528755638, 5666.744996475148, 5685.744141513642, 5715.714214289269, 5590.2732644756325, 5676.091825307952, 5709.714514274269, 5716.256886604736, 5756.510696590794, 5431.619786614939, 5484.643498172606, 5506.394296627368, 5529.834104976857, 5606.859828504279, 5552.250446189753, 5570.0, 5583.4974852263085, 5591.3569939456665, 5592.7762889484775, 5971.134185543116, 5973.283206015262, 6010.128531362971, 6013.909791353133, 6024.638521688713, 6267.028610565324, 6474.1583594132935, 6486.059521369375, 6497.772577959749, 6515.4787616990525, 6398.488120950313, 6455.193100862392, 6477.481801455872, 6487.22153341602, 6516.706748196342, 6039.63762174271, 6067.24159480065, 6067.453929146398, 6085.9087113692885, 6094.623096992176, 6271.874562508724, 6614.768483103068, 6634.170728658918, 6645.501587380966, 6679.799606011828, 6122.581127188521, 6283.3088360280335, 6343.651099189589, 6360.554761166674, 6385.042243663488, 6288.088227207029, 6315.905261421082, 6330.177076979963, 6467.159269295055, 6467.902981455282, 6370.840728981812, 6375.71309291083, 6437.645929473924, 6437.742490300336, 6445.806625801233, 6446.323136070739, 6468.450181734605, 6468.741250350027, 6471.870562588721, 6475.287718350977, 5129.12804823181, 5193.792248310026, 5205.0, 5243.659162154448, 5278.366596008426, 4516.23224051912, 4547.113312903952, 4558.703684260512, 4573.954260457353, 4626.653001024936, 5661.801836935688, 5669.121286200645, 5671.0, 5676.77292908279, 5680.744366503517, 6305.369463053658, 6408.1349017881985, 6418.711157997901, 6556.672166391757, 6567.211934567882, 5708.229389032427, 5718.971405142947, 5729.197912292282, 5754.021816291241, 5770.2498675171955, 5763.4812866842185, 5808.128780682931, 5813.854653633693, 5819.79630712923, 5822.505087067647, 6139.5228034422325, 6379.3301703320485, 6402.519811014099, 6405.967970160119, 6413.3266007069515, 6428.260750013808, 6464.0, 6546.901796473152, 6549.181352330958, 6552.475801935929, 6295.5907865988565, 6349.6507692077375, 6361.236651601837, 6361.840953976188, 6373.267074286517, 6353.523485738496, 6374.553781235269, 6391.009393544008, 6405.967970160119, 6416.679166041586, 6324.936750632435, 6435.549511534335, 6442.098106265033, 6567.934320656924, 6588.242352129567, 6324.146240257506, 6338.302786693553, 6368.617882927039, 6379.457746091634, 6394.680265986589, 6134.957077261001, 6156.230471191101, 6242.781502647385, 6366.395192456709, 6367.522435817425, 6284.3087260402235, 6289.779857704958, 6306.369363063657, 6321.589096708699, 6336.778212762531, 6162.969185154046, 6301.527385446018, 6328.398802113792, 6354.17395738551, 6375.6174629522375, 6173.290071641819, 6182.381761823782, 6224.564280500322, 6229.408206220583, 6250.343713909974], "value": 5924.813616330097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.1415002471946, 741.4735537768186, 761.185531481315, 1150.6490520391278, 1154.867190273119, 36908.446373304425, 37757.433638495444, 37909.0, 37934.81032594833, 37962.62037379626, 40017.39973900394, 40553.0, 40557.18885622293, 40579.594204057954, 40658.7967060165, 7262.527935684164, 7391.186969433372, 7420.443466740016, 7530.811729706774, 7531.548107113564, 7354.70581176755, 7355.264473552628, 7437.619961612286, 7438.702451901918, 7446.515976461513, 7383.704651813921, 7459.440541959348, 7465.328120469157, 7480.8877866832045, 7482.8877566836545, 7418.146913105008, 7438.0, 7454.925450745477, 7468.701251949943, 7471.7011319547155, 7260.7458738944415, 7291.9270807292305, 7309.671064802096, 7326.084239470067, 7326.3040011198855, 36280.274394511966, 36311.4553281701, 36457.270854583025, 36635.81682091572, 36759.81620091909, 3409.7954122752467, 3414.334204830059, 3426.9657303427143, 3434.845431955543, 3448.9655103449145, 27662.723372766417, 27830.721692783016, 27911.860440697666, 27927.860360698065, 27983.440331193466, 3565.4295312750096, 3577.83899724513, 3589.4436362363613, 3598.1004748812798, 3607.4769158472136, 134432.0, 135176.32411837878, 152087.23956380258, 165717.0, 165884.0, 42847.35728964068, 42999.78500107479, 43164.0, 43465.0, 43494.0, 44502.55497445049, 44512.55487445084, 44568.0, 44589.55410445919, 44611.0, 14543.0, 14587.708245835023, 14649.853501465062, 14669.853301467063, 14735.410583576751, 12084.214526055779, 12108.152429330039, 12115.878841211652, 12116.81824772629, 12147.0, 13548.322583870964, 13570.457181712818, 13650.385732641857, 13684.384202710902, 13935.0, 5530.364008139035, 5615.691136987505, 5631.493165615114, 5742.971285143548, 5789.334226563915, 977.1840513171582, 986.4180133721139, 1004.1113614451264, 1006.713086770267, 1009.2884516415909, 21695.891520542296, 22256.55486890253, 22318.335675686594, 22869.88565057164, 23019.42451438694, 1068.70610582089, 1079.5357996061769, 1082.6427278997912, 1083.3175099687146, 1099.4173088263233, 11621.709457263467, 11877.524899004116, 12294.20087694297, 12831.294278814756, 12931.224126552437, 177735.0, 180203.0, 180271.0, 181113.0, 197036.0, 53133.0, 53290.20064699033, 53474.46525534773, 53705.0, 53958.730206348715, 1425.3728359521776, 1446.2500374546917, 1456.0, 1462.4954390735393, 1465.8094447721728, 25510.362240944123, 27602.585961210196, 28301.0, 28772.136835894955, 29169.854150729112, 35680.28639427145, 35731.0, 35829.64170358367, 35841.64158358383, 35958.460623091196, 181906.0, 182250.0, 182329.0, 182458.0, 182761.0, 32513.67486325201, 32705.18237044093, 34381.484277735355, 34460.48309275413, 34583.0, 41438.37842432426, 41496.58503414927, 41967.16065678608, 42215.0, 42404.0, 29555.04449555027, 31112.84443577858, 31151.688483115784, 32013.35973280568, 32727.509087364186, 30148.397032059675, 30290.0, 30451.695483045773, 31019.379612408076, 31965.520517191795, 34326.48510272398, 34596.481052783725, 35072.29855402929, 35074.82462587671, 35205.0, 28838.279043024093, 29412.11763647094, 29655.258618533848, 30163.849180754834, 31219.37561248808, 21830.78169218351, 24530.754692452847, 24575.50848983046, 25225.0, 25228.62157067609], "value": 16269.464153152598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.98770036898884, 416.8811888611746, 421.91561687662465, 422.8541153302111, 442.8007396671497, 20211.39365819026, 21016.474588135305, 21042.473938151536, 22092.447688807788, 22734.0, 24463.0, 25092.623610645856, 25125.497490050187, 25139.120130795425, 25151.62272565913, 6824.965875170629, 7012.964935175317, 7018.122734658168, 7029.89455158173, 7059.682314295844, 6211.534134939875, 6540.803775886708, 6813.2164801047775, 6900.275471075515, 6915.585064896122, 6562.475001999828, 6572.277049524549, 6586.604803711769, 6590.011498275273, 6590.275069742324, 6576.835579110537, 6583.07836902834, 6596.637184954826, 6599.307072757388, 6600.603963762165, 6359.618422894595, 6412.294647588761, 6441.323661015573, 6455.354464553554, 6466.838329041764, 27470.0, 27599.034033808923, 27731.168064958085, 27876.16371508858, 28202.43595128086, 1933.690609502487, 1958.4614231086423, 1970.5861769028522, 1976.0613708488354, 1980.6830907054946, 18306.26774929001, 18751.62496750071, 18766.715824730618, 18869.62260754777, 18907.05464726772, 2281.8744969026698, 2347.3896786835544, 2411.46947671512, 2413.80689544836, 2433.902643894242, 114618.0, 115401.4229928845, 116630.41684791521, 124784.0, 125186.99999999908, 19971.60056798856, 20226.59546809085, 20821.75069495835, 20940.696523382416, 20961.63749356287, 39740.80129599333, 39912.401313980314, 40057.0, 40176.0, 40182.0, 10384.0, 10453.0, 10537.209709271836, 10548.683539493828, 10658.893411065945, 8401.789955251168, 8437.114103019094, 8507.744767656981, 8578.142185781497, 8582.914170858336, 10547.472626368652, 10750.73123171927, 10796.249650153906, 10864.837027444595, 10998.835017474745, 4013.337799263089, 4114.835406583763, 4130.359794231899, 4263.914721705611, 4308.353746937984, 916.1754421021134, 920.5305294299956, 927.5130556457779, 959.9904000960041, 985.2462865907443, 18415.447536573924, 18611.441656750318, 18984.240630374905, 19176.137073831433, 19270.32553860608, 957.8898426680881, 976.8485884687884, 978.1929907826072, 984.7488890332919, 999.6501224571488, 9887.555060022316, 10306.742331441625, 10443.216758743125, 10937.617183398543, 10950.671479855617, 390907.0, 405115.0, 406431.0, 414108.0, 416784.0, 96538.0, 100174.49912750535, 100881.0, 101120.49439752901, 102464.0, 1139.581256231306, 1152.5389844062443, 1174.2836869509592, 1184.7748927703708, 1191.952321907114, 17898.821011790238, 18586.44240672782, 19239.326623568108, 19466.0, 19899.104540295433, 45304.77347613241, 45602.315965259884, 45996.31005534853, 46484.53515464802, 47817.0, 58798.70600646969, 59464.0, 59640.70179649074, 59879.70060149671, 59974.0, 9641.084097010773, 10155.543000564845, 10309.587616495257, 10314.0, 10321.74195645085, 15546.766798497805, 15615.141167235912, 15884.60288492797, 16898.66202675964, 17085.57286067858, 12816.295103769382, 12817.551385701829, 12901.935490322488, 13041.087123901616, 13094.607161785161, 11487.770244595229, 11915.259490317449, 12360.690982725144, 12440.68898277514, 12451.128421010442, 13039.739205216032, 13262.336883155996, 13267.402966866708, 13308.800367994294, 13311.80032299497, 9555.331126821056, 10081.949590252001, 10082.243831712798, 10130.746731331776, 10159.7460063499, 13325.0, 13380.330983450984, 13403.128796628189, 13484.0, 13534.187948723109], "value": 11201.938516958839, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.1938797945274, 1350.5273154395968, 1354.5259159294249, 1364.4678575355613, 1365.3309878159703, 10714.303570267937, 11148.888511114887, 11186.608468703607, 11214.0, 11436.942815285913, 11151.553937842476, 11343.943280283587, 11370.204085714004, 11377.715557111076, 11396.658100257006, 2264.6942662740485, 2307.3308740465327, 2309.607366747657, 2309.930702078932, 2313.201945328859, 2279.0855681227767, 2338.9649155262687, 2339.836211465198, 2342.273895092527, 2343.414146463384, 2231.1856172497082, 2239.0595949701083, 2255.23322070496, 2259.514204446052, 2272.306946381353, 2182.530755887476, 2183.858049226795, 2197.604431202391, 2214.4906671465574, 2222.8777417242045, 1768.9386368179119, 1853.7404763333145, 2165.8375621828427, 2172.2722887832597, 2217.057750456066, 10196.0, 10208.74478138045, 10218.335808172445, 10242.590296388136, 10245.590176392936, 6163.84590385244, 6426.775062872824, 6427.100205971168, 6444.581102228387, 6451.29035806061, 3436.1924947637285, 3629.0927268182954, 3676.3015027144756, 3693.7045036397026, 3697.7226707997006, 1117.1788735279563, 1142.0863309352485, 1157.3981529604644, 1206.9180663355642, 1216.7201543644924, 15817.130057846814, 15866.52400427989, 16003.039817610981, 16019.11894845783, 16084.517464475968, 5100.642954993189, 5125.1287281162295, 5269.394019687708, 5282.366116066097, 5293.200311893975, 12098.213616114925, 12099.33453660057, 12111.152219344562, 12113.454894529767, 12115.454804533818, 6086.513078953673, 6188.690565471708, 6203.8138855834395, 6212.912740270525, 6214.782482613087, 5620.241267428926, 5785.82642520725, 5803.390643982406, 5812.709364531756, 5846.0, 3934.488516492838, 3992.680585553149, 4080.367543030835, 4102.774347410861, 4155.501339839178, 1153.0487347937985, 1162.5175552145765, 1173.6244401791516, 1178.157617303632, 1204.2172587817813, 819.4059307002494, 823.8928939237861, 830.7258604660448, 833.5373867503594, 856.5417501636595, 5920.671326454278, 5925.318588362307, 5983.311919129269, 6014.308354539196, 6154.692265386802, 598.5361344957693, 613.7913109542777, 619.755196697311, 633.5976654824128, 633.6578247746257, 3753.2868754936476, 3839.616038396138, 4167.374893765898, 4268.40242366069, 4292.681951746023, 12826.551070712667, 14073.0, 14130.646733831736, 14152.575422737129, 14175.362108704927, 13487.123336983064, 13497.595072147851, 13636.045476816726, 14045.78931316031, 14071.085379450304, 8257.752267431986, 8290.917090829134, 8346.081930987586, 8355.874661880076, 8440.57797110142, 6345.904811427925, 6448.677566121769, 6454.548181627241, 6607.665491304744, 6859.382655561023, 12280.938595306967, 12600.0, 12811.295378754257, 12814.807777883152, 12885.162464439782, 12869.67825804325, 12960.0, 12986.805197921849, 13026.153300035467, 13161.012924030545, 8862.689805856764, 9030.096990301181, 9077.046910074347, 9098.545072746203, 9129.680461183827, 9874.950625246827, 10003.29976901639, 10003.749906252402, 10021.749456263651, 10042.849357259502, 8255.25702686761, 8288.018375652406, 8489.53307568065, 8654.78363040929, 8655.783605409662, 7839.294463498312, 7894.763157105296, 7924.524528528307, 8162.18378162179, 8194.139615340304, 7234.493585449179, 7312.341889229995, 7328.267173282629, 7352.0442342495135, 7366.0, 5454.781808727606, 5641.887162256814, 5869.618474799125, 5937.139114828239, 6235.0, 5604.131359639263, 5721.57088218377, 5748.425157484386, 5762.884742305214, 5942.7920022799], "value": 4996.060568173507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.43934892777787, 398.3547946978977, 402.5913697596938, 403.576522979508, 403.98990025249344, 6117.632942023471, 6166.845828854281, 6167.568270221086, 6174.9382506174925, 6280.3936366408, 6029.457348838604, 6160.199174107371, 6171.7531298748, 6172.783952561661, 6193.69031548423, 4886.877828054309, 4985.451600323961, 5020.623453241022, 5030.320906677588, 5066.06277838601, 5035.093683137052, 5058.645894787366, 5075.898482030358, 5079.187330027196, 5086.643934924557, 5013.724245166514, 5018.372703412074, 5028.120078986181, 5048.368953880765, 5049.64652474327, 5020.573251273628, 5032.320636714034, 5046.419661738911, 5046.763542931987, 5051.116054690415, 4561.338605902126, 4566.840160594396, 4580.221362368372, 4580.450345958507, 4589.429919245234, 6057.757689692407, 6130.877382452326, 6151.446369826737, 6154.938450615481, 6168.907466388007, 5747.856303592402, 5753.597248192628, 5759.798407055733, 5765.53875689948, 5768.509676677488, 6504.406420427025, 6508.934910650928, 6553.180852393451, 6594.86810263792, 6605.834854128685, 4921.581665558432, 4926.275803468793, 4933.407991041062, 4934.851954441372, 4944.208926571731, 6502.934970650327, 6830.99999999995, 6873.803681288225, 6894.310568943116, 6954.165500140016, 4751.786169622375, 4807.399075115611, 4810.831620893252, 4826.662133650681, 4836.274558816206, 4841.225403935424, 4851.490593487703, 4878.780454879539, 4879.951200488021, 4888.291197776302, 5417.6478528895495, 5483.917741233885, 5515.61390702655, 5575.637583557137, 5582.944170558324, 6529.118568993125, 6538.313477084933, 6557.770478033246, 6559.508036897252, 6563.474922006228, 1738.9565260868326, 1774.7754049705661, 1775.334249656379, 1777.2002598830577, 1792.0681245752137, 1160.257435241446, 1207.275634619239, 1210.3040751567883, 1212.2362911365783, 1258.9622311330675, 5699.430056994351, 5730.6819431530985, 5738.655680659173, 5753.798617048383, 5767.163761254595, 6663.733450662016, 6678.666066696645, 6682.164729408824, 6693.397594216543, 6723.428508576826, 5716.57125715573, 5717.284814555616, 5727.398623144593, 5748.885022299531, 5761.0124507045, 3524.3303772283184, 3569.8750543730844, 3589.353916295092, 3596.478510615946, 3622.42041273395, 6468.126802881645, 6516.185476815398, 6522.315156908551, 6522.771702990372, 6524.151860258136, 6820.35206655367, 6839.153428574257, 6864.279250678706, 6872.347127022925, 6882.8623427532175, 6479.254885688112, 6493.740250389931, 6531.412172904366, 6535.705893234721, 6536.411722944958, 6672.599644021374, 6678.131842860397, 6689.0, 6716.328367163244, 6719.428848547928, 6633.303503132294, 6640.103586015826, 6647.268800432045, 6668.499862510234, 6694.464442844658, 6102.4507794298725, 6456.677166141768, 6483.189601299838, 6505.51208659343, 6523.64119973387, 4498.145352383168, 4507.143642707875, 4513.909721805479, 4532.161550113239, 4536.455625324982, 6440.710168042356, 6725.0, 6726.477570910908, 6741.764038258638, 6743.224529179207, 6487.643179625166, 6515.609063456208, 6521.152250207443, 6536.444402225674, 6536.542442029203, 6498.155239818793, 6510.414062734377, 6549.770758023446, 6551.6069035858, 6553.475721942138, 6328.145700330397, 6397.72045590893, 6475.661306924466, 6481.708323125376, 6493.512986525935, 6452.9677351612945, 6472.543677672486, 6527.51043671717, 6535.614500707303, 6563.638999854863, 6328.145700330397, 6354.998175574679, 6372.490200783834, 6378.6810659467765, 6386.872262554816], "value": 4996.179569328498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.5533434278318, 845.8519759042167, 848.626604294111, 857.5626430520437, 864.5504337744374, 16735.916320418397, 16852.915735421335, 17343.219555120017, 18821.529461763428, 20245.493862653442, 18701.625967480642, 18881.90559047203, 18950.0, 19087.0, 19157.042147892585, 984.3208186351412, 1012.8227560176977, 1013.6097602423047, 1015.9238057145743, 1022.913052390544, 973.2019743810079, 1011.0496133634397, 1014.5231741081717, 1016.7458135466134, 1020.066639025291, 1056.4876035122998, 1056.8837427882927, 1057.7091299892513, 1058.9311694739856, 1058.957641694335, 1047.1308813684623, 1053.836655318427, 1054.140875186724, 1054.3515737821185, 1058.841173823925, 765.2041876448487, 768.8654485465078, 769.2230846844672, 773.5899973014311, 778.6612823421773, 17099.487015389557, 17318.39385621497, 17410.564735881577, 17548.0, 17576.0, 18683.34608288717, 18769.812301876944, 19026.048697565206, 19032.71450928237, 19143.0, 14402.135871847619, 14486.058406203563, 14505.782413263809, 14595.051321664057, 14669.853301467063, 3374.8481318340732, 3403.710684591813, 3429.416999110132, 3525.1892064825233, 3556.78659280444, 84194.0, 84419.0, 84754.72867907048, 85026.14973850244, 85648.57175714144, 14415.135091894519, 14807.407703691732, 14868.70262594742, 14982.850171498145, 15007.399704011717, 25069.874650626996, 25601.8719906403, 25743.61384579233, 26766.866165669046, 26816.865915670685, 7926.365890728728, 8021.719239826695, 8170.3872209584515, 8238.670453181925, 8242.29940455056, 3737.9065523362133, 3829.4064420014943, 3835.3096442640594, 3847.6537111659527, 3852.749571277858, 4045.4336392905016, 4072.450219220427, 4119.0, 4128.8348466061625, 4208.642265407413, 822.6298165825402, 838.9496630202208, 840.8696652018947, 842.5576572299469, 844.6452489954233, 651.3031056769212, 666.0841343153164, 676.9187697476236, 678.2064983968768, 689.2969171445199, 9669.468179250069, 9993.80012399748, 10139.239557033252, 10545.261831671864, 10885.619003335003, 664.3655309179721, 667.4193451697055, 677.8745932002595, 681.9147606549182, 689.3520091114436, 4742.691725037862, 4764.071006153836, 4882.438519570295, 4897.4857639948, 5030.094582975026, 93591.19226423219, 95077.0, 95850.52074739581, 96324.51837740766, 96664.51667741757, 81479.0, 82163.17836821555, 82259.00798432081, 82296.0, 82318.4145268377, 64157.358426415136, 64194.11126499319, 64342.678286608265, 65022.67488662527, 65889.0, 9860.862651560212, 10661.680149595524, 10798.946005269923, 10977.12183025372, 11117.27737697047, 27827.44345113046, 27872.581911270943, 28156.296092597848, 29042.564361534172, 29640.588373475937, 35611.64388356187, 35862.820685896404, 35985.82007089948, 36642.45036324404, 37215.62784372122, 14202.147871127765, 14267.286635668383, 14305.785413218602, 14461.276936152939, 14494.63763405881, 16802.24389902482, 17354.652906942043, 17521.21154548074, 17965.461036168937, 18060.277588896297, 14588.12471251686, 14653.12081275127, 14731.705365892836, 14864.554063378117, 15011.17438540847, 15993.920030400239, 16187.0, 16369.590760230612, 16558.751618725968, 16606.418775342805, 14504.129752214902, 14556.63608409756, 14768.409263629765, 15366.462173823862, 15571.221438927781, 11002.0, 11389.430528473378, 11856.525738970344, 11869.287842729464, 11968.820467693165, 11678.357690327113, 11683.240589361665, 12144.332061736335, 12180.634580962585, 12208.572699955459], "value": 7929.93482628924, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 113.0, 112.0, 111.0, 112.0, 112.0, 113.0, 114.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 123.0, 182.0, 126.0, 122.0, 123.0, 130.0, 154.0, 122.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 171.0, 169.0, 163.0, 162.0, 167.0, 169.0, 172.0, 165.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 73.0, 116.0, 73.0, 76.0, 77.0, 74.0, 97.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 101.0, 83.0, 81.0, 82.0, 99.0, 82.0, 82.0, 105.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 151.0, 155.0, 149.0, 150.0, 150.0, 151.0, 155.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 99.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 56.0, 56.0, 59.0, 56.0, 57.0, 59.0, 56.0, 55.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 88.0, 87.0, 88.0, 87.0, 98.0, 88.0, 87.0, 112.0, 88.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 135.0, 135.0, 144.0, 129.0, 139.0, 141.0, 130.0, 133.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 195.0, 206.0, 199.0, 211.0, 194.0, 186.0, 197.0, 189.0, 201.0], "value": 196.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 74.0, 74.0, 72.0, 71.0, 71.0, 75.0, 71.0, 76.0], "value": 73.2, "unit": "score"}]}]} 04:05:15 INFO - Return code: 0 04:05:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:15 INFO - # TBPL SUCCESS # 04:05:15 INFO - Running post-action listener: _resource_record_post_action 04:05:15 INFO - [mozharness: 2017-06-06 11:05:15.990430Z] Finished run-tests step (success) 04:05:15 INFO - Running post-run listener: _resource_record_post_run 04:05:16 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 8192; Write bytes: 433692672; Read time: 92; Write time: 275584 04:05:16 INFO - TinderboxPrint: CPU usage
12.7% 04:05:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 92 04:05:16 INFO - TinderboxPrint: I/O write bytes / time
433,692,672 / 275,584 04:05:16 INFO - TinderboxPrint: CPU idle
8,736.5 (87.3%) 04:05:16 INFO - TinderboxPrint: CPU user
1,215.8 (12.1%) 04:05:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104636416; Read time: 0; Write time: 82056 04:05:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:05:16 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 8192; Write bytes: 329056256; Read time: 92; Write time: 193528 04:05:16 INFO - Running post-run listener: _upload_blobber_files 04:05:16 INFO - Blob upload gear active. 04:05:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:05:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:18 INFO - (blobuploader) - INFO - Done attempting. 04:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:19 INFO - (blobuploader) - INFO - Done attempting. 04:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:25 INFO - (blobuploader) - INFO - Done attempting. 04:05:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:05:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:05:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:26 INFO - (blobuploader) - INFO - Done attempting. 04:05:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:26 INFO - Return code: 0 04:05:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c11f28ec5d8d090df5c6c28ef376d503308724ef22f7b00dba656f063c59e776ef6c6af0b0a3e43fbeea39c86ab7924891487b7efd871fcb570dd241371bf11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/828617f3b295bc2ee37c09984fa9c48a278c04be4863e4077a3ec7874a6d382e30c4bc211255074ea572b9a777713a8b49bb1bcc8befa4f4a45828c34e5770af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7b5c966ba23313d48c6d60180cdfa46e539b699a1f93a512ddffc5ecd19bf252c226a124a8781732b00c47766aac633fd39c28fcd5c9c5b3dfde1a849961702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9589e4ade8f0b7f7d09fc765ba95995ac92fe3fc3b37a534e1f73f020f308b1109ad0eca33f077b38fa7517dadec09513e49ac68fc258b207638d3489c47ab96"} 04:05:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:26 INFO - Contents: 04:05:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c11f28ec5d8d090df5c6c28ef376d503308724ef22f7b00dba656f063c59e776ef6c6af0b0a3e43fbeea39c86ab7924891487b7efd871fcb570dd241371bf11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/828617f3b295bc2ee37c09984fa9c48a278c04be4863e4077a3ec7874a6d382e30c4bc211255074ea572b9a777713a8b49bb1bcc8befa4f4a45828c34e5770af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7b5c966ba23313d48c6d60180cdfa46e539b699a1f93a512ddffc5ecd19bf252c226a124a8781732b00c47766aac633fd39c28fcd5c9c5b3dfde1a849961702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9589e4ade8f0b7f7d09fc765ba95995ac92fe3fc3b37a534e1f73f020f308b1109ad0eca33f077b38fa7517dadec09513e49ac68fc258b207638d3489c47ab96"} 04:05:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:26 INFO - Copying logs to upload dir... 04:05:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.512459 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-06-06 04:05:25.426187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 04:05:25.429133) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323 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/8c11f28ec5d8d090df5c6c28ef376d503308724ef22f7b00dba656f063c59e776ef6c6af0b0a3e43fbeea39c86ab7924891487b7efd871fcb570dd241371bf11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/828617f3b295bc2ee37c09984fa9c48a278c04be4863e4077a3ec7874a6d382e30c4bc211255074ea572b9a777713a8b49bb1bcc8befa4f4a45828c34e5770af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7b5c966ba23313d48c6d60180cdfa46e539b699a1f93a512ddffc5ecd19bf252c226a124a8781732b00c47766aac633fd39c28fcd5c9c5b3dfde1a849961702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9589e4ade8f0b7f7d09fc765ba95995ac92fe3fc3b37a534e1f73f020f308b1109ad0eca33f077b38fa7517dadec09513e49ac68fc258b207638d3489c47ab96"} build_url:https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/WM5A4yj8QemamlrfNXrBeA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c11f28ec5d8d090df5c6c28ef376d503308724ef22f7b00dba656f063c59e776ef6c6af0b0a3e43fbeea39c86ab7924891487b7efd871fcb570dd241371bf11", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/828617f3b295bc2ee37c09984fa9c48a278c04be4863e4077a3ec7874a6d382e30c4bc211255074ea572b9a777713a8b49bb1bcc8befa4f4a45828c34e5770af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7b5c966ba23313d48c6d60180cdfa46e539b699a1f93a512ddffc5ecd19bf252c226a124a8781732b00c47766aac633fd39c28fcd5c9c5b3dfde1a849961702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9589e4ade8f0b7f7d09fc765ba95995ac92fe3fc3b37a534e1f73f020f308b1109ad0eca33f077b38fa7517dadec09513e49ac68fc258b207638d3489c47ab96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 04:05:25.452827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 04:05:25.453107) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496744215.141688-1472621323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 04:05:25.536532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 04:05:25.536847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 04:05:25.537145) ========= ========= Total master_lag: 0.17 =========