builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1496680899.23 results: success (0) revision: 2f77e11bf03d535873759601f73e2e65f464ba26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.233159) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.233629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.233917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.247062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.247347) ========= 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=826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 09:41:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-06-05 09:41:40 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.332335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.332660) ========= 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=826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019762 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:39.381750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 09:41:39.385092) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2f77e11bf03d535873759601f73e2e65f464ba26 --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 2f77e11bf03d535873759601f73e2e65f464ba26 --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=826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 09:41:40,541 truncating revision to first 12 chars 2017-06-05 09:41:40,541 Setting DEBUG logging. 2017-06-05 09:41:40,542 attempt 1/10 2017-06-05 09:41:40,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2f77e11bf03d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 09:41:41,736 unpacking tar archive at: mozilla-central-2f77e11bf03d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.491489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 09:41:40.888522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:40.888832) ========= script_repo_revision: 2f77e11bf03d535873759601f73e2e65f464ba26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:40.891236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:40.891498) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 09:41:40.899732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-05 09:41:40.900076) ========= /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=826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:41:42 INFO - MultiFileLogger online at 20170605 09:41:42 in /builds/slave/test 09:41:42 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 09:41:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:41:42 INFO - {'append_to_log': False, 09:41:42 INFO - 'base_work_dir': '/builds/slave/test', 09:41:42 INFO - 'blob_upload_branch': 'Firefox', 09:41:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:41:42 INFO - 'branch': 'Firefox', 09:41:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:41:42 INFO - 'config_files': ('talos/linux_config.py',), 09:41:42 INFO - 'default_actions': ('clobber', 09:41:42 INFO - 'read-buildbot-config', 09:41:42 INFO - 'download-and-extract', 09:41:42 INFO - 'populate-webroot', 09:41:42 INFO - 'create-virtualenv', 09:41:42 INFO - 'install', 09:41:42 INFO - 'setup-mitmproxy', 09:41:42 INFO - 'run-tests'), 09:41:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:41:42 INFO - 'download_minidump_stackwalk': True, 09:41:42 INFO - 'download_symbols': 'ondemand', 09:41:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:41:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:41:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:41:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:41:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:41:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:41:42 INFO - 'gecko_profile': False, 09:41:42 INFO - 'gecko_profile_interval': 0, 09:41:42 INFO - 'installer_path': 'installer.exe', 09:41:42 INFO - 'log_level': 'info', 09:41:42 INFO - 'log_name': 'talos', 09:41:42 INFO - 'log_to_console': True, 09:41:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:41:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:41:42 INFO - 'opt_config_files': (), 09:41:42 INFO - 'pip_index': False, 09:41:42 INFO - 'suite': 'dromaeojs-e10s', 09:41:42 INFO - 'system_bits': '32', 09:41:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:41:42 INFO - 'title': 'talos-linux64-ix-052', 09:41:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:41:42 INFO - 'use_talos_json': True, 09:41:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:41:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:41:42 INFO - 'work_dir': 'build'} 09:41:42 INFO - [mozharness: 2017-06-05 16:41:42.162353Z] Running clobber step. 09:41:42 INFO - Running pre-action listener: _resource_record_pre_action 09:41:42 INFO - Running main action method: clobber 09:41:42 INFO - rmtree: /builds/slave/test/build 09:41:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:41:43 INFO - Running post-action listener: _resource_record_post_action 09:41:43 INFO - [mozharness: 2017-06-05 16:41:43.792233Z] Finished clobber step (success) 09:41:43 INFO - [mozharness: 2017-06-05 16:41:43.792332Z] Running read-buildbot-config step. 09:41:43 INFO - Running pre-action listener: _resource_record_pre_action 09:41:43 INFO - Running main action method: read_buildbot_config 09:41:43 INFO - Using buildbot properties: 09:41:43 INFO - { 09:41:43 INFO - "project": "", 09:41:43 INFO - "product": "firefox", 09:41:43 INFO - "who": "ryanvm@gmail.com", 09:41:43 INFO - "installer_path": "public/build/target.tar.bz2", 09:41:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:41:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:41:43 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:41:43 INFO - "stage_platform": "linux64-stylo", 09:41:43 INFO - "basedir": "/builds/slave/test", 09:41:43 INFO - "buildnumber": 129, 09:41:43 INFO - "platform": "ubuntu64_hw_stylo", 09:41:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:41:43 INFO - "slavebuilddir": "test", 09:41:43 INFO - "taskId": "HEfJmFyaR6aSMoQG9jyc9w", 09:41:43 INFO - "branch": "mozilla-central", 09:41:43 INFO - "script_repo_revision": "production", 09:41:43 INFO - "revision": "2f77e11bf03d535873759601f73e2e65f464ba26", 09:41:43 INFO - "slavename": "talos-linux64-ix-052", 09:41:43 INFO - "repo_path": "mozilla-central" 09:41:43 INFO - } 09:41:43 INFO - Finding installer, test and symbols from parent task. 09:41:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HEfJmFyaR6aSMoQG9jyc9w'}, attempt #1 09:41:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HEfJmFyaR6aSMoQG9jyc9w'}, attempt #1 09:41:44 INFO - Task dependencies: AHdxqNkdTG-2Uapx0N6E-A 09:41:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A'}, attempt #1 09:41:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2 09:41:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/test_packages.json 09:41:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.crashreporter-symbols.zip 09:41:45 INFO - Running post-action listener: _resource_record_post_action 09:41:45 INFO - [mozharness: 2017-06-05 16:41:45.195492Z] Finished read-buildbot-config step (success) 09:41:45 INFO - [mozharness: 2017-06-05 16:41:45.195713Z] Running download-and-extract step. 09:41:45 INFO - Running pre-action listener: _resource_record_pre_action 09:41:45 INFO - Running main action method: download_and_extract 09:41:45 INFO - mkdir: /builds/slave/test/build/tests 09:41:45 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')]} 09:41:45 INFO - trying https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.test_packages.json 09:41:45 INFO - Downloading https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:41:45 INFO - Downloaded 989 bytes. 09:41:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:41:45 INFO - Using the following test package requirements: 09:41:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:41:45 INFO - u'common': [u'target.common.tests.zip'], 09:41:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:41:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:41:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:41:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:41:45 INFO - u'mozbase': [u'target.common.tests.zip'], 09:41:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:41:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:41:45 INFO - u'web-platform': [u'target.common.tests.zip', 09:41:45 INFO - u'target.web-platform.tests.tar.gz'], 09:41:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:41:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:41:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.common.tests.zip 09:41:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:41:45 INFO - Fetch https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.common.tests.zip into memory 09:41:47 INFO - Content-Length response header: 65108614 09:41:47 INFO - Bytes received: 65108614 09:41:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:41:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.common.tests.zip 09:41:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:41:58 INFO - Fetch https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.common.tests.zip into memory 09:41:59 INFO - Content-Length response header: 65108614 09:41:59 INFO - Bytes received: 65108614 09:42:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.talos.tests.zip 09:42:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:42:11 INFO - Fetch https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.talos.tests.zip into memory 09:42:11 INFO - Content-Length response header: 14447425 09:42:11 INFO - Bytes received: 14447425 09:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:12 INFO - trying https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2 09:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:42:13 INFO - Downloaded 60565528 bytes. 09:42:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2 09:42:13 INFO - mkdir: /builds/slave/test/properties 09:42:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:42:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:42:13 INFO - Contents: 09:42:13 INFO - build_url:https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2 09:42:13 INFO - Running post-action listener: _resource_record_post_action 09:42:13 INFO - Running post-action listener: set_extra_try_arguments 09:42:13 INFO - [mozharness: 2017-06-05 16:42:13.328708Z] Finished download-and-extract step (success) 09:42:13 INFO - [mozharness: 2017-06-05 16:42:13.328804Z] Running populate-webroot step. 09:42:13 INFO - Running pre-action listener: _resource_record_pre_action 09:42:13 INFO - Running main action method: populate_webroot 09:42:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:42:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:42:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:42:13 INFO - '--tppagecycles', 09:42:13 INFO - '7'], 09:42:13 INFO - 'tests': ['tsvgm']}}, 09:42:13 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:42:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:42:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:42:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:42:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['damp', 'tps']}, 09:42:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'tests': ['damp', 'tps']}, 09:42:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['dromaeo_dom']}, 09:42:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:42:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:42:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:42:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:42:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['a11yr', 09:42:13 INFO - 'ts_paint', 09:42:13 INFO - 'tpaint', 09:42:13 INFO - 'sessionrestore', 09:42:13 INFO - 'sessionrestore_no_auto_restore', 09:42:13 INFO - 'tabpaint']}, 09:42:13 INFO - 'other-e10s': {'tests': ['a11yr', 09:42:13 INFO - 'ts_paint', 09:42:13 INFO - 'tpaint', 09:42:13 INFO - 'sessionrestore', 09:42:13 INFO - 'sessionrestore_no_auto_restore', 09:42:13 INFO - 'tabpaint']}, 09:42:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:42:13 INFO - 'ts_paint', 09:42:13 INFO - 'tpaint', 09:42:13 INFO - 'sessionrestore', 09:42:13 INFO - 'sessionrestore_no_auto_restore', 09:42:13 INFO - 'tabpaint']}, 09:42:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:42:13 INFO - 'ts_paint', 09:42:13 INFO - 'tpaint', 09:42:13 INFO - 'sessionrestore', 09:42:13 INFO - 'sessionrestore_no_auto_restore', 09:42:13 INFO - 'tabpaint']}, 09:42:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['a11yr', 09:42:13 INFO - 'ts_paint', 09:42:13 INFO - 'tpaint', 09:42:13 INFO - 'sessionrestore', 09:42:13 INFO - 'sessionrestore_no_auto_restore', 09:42:13 INFO - 'tabpaint']}, 09:42:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['a11yr', 09:42:13 INFO - 'ts_paint', 09:42:13 INFO - 'tpaint', 09:42:13 INFO - 'sessionrestore', 09:42:13 INFO - 'sessionrestore_no_auto_restore', 09:42:13 INFO - 'tabpaint']}, 09:42:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:42:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:42:13 INFO - 'bloom_basic_ref']}, 09:42:13 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:42:13 INFO - 'talos_options': ['--mitmproxy', 09:42:13 INFO - 'mitmproxy-recording-1.mp', 09:42:13 INFO - '--firstNonBlankPaint'], 09:42:13 INFO - 'tests': ['Quantum_1']}, 09:42:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['tsvgx', 09:42:13 INFO - 'tsvgr_opacity', 09:42:13 INFO - 'tart', 09:42:13 INFO - 'tscrollx', 09:42:13 INFO - 'cart', 09:42:13 INFO - 'tsvg_static']}, 09:42:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:42:13 INFO - 'tsvgr_opacity', 09:42:13 INFO - 'tart', 09:42:13 INFO - 'tscrollx', 09:42:13 INFO - 'cart', 09:42:13 INFO - 'tsvg_static']}, 09:42:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'talos_options': ['--disable-e10s'], 09:42:13 INFO - 'tests': ['tp5o']}, 09:42:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:42:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'talos_options': ['--disable-e10s', 09:42:13 INFO - '--xperf_path', 09:42:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:13 INFO - 'tests': ['tp5n']}, 09:42:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:42:13 INFO - 'talos_options': ['--xperf_path', 09:42:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:42:13 INFO - 'tests': ['tp5n']}}, 09:42:13 INFO - 'talos.zip': {'path': '', 09:42:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:42:13 INFO - Running post-action listener: _resource_record_post_action 09:42:13 INFO - [mozharness: 2017-06-05 16:42:13.343110Z] Finished populate-webroot step (success) 09:42:13 INFO - [mozharness: 2017-06-05 16:42:13.343205Z] Running create-virtualenv step. 09:42:13 INFO - Running pre-action listener: _resource_record_pre_action 09:42:13 INFO - Running main action method: create_virtualenv 09:42:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:42:13 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 09:42:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:42:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:42:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:42:13 INFO - Using real prefix '/usr' 09:42:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:42:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:42:15 INFO - Installing pip.................done. 09:42:15 INFO - Return code: 0 09:42:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:42:16 INFO - Reading from file tmpfile_stdout 09:42:16 INFO - Output received: 09:42:16 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) 09:42:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42: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')]} 09:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:16 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:16 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 09:42:16 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 09:42:16 INFO - Using env: {'DISPLAY': ':0', 09:42:16 INFO - 'HOME': '/home/cltbld', 09:42:16 INFO - 'LANG': 'en_US.UTF-8', 09:42:16 INFO - 'LANGUAGE': 'en_US:en', 09:42:16 INFO - 'LOGNAME': 'cltbld', 09:42:16 INFO - 'MAIL': '/var/mail/cltbld', 09:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:16 INFO - 'MOZ_NO_REMOTE': '1', 09:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:16 INFO - 'NO_EM_RESTART': '1', 09:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:16 INFO - 'PWD': '/builds/slave/test', 09:42:16 INFO - 'SHELL': '/bin/bash', 09:42:16 INFO - 'SHLVL': '1', 09:42:16 INFO - 'TERM': 'linux', 09:42:16 INFO - 'TMOUT': '86400', 09:42:16 INFO - 'USER': 'cltbld', 09:42:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:16 INFO - '_': '/tools/buildbot/bin/python'} 09:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:16 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 09:42:16 INFO - Cleaning up... 09:42:16 INFO - Return code: 0 09:42:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42: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')]} 09:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:16 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:16 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 09:42:16 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 09:42:16 INFO - Using env: {'DISPLAY': ':0', 09:42:16 INFO - 'HOME': '/home/cltbld', 09:42:16 INFO - 'LANG': 'en_US.UTF-8', 09:42:16 INFO - 'LANGUAGE': 'en_US:en', 09:42:16 INFO - 'LOGNAME': 'cltbld', 09:42:16 INFO - 'MAIL': '/var/mail/cltbld', 09:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:16 INFO - 'MOZ_NO_REMOTE': '1', 09:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:16 INFO - 'NO_EM_RESTART': '1', 09:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:16 INFO - 'PWD': '/builds/slave/test', 09:42:16 INFO - 'SHELL': '/bin/bash', 09:42:16 INFO - 'SHLVL': '1', 09:42:16 INFO - 'TERM': 'linux', 09:42:16 INFO - 'TMOUT': '86400', 09:42:16 INFO - 'USER': 'cltbld', 09:42:16 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:16 INFO - '_': '/tools/buildbot/bin/python'} 09:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:16 INFO - Downloading/unpacking psutil>=3.1.1 09:42:16 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 09:42:16 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 09:42:16 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 09:42:16 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 09:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:42:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:18 INFO - Installing collected packages: psutil 09:42:18 INFO - Running setup.py install for psutil 09:42:18 INFO - building 'psutil._psutil_linux' extension 09:42:18 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 09:42:19 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 09:42:19 INFO - building 'psutil._psutil_posix' extension 09:42:19 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 09:42:19 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 09:42:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:42:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:42:19 INFO - Successfully installed psutil 09:42:19 INFO - Cleaning up... 09:42:19 INFO - Return code: 0 09:42:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42: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')]} 09:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:19 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:19 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 09:42:19 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 09:42:19 INFO - Using env: {'DISPLAY': ':0', 09:42:19 INFO - 'HOME': '/home/cltbld', 09:42:19 INFO - 'LANG': 'en_US.UTF-8', 09:42:19 INFO - 'LANGUAGE': 'en_US:en', 09:42:19 INFO - 'LOGNAME': 'cltbld', 09:42:19 INFO - 'MAIL': '/var/mail/cltbld', 09:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:19 INFO - 'MOZ_NO_REMOTE': '1', 09:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:19 INFO - 'NO_EM_RESTART': '1', 09:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:19 INFO - 'PWD': '/builds/slave/test', 09:42:19 INFO - 'SHELL': '/bin/bash', 09:42:19 INFO - 'SHLVL': '1', 09:42:19 INFO - 'TERM': 'linux', 09:42:19 INFO - 'TMOUT': '86400', 09:42:19 INFO - 'USER': 'cltbld', 09:42:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:19 INFO - '_': '/tools/buildbot/bin/python'} 09:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:42:19 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 09:42:19 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 09:42:19 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 09:42:19 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 09:42:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:42:20 INFO - Installing collected packages: mozsystemmonitor 09:42:20 INFO - Running setup.py install for mozsystemmonitor 09:42:20 INFO - Successfully installed mozsystemmonitor 09:42:20 INFO - Cleaning up... 09:42:20 INFO - Return code: 0 09:42:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:20 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:20 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 09:42:20 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 09:42:20 INFO - Using env: {'DISPLAY': ':0', 09:42:20 INFO - 'HOME': '/home/cltbld', 09:42:20 INFO - 'LANG': 'en_US.UTF-8', 09:42:20 INFO - 'LANGUAGE': 'en_US:en', 09:42:20 INFO - 'LOGNAME': 'cltbld', 09:42:20 INFO - 'MAIL': '/var/mail/cltbld', 09:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:20 INFO - 'MOZ_NO_REMOTE': '1', 09:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:20 INFO - 'NO_EM_RESTART': '1', 09:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:20 INFO - 'PWD': '/builds/slave/test', 09:42:20 INFO - 'SHELL': '/bin/bash', 09:42:20 INFO - 'SHLVL': '1', 09:42:20 INFO - 'TERM': 'linux', 09:42:20 INFO - 'TMOUT': '86400', 09:42:20 INFO - 'USER': 'cltbld', 09:42:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:20 INFO - '_': '/tools/buildbot/bin/python'} 09:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:21 INFO - Downloading/unpacking jsonschema==2.5.1 09:42:21 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 09:42:21 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 09:42:21 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 09:42:21 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 09:42:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:42:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:22 INFO - Downloading functools32-3.2.3-2.tar.gz 09:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:42:22 INFO - warning: no files found matching '*.txt' 09:42:22 INFO - no previously-included directories found matching 'build' 09:42:22 INFO - no previously-included directories found matching 'dist' 09:42:22 INFO - no previously-included directories found matching '.git*' 09:42:22 INFO - Installing collected packages: jsonschema, functools32 09:42:22 INFO - Running setup.py install for functools32 09:42:22 INFO - warning: no files found matching '*.txt' 09:42:22 INFO - no previously-included directories found matching 'build' 09:42:22 INFO - no previously-included directories found matching 'dist' 09:42:22 INFO - no previously-included directories found matching '.git*' 09:42:22 INFO - Successfully installed jsonschema functools32 09:42:22 INFO - Cleaning up... 09:42:22 INFO - Return code: 0 09:42:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:42:22 INFO - Using env: {'DISPLAY': ':0', 09:42:22 INFO - 'HOME': '/home/cltbld', 09:42:22 INFO - 'LANG': 'en_US.UTF-8', 09:42:22 INFO - 'LANGUAGE': 'en_US:en', 09:42:22 INFO - 'LOGNAME': 'cltbld', 09:42:22 INFO - 'MAIL': '/var/mail/cltbld', 09:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:22 INFO - 'MOZ_NO_REMOTE': '1', 09:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:22 INFO - 'NO_EM_RESTART': '1', 09:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:22 INFO - 'PWD': '/builds/slave/test', 09:42:22 INFO - 'SHELL': '/bin/bash', 09:42:22 INFO - 'SHLVL': '1', 09:42:22 INFO - 'TERM': 'linux', 09:42:22 INFO - 'TMOUT': '86400', 09:42:22 INFO - 'USER': 'cltbld', 09:42:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:22 INFO - '_': '/tools/buildbot/bin/python'} 09:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:42:22 INFO - Cleaning up... 09:42:22 INFO - Return code: 0 09:42:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:42:22 INFO - Using env: {'DISPLAY': ':0', 09:42:22 INFO - 'HOME': '/home/cltbld', 09:42:22 INFO - 'LANG': 'en_US.UTF-8', 09:42:22 INFO - 'LANGUAGE': 'en_US:en', 09:42:22 INFO - 'LOGNAME': 'cltbld', 09:42:22 INFO - 'MAIL': '/var/mail/cltbld', 09:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:22 INFO - 'MOZ_NO_REMOTE': '1', 09:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:22 INFO - 'NO_EM_RESTART': '1', 09:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:22 INFO - 'PWD': '/builds/slave/test', 09:42:22 INFO - 'SHELL': '/bin/bash', 09:42:22 INFO - 'SHLVL': '1', 09:42:22 INFO - 'TERM': 'linux', 09:42:22 INFO - 'TMOUT': '86400', 09:42:22 INFO - 'USER': 'cltbld', 09:42:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:22 INFO - '_': '/tools/buildbot/bin/python'} 09:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:42:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:42:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:42:24 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 09:42:24 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 09:42:24 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 09:42:24 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 09:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:42:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:42:24 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 09:42:24 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 09:42:24 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 09:42:24 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 09:42:24 INFO - Downloading docopt-0.6.1.tar.gz 09:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:42:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:42:24 INFO - Running setup.py install for blobuploader 09:42:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:42:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:42:24 INFO - Running setup.py install for requests 09:42:25 INFO - Running setup.py install for docopt 09:42:25 INFO - Successfully installed blobuploader requests docopt 09:42:25 INFO - Cleaning up... 09:42:25 INFO - Return code: 0 09:42:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:25 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:25 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 09:42:25 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 09:42:25 INFO - Using env: {'DISPLAY': ':0', 09:42:25 INFO - 'HOME': '/home/cltbld', 09:42:25 INFO - 'LANG': 'en_US.UTF-8', 09:42:25 INFO - 'LANGUAGE': 'en_US:en', 09:42:25 INFO - 'LOGNAME': 'cltbld', 09:42:25 INFO - 'MAIL': '/var/mail/cltbld', 09:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:25 INFO - 'MOZ_NO_REMOTE': '1', 09:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:25 INFO - 'NO_EM_RESTART': '1', 09:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:25 INFO - 'PWD': '/builds/slave/test', 09:42:25 INFO - 'SHELL': '/bin/bash', 09:42:25 INFO - 'SHLVL': '1', 09:42:25 INFO - 'TERM': 'linux', 09:42:25 INFO - 'TMOUT': '86400', 09:42:25 INFO - 'USER': 'cltbld', 09:42:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:25 INFO - '_': '/tools/buildbot/bin/python'} 09:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:25 INFO - Running setup.py (path:/tmp/pip-VyyhMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:25 INFO - Running setup.py (path:/tmp/pip-uThri0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:25 INFO - Running setup.py (path:/tmp/pip-tSBPDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:25 INFO - Running setup.py (path:/tmp/pip-nCckCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:25 INFO - Running setup.py (path:/tmp/pip-gJVkFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:25 INFO - Running setup.py (path:/tmp/pip-8omStj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:25 INFO - Running setup.py (path:/tmp/pip-UEoJO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:25 INFO - Running setup.py (path:/tmp/pip-hLwvjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:26 INFO - Running setup.py (path:/tmp/pip-rtN8bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:26 INFO - Running setup.py (path:/tmp/pip-79LlzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:26 INFO - Running setup.py (path:/tmp/pip-iVKvsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:26 INFO - Running setup.py (path:/tmp/pip-YVWOsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:26 INFO - Running setup.py (path:/tmp/pip-jagc5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:26 INFO - Running setup.py (path:/tmp/pip-HDlsns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:26 INFO - Running setup.py (path:/tmp/pip-X01BSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:26 INFO - Running setup.py (path:/tmp/pip-FI0Py8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:26 INFO - Running setup.py (path:/tmp/pip-KHNphA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:42:26 INFO - Running setup.py install for manifestparser 09:42:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:42:26 INFO - Running setup.py install for mozcrash 09:42:26 INFO - Running setup.py install for mozdebug 09:42:26 INFO - Running setup.py install for mozdevice 09:42:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for mozfile 09:42:27 INFO - Running setup.py install for mozhttpd 09:42:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for mozinfo 09:42:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for mozInstall 09:42:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for mozleak 09:42:27 INFO - Running setup.py install for mozlog 09:42:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for moznetwork 09:42:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for mozprocess 09:42:27 INFO - Running setup.py install for mozprofile 09:42:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:42:27 INFO - Running setup.py install for mozrunner 09:42:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:42:28 INFO - Running setup.py install for mozscreenshot 09:42:28 INFO - Running setup.py install for moztest 09:42:28 INFO - Running setup.py install for mozversion 09:42:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:42:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:42:28 INFO - Cleaning up... 09:42:28 INFO - Return code: 0 09:42:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42:28 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')]} 09:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:28 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')]} 09:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:28 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:28 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 09:42:28 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 09:42:28 INFO - Using env: {'DISPLAY': ':0', 09:42:28 INFO - 'HOME': '/home/cltbld', 09:42:28 INFO - 'LANG': 'en_US.UTF-8', 09:42:28 INFO - 'LANGUAGE': 'en_US:en', 09:42:28 INFO - 'LOGNAME': 'cltbld', 09:42:28 INFO - 'MAIL': '/var/mail/cltbld', 09:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:28 INFO - 'MOZ_NO_REMOTE': '1', 09:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:28 INFO - 'NO_EM_RESTART': '1', 09:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:28 INFO - 'PWD': '/builds/slave/test', 09:42:28 INFO - 'SHELL': '/bin/bash', 09:42:28 INFO - 'SHLVL': '1', 09:42:28 INFO - 'TERM': 'linux', 09:42:28 INFO - 'TMOUT': '86400', 09:42:28 INFO - 'USER': 'cltbld', 09:42:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:28 INFO - '_': '/tools/buildbot/bin/python'} 09:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:42:28 INFO - Running setup.py (path:/tmp/pip-8Be1_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:42:28 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)) 09:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:42:28 INFO - Running setup.py (path:/tmp/pip-0J1udg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:42:28 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)) 09:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:42:28 INFO - Running setup.py (path:/tmp/pip-UZ_Kl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:42:28 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)) 09:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:42:28 INFO - Running setup.py (path:/tmp/pip-RuiOrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:42:28 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)) 09:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:42:28 INFO - Running setup.py (path:/tmp/pip-EuT8JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:42:29 INFO - Running setup.py (path:/tmp/pip-CrimtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:42:29 INFO - Running setup.py (path:/tmp/pip-vecKIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:42:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:42:29 INFO - Running setup.py (path:/tmp/pip-0qSFX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:42:29 INFO - Running setup.py (path:/tmp/pip-A8fE0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:42:29 INFO - Running setup.py (path:/tmp/pip-rNWrwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:42:29 INFO - Running setup.py (path:/tmp/pip-afTb95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:42:29 INFO - Running setup.py (path:/tmp/pip-mZRWmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:42:29 INFO - Running setup.py (path:/tmp/pip-US4DB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:42:29 INFO - Running setup.py (path:/tmp/pip-FdqE6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:29 INFO - Running setup.py (path:/tmp/pip-7qpyll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:42:29 INFO - Running setup.py (path:/tmp/pip-QgQZ5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:42:29 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)) 09:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:42:29 INFO - Running setup.py (path:/tmp/pip-gav5Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:42:29 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)) 09:42:29 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)) 09:42:29 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)) 09:42:29 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)) 09:42:29 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)) 09:42:29 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)) 09:42:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:42:29 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 09:42:29 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 09:42:29 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 09:42:29 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 09:42:30 INFO - Downloading blessings-1.6.tar.gz 09:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:42:31 INFO - Installing collected packages: blessings 09:42:31 INFO - Running setup.py install for blessings 09:42:31 INFO - Successfully installed blessings 09:42:31 INFO - Cleaning up... 09:42:31 INFO - Return code: 0 09:42:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:31 INFO - Reading from file tmpfile_stdout 09:42:31 INFO - Current package versions: 09:42:31 INFO - argparse == 1.2.1 09:42:31 INFO - blessings == 1.6 09:42:31 INFO - blobuploader == 1.2.4 09:42:31 INFO - docopt == 0.6.1 09:42:31 INFO - functools32 == 3.2.3-2 09:42:31 INFO - jsonschema == 2.5.1 09:42:31 INFO - manifestparser == 1.1 09:42:31 INFO - mozInstall == 1.12 09:42:31 INFO - mozcrash == 1.0 09:42:31 INFO - mozdebug == 0.1 09:42:31 INFO - mozdevice == 0.51 09:42:31 INFO - mozfile == 1.2 09:42:31 INFO - mozhttpd == 0.7 09:42:31 INFO - mozinfo == 0.9 09:42:31 INFO - mozleak == 0.1 09:42:31 INFO - mozlog == 3.4 09:42:31 INFO - moznetwork == 0.27 09:42:31 INFO - mozprocess == 0.25 09:42:31 INFO - mozprofile == 0.28 09:42:31 INFO - mozrunner == 6.13 09:42:31 INFO - mozscreenshot == 0.1 09:42:31 INFO - mozsystemmonitor == 0.3 09:42:31 INFO - moztest == 0.8 09:42:31 INFO - mozversion == 1.4 09:42:31 INFO - psutil == 3.1.1 09:42:31 INFO - requests == 1.2.3 09:42:31 INFO - wsgiref == 0.1.2 09:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:42: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')]} 09:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42: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')]} 09:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:31 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 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:31 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 09:42:31 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 09:42:31 INFO - Using env: {'DISPLAY': ':0', 09:42:31 INFO - 'HOME': '/home/cltbld', 09:42:31 INFO - 'LANG': 'en_US.UTF-8', 09:42:31 INFO - 'LANGUAGE': 'en_US:en', 09:42:31 INFO - 'LOGNAME': 'cltbld', 09:42:31 INFO - 'MAIL': '/var/mail/cltbld', 09:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:31 INFO - 'MOZ_NO_REMOTE': '1', 09:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:31 INFO - 'NO_EM_RESTART': '1', 09:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:31 INFO - 'PWD': '/builds/slave/test', 09:42:31 INFO - 'SHELL': '/bin/bash', 09:42:31 INFO - 'SHLVL': '1', 09:42:31 INFO - 'TERM': 'linux', 09:42:31 INFO - 'TMOUT': '86400', 09:42:31 INFO - 'USER': 'cltbld', 09:42:31 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:31 INFO - '_': '/tools/buildbot/bin/python'} 09:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 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)) 09:42:31 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:42:31 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 09:42:31 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 09:42:31 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 09:42:31 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 09:42:32 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:42:32 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)) 09:42:32 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)) 09:42:32 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)) 09:42:32 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)) 09:42:32 INFO - Installing collected packages: marionette-driver 09:42:32 INFO - Running setup.py install for marionette-driver 09:42:32 INFO - Successfully installed marionette-driver 09:42:32 INFO - Cleaning up... 09:42:32 INFO - Return code: 0 09:42:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:42:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1218dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, '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': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', '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 09:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:42:32 INFO - Using env: {'DISPLAY': ':0', 09:42:32 INFO - 'HOME': '/home/cltbld', 09:42:32 INFO - 'LANG': 'en_US.UTF-8', 09:42:32 INFO - 'LANGUAGE': 'en_US:en', 09:42:32 INFO - 'LOGNAME': 'cltbld', 09:42:32 INFO - 'MAIL': '/var/mail/cltbld', 09:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:32 INFO - 'MOZ_NO_REMOTE': '1', 09:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:32 INFO - 'NO_EM_RESTART': '1', 09:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:32 INFO - 'PWD': '/builds/slave/test', 09:42:32 INFO - 'SHELL': '/bin/bash', 09:42:32 INFO - 'SHLVL': '1', 09:42:32 INFO - 'TERM': 'linux', 09:42:32 INFO - 'TMOUT': '86400', 09:42:32 INFO - 'USER': 'cltbld', 09:42:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:32 INFO - '_': '/tools/buildbot/bin/python'} 09:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:42:33 INFO - Cleaning up... 09:42:33 INFO - Return code: 0 09:42:33 INFO - Running post-action listener: _resource_record_post_action 09:42:33 INFO - Running post-action listener: _start_resource_monitoring 09:42:33 INFO - Starting resource monitoring. 09:42:33 INFO - [mozharness: 2017-06-05 16:42:33.179349Z] Finished create-virtualenv step (success) 09:42:33 INFO - [mozharness: 2017-06-05 16:42:33.179871Z] Running install step. 09:42:33 INFO - Running pre-action listener: _resource_record_pre_action 09:42:33 INFO - Running main action method: install 09:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:42:33 INFO - Reading from file tmpfile_stdout 09:42:33 INFO - Detecting whether we're running mozinstall >=1.0... 09:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:42:33 INFO - Reading from file tmpfile_stdout 09:42:33 INFO - Output received: 09:42:33 INFO - Usage: mozinstall [options] installer 09:42:33 INFO - Options: 09:42:33 INFO - -h, --help show this help message and exit 09:42:33 INFO - -d DEST, --destination=DEST 09:42:33 INFO - Directory to install application into. [default: 09:42:33 INFO - "/builds/slave/test"] 09:42:33 INFO - --app=APP Application being installed. [default: firefox] 09:42:33 INFO - mkdir: /builds/slave/test/build/application 09:42:33 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'] 09:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:42:50 INFO - Reading from file tmpfile_stdout 09:42:50 INFO - Output received: 09:42:50 INFO - /builds/slave/test/build/application/firefox/firefox 09:42:50 INFO - Running post-action listener: _resource_record_post_action 09:42:50 INFO - [mozharness: 2017-06-05 16:42:50.967773Z] Finished install step (success) 09:42:50 INFO - [mozharness: 2017-06-05 16:42:50.967924Z] Running setup-mitmproxy step. 09:42:50 INFO - Running pre-action listener: _resource_record_pre_action 09:42:50 INFO - Running main action method: setup_mitmproxy 09:42:50 INFO - Skipping: mitmproxy is not required 09:42:50 INFO - Running post-action listener: _resource_record_post_action 09:42:50 INFO - [mozharness: 2017-06-05 16:42:50.968448Z] Finished setup-mitmproxy step (success) 09:42:50 INFO - [mozharness: 2017-06-05 16:42:50.968551Z] Running run-tests step. 09:42:50 INFO - Running pre-action listener: _resource_record_pre_action 09:42:50 INFO - Running main action method: run_tests 09:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:42:50 INFO - Python 2.7.3 09:42:50 INFO - Return code: 0 09:42:50 INFO - grabbing minidump binary from tooltool 09:42:50 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')]} 09:42:50 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 0x1215840>, '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 0x1216740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1216bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:42:50 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 09:42:50 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 09:42:50 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 09:42:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:42:51 INFO - Return code: 0 09:42:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:42:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:42:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:42:51 INFO - ENV: RUST_BACKTRACE is now 1 09:42:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:42:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:42:51 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/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 09:42:51 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/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 09:42:51 INFO - Using env: {'DISPLAY': ':0', 09:42:51 INFO - 'HOME': '/home/cltbld', 09:42:51 INFO - 'LANG': 'en_US.UTF-8', 09:42:51 INFO - 'LANGUAGE': 'en_US:en', 09:42:51 INFO - 'LOGNAME': 'cltbld', 09:42:51 INFO - 'MAIL': '/var/mail/cltbld', 09:42:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:42:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:42:51 INFO - 'MOZ_NO_REMOTE': '1', 09:42:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:42:51 INFO - 'NO_EM_RESTART': '1', 09:42:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:42:51 INFO - 'PWD': '/builds/slave/test', 09:42:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:42:51 INFO - 'RUST_BACKTRACE': '1', 09:42:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:42:51 INFO - 'SHELL': '/bin/bash', 09:42:51 INFO - 'SHLVL': '1', 09:42:51 INFO - 'TERM': 'linux', 09:42:51 INFO - 'TMOUT': '86400', 09:42:51 INFO - 'USER': 'cltbld', 09:42:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029', 09:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:42:51 INFO - '_': '/tools/buildbot/bin/python'} 09:42:51 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/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 09:42:51 INFO - mozversion application_buildid: 20170605155915 09:42:51 INFO - mozversion application_changeset: 2f77e11bf03d535873759601f73e2e65f464ba26 09:42:51 INFO - mozversion application_display_name: Nightly 09:42:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:42:51 INFO - mozversion application_name: Firefox 09:42:51 INFO - mozversion application_remotingname: firefox 09:42:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:42:51 INFO - mozversion application_vendor: Mozilla 09:42:51 INFO - mozversion application_version: 55.0a1 09:42:51 INFO - mozversion platform_buildid: 20170605155915 09:42:51 INFO - mozversion platform_changeset: 2f77e11bf03d535873759601f73e2e65f464ba26 09:42:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:42:51 INFO - mozversion platform_version: 55.0a1 09:42:51 INFO - using testdate: 1496680971 09:42:51 INFO - actual date: 1496680971 09:42:51 INFO - starting webserver on 'localhost:51449' 09:42:51 INFO - SUITE-START | Running 2 tests 09:42:51 INFO - TEST-START | dromaeo_css 09:42:51 INFO - operating with platform_type : linux_ 09:42:51 INFO - Initialising browser for dromaeo_css test... 09:42:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51449/getInfo.html -profile /tmp/tmpL9hYQQ/profile 09:42:51 INFO - TEST-INFO | started process 29087 (/builds/slave/test/build/application/firefox/firefox http://localhost:51449/getInfo.html) 09:43:25 INFO - TEST-INFO | 29087: killed by SIGTERM 09:43:25 INFO - Browser initialized. 09:43:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:43:25 INFO - TEST-INFO | started process 29315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL9hYQQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:37 INFO - PID 29315 | RSS: Main: 191807488 09:43:37 INFO - PID 29315 | 09:46:38 INFO - PID 29315 | Cycle 1(1): loaded http://localhost:51449/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51449/tests/dromaeo/cssquery-ext.html) 09:46:40 INFO - PID 29315 | RSS: Main: 187150336 09:46:40 INFO - PID 29315 | 09:49:42 INFO - PID 29315 | Cycle 1(1): loaded http://localhost:51449/tests/dromaeo/cssquery-ext.html (next: http://localhost:51449/tests/dromaeo/cssquery-jquery.html) 09:49:43 INFO - PID 29315 | RSS: Main: 193703936 09:49:43 INFO - PID 29315 | 09:52:44 INFO - PID 29315 | Cycle 1(1): loaded http://localhost:51449/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51449/tests/dromaeo/cssquery-mootools.html) 09:52:45 INFO - PID 29315 | RSS: Main: 190648320 09:52:45 INFO - PID 29315 | 09:55:47 INFO - PID 29315 | Cycle 1(1): loaded http://localhost:51449/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51449/tests/dromaeo/cssquery-prototype.html) 09:55:47 INFO - PID 29315 | RSS: Main: 194899968 09:55:47 INFO - PID 29315 | 09:58:50 INFO - PID 29315 | Cycle 1(1): loaded http://localhost:51449/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51449/tests/dromaeo/cssquery-yui.html) 09:58:51 INFO - PID 29315 | RSS: Main: 193675264 09:58:51 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | Cycle 1(1): loaded http://localhost:51449/tests/dromaeo/cssquery-yui.html (next: http://localhost:51449/tests/dromaeo/cssquery-dojo.html) 10:01:53 INFO - PID 29315 | RSS: Main: 191397888 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | __start_tp_report 10:01:53 INFO - PID 29315 | _x_x_mozilla_page_load 10:01:53 INFO - PID 29315 | _x_x_mozilla_page_load_details 10:01:53 INFO - PID 29315 | |i|pagename|runs| 10:01:53 INFO - PID 29315 | |0;dojo.html;3084.244360131768;3092.9638571078685;3111.4866047102228;3128.3117714102905;3139.105354973832;5949.7025148742605;5980.1926739890105;6026.578139530235;6029.065494848294;6036.818895433138;5933.7033148342625;5958;5976.073708575178;5978.850528736783;6036.8490787730325;5497;5610.803621873235;5620.932022915643;5625;5642.971785141069;5451.863703407407;5608.691521966311;5630.493255606994;5656.943430565703;5657.717114144297;5567.248421463091;5655.57583181261;5671.291088613923;5690.5447564194765;5717.456841600062;5468.589855760833;5505.504504594605;5522.199281104217;5533.916991245134;5574.944250557523;5558.360788509332;5561.360443549003;5588;5609.130584759328;5622.91565626516;6012.458878700938;6024.608400453956;6040.667763273018;6041.8187454376;6046.365131661156;6310;6446.129772480702;6542.214934207926;6551.0500977358015;6554.344565543455;6459.5478316517865;6471.611703297817;6516.0877477153235;6539.378759017934;6561.540692151551;6018.1574579558455;6020.571200319588;6052.727627256784;6066.211392518989;6120.479759220516;6487.7080531376205;6634.13756211699;6687.230968438595;6692.364225398579;6709.29552397001;6280.214973128359;6283.96858015707;6363.236411630634;6364.395382438661;6389;6524.347565243438;6528.445082167974;6530.771423000172;6535.542512024208;6555.508336874754;6442.323556026643;6478.514111441661;6479.222493300834;6493.967530162414;6537.901931471032;6230.813075607739;6291.433770960635;6340.334264902119;6448;6474.417302442708;5237.528622424;5309.65487243328;5311.7344132793205;5357.651752636066;5365.839024829262;4533.863984080483;4544.863654090383;4576.382188404589;4589.655775816827;4596.678232523691;5572.693501857356;5655.802046928337;5662.292213473316;5666.660000399989;5682.176084467729;6562.934370656232;6567;6610.0745895574655;6611.140551728245;6611.834704132339;5664.631798933056;5681.34664513578;5700.315962084576;5701.771929122871;5751.367349591542;5622.072358060956;5673.886522269531;5736.655800651891;5741.052726300197;5751.683657398883;6207.565470417027;6304.401081897304;6324.462420694293;6330.49356051524;6335.841603959938;6438.163038804925;6489.448396886318;6532.281449040506;6540.953447448385;6572.80281591553;6133.946794548733;6203.96898015507;6205.410486003822;6298.496120310272;6305.148804911279;6283.7800676976085;6343.746250150127;6387.201599800025;6397.136386587751;6403.135576697273;6519.250286217146;6542.1168142300185;6551.672416379257;6553.541252112306;6562.80311590653;6151.50787936955;6246.281677607133;6305.464035557029;6345.7144428499905;6361.236651601837;6189.071639254148;6272.341404152681;6292.1505596743855;6299.811005669837;6320.083587879823;6249.031400132987;6284.780032698834;6312.2740884796995;6331.113644089739;6338.619682819046;6434;6440.967795161182;6445.5165862561435;6448.290688024407;6457.0637257596445;6048.304444988707;6112.837854638657;6122.733612273432;6192.287886892885;6222.937770622236 10:01:53 INFO - PID 29315 | |1;ext.html;731.3162193349219;768.6118510152372;790.7706765038138;1141.6632093532412;1149.4080548517509;37543.43684844726;38630.806845965766;38634.227315453674;38636.61363386365;38808.223835523306;40041.799791001;40462.393064104064;40633.39049914254;40688.38967415491;40738.7963060185;7269.236730143338;7418.96290518548;7452.55284682918;7592.050993625797;7592.658330375147;7414.332710056094;7472.4395670324675;7474.813129671747;7482.588457634828;7491.962540187292;7501.66242519088;7505.061867266591;7555.773326800205;7559.62201889906;7561.508501947384;7483.027206463179;7504.887426688604;7504.887426688604;7508.286712762333;7510.460355627083;7323.084614423197;7369.520981136263;7381.409487241008;7383.8154046149275;7414.555126692416;35978.82010589956;36227.09432264188;36230.63769362299;36243.275134497424;36279.63720362789;3352.932941341184;3381.2899291148888;3386.7121294689982;3407.7444191685477;3407.812570308632;27951.86024069887;28022.299442513897;28090.578641320397;28135.718642813514;28158.577621335695;3637.290728307981;3642.690371318441;3644.927101457956;3659.835307411173;3660.249648821985;167512;169172;176095;184474;184567.07716461466;43688.3446748299;43830.34254486185;43885.341719874225;43917.29075220201;43997.120057598666;45458.77270613626;45719;45832.3125153123;45921.5407845924;45965.310520342224;13820.585382438543;13910.374033168531;13948.651283717785;13951.162930224218;13976.860231397759;11057.834132488018;11209.271397359309;11249.550017999352;11253.831192532118;11275.605353812742;13507.527236546674;13592.11651242666;13603.591892243248;13726.794098088536;13844.723105537832;5624.325080990226;5674.0565307111165;5708.600397972102;5744.034100835048;5784.21913041734;964.4117088575963;995.2833959549113;1002.4486532407293;1002.8144793213279;1011.2163073617858;21689.240876569245;22437.43906402353;22465.10139594398;23022.539549208923;23045.884770576038;1066.722652110457;1076;1081.491698901515;1083.9566417343217;1084.2139448899484;11770.882291176978;11997.10075856878;12067.396630168456;12354.208639747187;12951.222926624432;203470;205805;205889;206796;206805;49817.50182498201;50116.49883501118;50167.49832501701;50275.74862125666;50303.74848125736;1398.1471302505463;1425.6863490032176;1433.3621538415514;1440.0567628203544;1447.7249322628668;21156.576868462853;22216.444588885406;23424.414389640395;23701.644475332538;23894.163704270268;36672.08319792026;45483.77258113688;46667;46724;46760.53239467562;180641;182020;182255;182850;183367;32849.34301314008;33930;34048.48927266143;34248.91759741635;34586.30827383488;40085.599144008185;41612.50324980511;41839.58160418357;43102.35346469743;43298.567014330714;30167.547486787276;30936.381272374878;30963.535546966363;31564;32520.67479325271;30064.549031764105;30089.54865676973;30523.389532209676;31057;31775;33527.49708754322;35313.1171720709;35351.46972795359;35373.115672108404;35451;29071;29686;29902.551461728526;30267.69732302649;31418.685813141576;21925.451863703536;24243.51512969766;24356.75643243545;24485;24517.387065322797 10:01:53 INFO - PID 29315 | |2;jquery.html;409.1693861461235;415.7775590059318;418.5814185814186;425.08606496033525;439.08450879915375;14745.852541474582;15288.464903728373;20189.798102018976;20692.89653551732;20900.89549552252;21263.36209913701;22135.57288542294;22262.220822271225;22312.330630081124;22342.10631574739;5858.472737453618;5863.061910094386;5888.087346461305;5907.468327850493;6013.398660133996;5815.563832712563;5903.616264942786;5911.852203694921;5921.141434491996;5928.87351403232;5583.162525621149;5870.412958704117;5877.706114694248;5881.8823623527505;5900.055991041434;5859.326177489579;5884.882302353972;5894.204282421882;5900.557458190653;5907.704614769265;5278.1291086970605;5290.1800220965815;5317.308749862532;5319.680819150824;5335.9466405336225;24532.754672453226;24886.626700599507;24896.875515622305;24897.128600498894;24961.375965600822;1919.8368138708227;1950.2589016173904;1958.3831093205595;1960.1865225931222;1960.647083524965;16314.592135196597;17004.574885627833;17018.65962680752;17030;17035.23341449638;2136.6154092263387;2155.374941267031;2194.8902554872193;2197.121151539381;2219.966700499494;108247.45876270568;110479.44760276227;110828;112263.43868280607;112353;11211.159163062803;11361.54553817838;11417.714557136138;11618.825717614243;12079.51681932713;16483.752743708854;16485.58786030335;16492.25784839685;16493.6701265974;16498;8247.004662984418;8278.337732981467;8287.50274983503;8362.665493380196;8363.330933525303;7781.299683028441;7794.454388192772;7879;7898.526088434713;7916.564588947663;7515.135759387631;7563.281488258606;7571.167171611119;7595.848083038309;7744.6902123914415;2094.476380904774;2100.233414803616;2117.385958072173;2180.2805074325433;2192.1121945612053;898.2275243290765;935.5322338830584;942.79258563116;943.688582767685;981.548487695668;17985.820141798675;18466.907665461586;19475.026248687507;19767.604647906963;19795.10922008513;964.6382606522554;998.3959704378747;1001.244060734141;1002.8896821349646;1040.869891263592;9615.56729947154;11419.429028548539;12631.431585578672;13222.801657975138;13400.865991340157;425808;425878;430137;433325;435323;96430.51784741171;99963.50018249862;100396.49801751091;100454;100722;1207.927524348542;1214.423149004216;1249.5314257153568;1251.7809383357876;1262.5644152767281;17517.299308027537;19120.808791911903;19920.203191872162;20028.898410586975;20277.695834562197;48212.5178748222;48522.75738621284;49056.509434905194;49616.75191624019;50454.49545504498;62192.37807622047;62294.688526557075;62450.68774656098;62897.371026289155;62926.37073629388;9603.9039609603;9755.902440975784;9773.41359518431;9810.65662701802;9853.16248118918;13471.191728495929;14566.92716536453;14659.780103298246;14691.926540367658;16164.030158190546;11674.066074713832;11692.123090768056;11740.471678774646;12651.240925544496;12819.423125959167;11465.885341146482;11727.76544469123;11824.050651783991;12096.879031209575;13734.381952811947;12709.237445753284;12754.68113297175;13296.534621288209;13431.12697674648;13486.190828550318;9923.801523969336;9985.850212246967;10000.899990999997;10054.34646747959;10108;13812;13937.163770173822;13978.860211398163;14087.647808804451;14131.929340353232 10:01:53 INFO - PID 29315 | |3;mootools.html;1282.5959822655864;1332.8200692906462;1336.4186578838205;1345.1727187779506;1348.4538761801468;10193.286469947107;10581.84127238091;10589;11217.719557011078;11577.768444631103;11277.154213433983;11423.657290281284;11471.827922581148;11475.311481311106;11508.769824603503;2277.840551161415;2328.9184878529254;2336.9883150584224;2354.458474550854;2357.1867705641525;2266.909323627053;2346.7418583955837;2379.3456799380137;2380.500094980048;2389.0682633772844;2310.919117830876;2314.1553333033407;2318.0959425823944;2339.9298021059394;2349.447879748258;2269.3645779181857;2283.668868014145;2289.164454973939;2290.9541809163725;2303.8963246653775;2203.1848216159965;2246.3036458697857;2309.642005489135;2313.699219101523;2314.8148148148107;10510.159187265;10536.894631053668;10577.153827693843;10623.734406639818;10630.840537391869;6036.0945858121195;6307.716152773136;6329.810105696836;6347.143135676717;6349;3656.2504686539196;3664.285464334456;3666.046827824758;3731.3470142725187;3775.9811200944096;1268.7589358021946;1269.2384569258463;1287.710265190334;1290.8511424831906;1299.7010687541824;13843;14380.92809535956;15203.543893683096;15264.618384540365;15362.615934601612;5002.824901128443;5021.623378246573;5191.299174611455;5233.215017747292;5242.18746094356;12027.518899244107;12083.939580302042;12093.274403535816;12095.697607559705;12097.516099355928;6033.607815491979;6146.262448506119;6148.846278843064;6151.938480615226;6159.692015399212;5668.26312579362;5750.769969201185;5761.135829625506;5764.625299355613;5927.4665280125;4020.296448121567;4153.210889930964;4156.605122513356;4165.083681590046;4165.958340416618;1141.7488152606413;1170.8887655672697;1171.2328424881716;1182.2020136407891;1183.5325046606715;779.9883001754978;796.7092011415791;802.293981296467;805.8428606421809;808.2523665609287;6086.756529738849;6115.082737589397;6204.875902481925;6229.314775374705;6640.136782218281;954.6706386296717;963.1812958984807;973.6884197056874;978.5351957819978;1004.1314263162458;3686.5391826021746;3715;3735.9813200933822;3810.6760925321105;3925.6074392560517;13493.392797324144;13938.163710177421;14060.578182654537;14327.78508322376;14347.713045739027;13783.897288216918;14096.71806563863;14163.575092747235;14178.645533861736;14222.288885555681;7958.6418611162635;8126.593670316461;8130.024397072271;8139.226773456512;8198.262156405952;5994.790182343597;6273.3099359071375;6458.192725909262;6552.3447655234095;6601.9009714853355;11950.223235489666;12051.457684404048;12901.741965160832;12920.483180672667;13103.803442948172;12727.681807954505;12937.805932911202;12950.676233094247;13087;13131.75248351405;8111.594420278844;8270.131636178356;8355.874661880198;8403.873941890753;8407.369447291356;10001.849972250568;10219.386836789816;10233.846492302473;10247.077763001365;10318.845217321896;8590.441621294596;8634.654613815377;8692.91307086921;8800.647974080965;9029.413088149511;8466.322694184328;8480.830383392175;8494.91505084966;8638.56807159627;8779.165979231962;7108.253633368422;7262.709491620276;7293.927060729325;7294.890576641248;7313.268673132644;5495.890082198413;5505.449455054462;5580.274564306615;5589.608727389043;5839.795607153729;5689.687067211343;5751.7411716472025;5818.796342128006;5844;5874.383189765013 10:01:53 INFO - PID 29315 | |4;prototype.html;356.0830860534125;370.41104643616643;373.38018888644837;380.2547007864585;381.6279127850344;6187;6231.283402408724;6237.282712488065;6249.156363890874;6292.3707629237115;6077.781609712456;6102;6123.908141377872;6137.6317420954665;6141.600795948271;4565.7717114144325;4735.621150307967;4742.4824056301995;4748.691335063227;4767.880802979918;4737.40782402198;4739.834105806298;4760.285957106427;4774.928376074362;4786.808527658907;4651.88370290742;4662.463816661094;4675.672702910798;4678.994016286498;4682.344471773954;4695.859124226278;4699.201135806921;4708.835190768324;4709.764511774431;4718.457377401608;4082.8159833648206;4089.6728261739286;4099.241640296525;4104.897377565555;4106.342985122366;5996.4603185713495;6003.969980150115;6026.2165918430765;6061.363556826558;6078.665673387962;5332.373985689729;5370.194470829368;5390.649607775482;5408.8377348679605;5414.756335964852;6492.123563318939;6498.187726534184;6512.023196520512;6534.444572211368;6538.280789113193;4445.977770111161;4458.9331160032625;4467.994701192239;4476.731396116244;4477.328400739882;6424.357564243585;6838.350356716153;6911.136107986502;6928.861422771516;6946.235914049451;4538.411555955455;4554.908901821945;4561.338605902126;4567.086582683477;4588.564086411786;4581.679282450196;4612.331211974312;4619.214733495314;4622.2835460503675;4629.444466663955;5194.7922083116255;5389.326334208224;5389.407165211824;5396.244525766396;5401.135818269058;6557.934420655828;6559.16343423842;6561.130077927768;6567.113439685677;6571.80284591463;1598.3366902735468;1614.8465895739887;1614.9434769783002;1619.3279788887714;1620.424749214012;1018.2668478695327;1065.9893401066045;1080.378782200238;1082.1018554599664;1088.9782204355868;5803.82588522345;5817.680027598522;5849.327327357409;5856.912146317809;5881.9705901470215;6749.493787965824;6776.424003959719;6784.423324017415;6789.422899053636;6859.794206173823;5785.971070144707;5822.184894114827;5824.912626310609;5836.387179346192;5872.0898260769645;3582.3193593217206;3608.855645774192;3623.695469630931;3629.274145170976;3650.8357123928954;6506.837329066811;6528.445082167974;6571.211454625475;6593.14289142418;6614.735410583523;6931.920423872818;6934.410575101072;6952.930470695228;6981.726653915127;6987.196472405739;6480.967595161994;6506.869862602722;6585.440237579764;6587.901181482186;6592.406683398517;6724.630145341857;6773;6777.864442711217;6780.288069752605;6790.660466976533;6675.632840193836;6676.76631317921;6716.227633821977;6731.394174524316;6753.459723222032;6212.161358216583;6499.545031847725;6529.771457998947;6551.50863685216;6569.408753212234;4544.931826022546;4568.132054909556;4573.153966516205;4573.507438445989;4574.4510658721165;6728;6748.932510675027;6771.864562708817;6799.796006119825;6842.384185423336;6287.622742635456;6561.901571476336;6563.7702680405955;6569.5035886362875;6618.172728408949;6566.376194261537;6583.572067815577;6587.769428069994;6598.406143447113;6611.173603299588;6492.5455218134275;6532;6551;6568.244651864906;6570.441512471493;6596.472282217507;6623.768168114093;6667.799966001027;6684.030815531623;6689.163854518185;6430.7749228776765;6440.645764482999;6443.874720760334;6459.709313081016;6465.741370345134 10:01:53 INFO - PID 29315 | |5;yui.html;819.2135549872122;823.2919689067405;843.9578021098947;853.6542700206414;864.0581765875195;16325.836741632595;16864.83135168648;16983.91508042458;17052.658946821055;20338.491537711565;18886.43340699781;18945;19212.32756853507;19220.231190752387;19226.230950761987;950.904909509047;992.7964767222738;994.8259054665441;997.8154041502308;1001.4542074569378;972.1493693018608;982.6609819612258;983;985.1773768902974;1000.5047501486774;1049.2812423489895;1052.6736711619421;1054.9261551691384;1058.8358804385293;1059.7191744187796;1039.2050081687514;1039.9116075133622;1045.372776334201;1047.8061558611605;1052.079430498314;764.5947647746704;767.1446337333832;768.4352001279055;769.9730509432198;769.9807504812369;16982.660346792996;17045.7443138353;17203.827961720348;17224.052677102754;18228.36200732981;18621.906890465598;18987.145578449003;19063.90468047651;19087.61824763497;19249.13378897953;14735.410583576644;14886.776698349533;14917.925410372987;14935.925320373328;14975.1014939104;3445.1214940190093;3486.250456151914;3489.3893568625645;3511.5961664408665;3534.9823250883837;95136.52431737797;95890.9999999993;96993.51503242509;97159.51420242924;98538;14819.40722371093;15074.397024119131;15177.24113794306;15214;15399.307031183624;26862.328441788723;28194.71805281962;28346.574801377996;28355.14934551967;28434.146975590764;7897.921020789833;8117.47236429642;8449.704260350858;8472.915270847336;8492.915070849336;3955.604439556079;4013.478247827764;4038.394240863894;4046;4075.3683179107284;4316.892077698083;4390.8024138913825;4398.8020539075815;4435.35687325336;4437.5784300491405;857.7255278311005;866.358894418126;880.9735707928772;882.7131182365757;886.8935727712586;685.2907241005536;697.8988046733297;708.8050786033882;715.6815217228284;721.570665454054;9895.158911492459;10665.146788256921;10746.78506429867;11216.831747523795;11353.489092990836;691.6645426967916;693.7987983484834;694.4826104552141;722.2163952112018;727.287258486686;4509.233430316854;4754.595859351994;4763.833265835679;4957.900841983213;5023.723695196726;90650;91870;92425.53787231156;92509;92988;79438.6028069856;80185;81018.5949070251;81513;82226.58886705528;69757;71371;71722.2827771726;71764;72537;9613.471259080537;10188.388696678223;10254.6410875619;10398.844017339594;10401.947990260303;28869.855650721613;29183.708162918098;29474.115776526738;29723.85138074296;30184.24539386533;37673.811630942764;37776.62223377731;37911.43132852954;38207.235855283296;38484.615153848106;14310.85689143137;14720.263986800832;14751.92624036873;14818.110913345234;14975.1014939104;17451.650966980844;18226.817731822513;18707.919364302517;18784.436466906016;19203.423897283104;16709.8096047176;17271.91364043222;17310.65378692394;17339.393121240697;17539.123043847503;17510;17515.21181546808;17694.8498347607;17738.5565360867;18172.636547268718;16105.436309729103;17329.566760830578;17366.218520166876;17627.55931101733;17805.376811811526;10060.295779295378;10143.34068285559;10285.9485702571;10534;10930.070943969533;12378.62864114078;13015.544455943997;13028.218306901616;13142.40859161321;13148.276844773629 10:01:53 INFO - PID 29315 | __end_tp_report 10:01:53 INFO - PID 29315 | __start_cc_report 10:01:53 INFO - PID 29315 | _x_x_mozilla_cycle_collect,380 10:01:53 INFO - PID 29315 | __end_cc_report 10:01:53 INFO - PID 29315 | __startTimestamp1496682113424__endTimestamp 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | ------- Summary: start ------- 10:01:53 INFO - PID 29315 | Number of tests: 6 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | [#0] dojo.html Cycles:165 Average:5982.63 Median:6203.97 stddev:684.98 (11.0%) stddev-sans-first:648.24 10:01:53 INFO - PID 29315 | Values: 3084.2 3093.0 3111.5 3128.3 3139.1 5949.7 5980.2 6026.6 6029.1 6036.8 5933.7 5958.0 5976.1 5978.9 6036.8 5497.0 5610.8 5620.9 5625.0 5643.0 5451.9 5608.7 5630.5 5656.9 5657.7 5567.2 5655.6 5671.3 5690.5 5717.5 5468.6 5505.5 5522.2 5533.9 5574.9 5558.4 5561.4 5588.0 5609.1 5622.9 6012.5 6024.6 6040.7 6041.8 6046.4 6310.0 6446.1 6542.2 6551.1 6554.3 6459.5 6471.6 6516.1 6539.4 6561.5 6018.2 6020.6 6052.7 6066.2 6120.5 6487.7 6634.1 6687.2 6692.4 6709.3 6280.2 6284.0 6363.2 6364.4 6389.0 6524.3 6528.4 6530.8 6535.5 6555.5 6442.3 6478.5 6479.2 6494.0 6537.9 6230.8 6291.4 6340.3 6448.0 6474.4 5237.5 5309.7 5311.7 5357.7 5365.8 4533.9 4544.9 4576.4 4589.7 4596.7 5572.7 5655.8 5662.3 5666.7 5682.2 6562.9 6567.0 6610.1 6611.1 6611.8 5664.6 5681.3 5700.3 5701.8 5751.4 5622.1 5673.9 5736.7 5741.1 5751.7 6207.6 6304.4 6324.5 6330.5 6335.8 6438.2 6489.4 6532.3 6541.0 6572.8 6133.9 6204.0 6205.4 6298.5 6305.1 6283.8 6343.7 6387.2 6397.1 6403.1 6519.3 6542.1 6551.7 6553.5 6562.8 6151.5 6246.3 6305.5 6345.7 6361.2 6189.1 6272.3 6292.2 6299.8 6320.1 6249.0 6284.8 6312.3 6331.1 6338.6 6434.0 6441.0 6445.5 6448.3 6457.1 6048.3 6112.8 6122.7 6192.3 6222.9 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | [#1] ext.html Cycles:180 Average:35265.98 Median:33989.24 stddev:48795.11 (143.6%) stddev-sans-first:48863.08 10:01:53 INFO - PID 29315 | Values: 731.3 768.6 790.8 1141.7 1149.4 37543.4 38630.8 38634.2 38636.6 38808.2 40041.8 40462.4 40633.4 40688.4 40738.8 7269.2 7419.0 7452.6 7592.1 7592.7 7414.3 7472.4 7474.8 7482.6 7492.0 7501.7 7505.1 7555.8 7559.6 7561.5 7483.0 7504.9 7504.9 7508.3 7510.5 7323.1 7369.5 7381.4 7383.8 7414.6 35978.8 36227.1 36230.6 36243.3 36279.6 3352.9 3381.3 3386.7 3407.7 3407.8 27951.9 28022.3 28090.6 28135.7 28158.6 3637.3 3642.7 3644.9 3659.8 3660.2 167512.0 169172.0 176095.0 184474.0 184567.1 43688.3 43830.3 43885.3 43917.3 43997.1 45458.8 45719.0 45832.3 45921.5 45965.3 13820.6 13910.4 13948.7 13951.2 13976.9 11057.8 11209.3 11249.6 11253.8 11275.6 13507.5 13592.1 13603.6 13726.8 13844.7 5624.3 5674.1 5708.6 5744.0 5784.2 964.4 995.3 1002.4 1002.8 1011.2 21689.2 22437.4 22465.1 23022.5 23045.9 1066.7 1076.0 1081.5 1084.0 1084.2 11770.9 11997.1 12067.4 12354.2 12951.2 203470.0 205805.0 205889.0 206796.0 206805.0 49817.5 50116.5 50167.5 50275.7 50303.7 1398.1 1425.7 1433.4 1440.1 1447.7 21156.6 22216.4 23424.4 23701.6 23894.2 36672.1 45483.8 46667.0 46724.0 46760.5 180641.0 182020.0 182255.0 182850.0 183367.0 32849.3 33930.0 34048.5 34248.9 34586.3 40085.6 41612.5 41839.6 43102.4 43298.6 30167.5 30936.4 30963.5 31564.0 32520.7 30064.5 30089.5 30523.4 31057.0 31775.0 33527.5 35313.1 35351.5 35373.1 35451.0 29071.0 29686.0 29902.6 30267.7 31418.7 21925.5 24243.5 24356.8 24485.0 24517.4 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | [#2] jquery.html Cycles:180 Average:29480.34 Median:2193.50 stddev:72220.18 (3292.5%) stddev-sans-first:72389.79 10:01:53 INFO - PID 29315 | Values: 409.2 415.8 418.6 425.1 439.1 14745.9 15288.5 20189.8 20692.9 20900.9 21263.4 22135.6 22262.2 22312.3 22342.1 5858.5 5863.1 5888.1 5907.5 6013.4 5815.6 5903.6 5911.9 5921.1 5928.9 5583.2 5870.4 5877.7 5881.9 5900.1 5859.3 5884.9 5894.2 5900.6 5907.7 5278.1 5290.2 5317.3 5319.7 5335.9 24532.8 24886.6 24896.9 24897.1 24961.4 1919.8 1950.3 1958.4 1960.2 1960.6 16314.6 17004.6 17018.7 17030.0 17035.2 2136.6 2155.4 2194.9 2197.1 2220.0 108247.5 110479.4 110828.0 112263.4 112353.0 11211.2 11361.5 11417.7 11618.8 12079.5 16483.8 16485.6 16492.3 16493.7 16498.0 8247.0 8278.3 8287.5 8362.7 8363.3 7781.3 7794.5 7879.0 7898.5 7916.6 7515.1 7563.3 7571.2 7595.8 7744.7 2094.5 2100.2 2117.4 2180.3 2192.1 898.2 935.5 942.8 943.7 981.5 17985.8 18466.9 19475.0 19767.6 19795.1 964.6 998.4 1001.2 1002.9 1040.9 9615.6 11419.4 12631.4 13222.8 13400.9 425808.0 425878.0 430137.0 433325.0 435323.0 96430.5 99963.5 100396.5 100454.0 100722.0 1207.9 1214.4 1249.5 1251.8 1262.6 17517.3 19120.8 19920.2 20028.9 20277.7 48212.5 48522.8 49056.5 49616.8 50454.5 62192.4 62294.7 62450.7 62897.4 62926.4 9603.9 9755.9 9773.4 9810.7 9853.2 13471.2 14566.9 14659.8 14691.9 16164.0 11674.1 11692.1 11740.5 12651.2 12819.4 11465.9 11727.8 11824.1 12096.9 13734.4 12709.2 12754.7 13296.5 13431.1 13486.2 9923.8 9985.9 10000.9 10054.3 10108.0 13812.0 13937.2 13978.9 14087.6 14131.9 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | [#3] mootools.html Cycles:180 Average:6685.72 Median:3022.66 stddev:4229.45 (139.9%) stddev-sans-first:4221.83 10:01:53 INFO - PID 29315 | Values: 1282.6 1332.8 1336.4 1345.2 1348.5 10193.3 10581.8 10589.0 11217.7 11577.8 11277.2 11423.7 11471.8 11475.3 11508.8 2277.8 2328.9 2337.0 2354.5 2357.2 2266.9 2346.7 2379.3 2380.5 2389.1 2310.9 2314.2 2318.1 2339.9 2349.4 2269.4 2283.7 2289.2 2291.0 2303.9 2203.2 2246.3 2309.6 2313.7 2314.8 10510.2 10536.9 10577.2 10623.7 10630.8 6036.1 6307.7 6329.8 6347.1 6349.0 3656.3 3664.3 3666.0 3731.3 3776.0 1268.8 1269.2 1287.7 1290.9 1299.7 13843.0 14380.9 15203.5 15264.6 15362.6 5002.8 5021.6 5191.3 5233.2 5242.2 12027.5 12083.9 12093.3 12095.7 12097.5 6033.6 6146.3 6148.8 6151.9 6159.7 5668.3 5750.8 5761.1 5764.6 5927.5 4020.3 4153.2 4156.6 4165.1 4166.0 1141.7 1170.9 1171.2 1182.2 1183.5 780.0 796.7 802.3 805.8 808.3 6086.8 6115.1 6204.9 6229.3 6640.1 954.7 963.2 973.7 978.5 1004.1 3686.5 3715.0 3736.0 3810.7 3925.6 13493.4 13938.2 14060.6 14327.8 14347.7 13783.9 14096.7 14163.6 14178.6 14222.3 7958.6 8126.6 8130.0 8139.2 8198.3 5994.8 6273.3 6458.2 6552.3 6601.9 11950.2 12051.5 12901.7 12920.5 13103.8 12727.7 12937.8 12950.7 13087.0 13131.8 8111.6 8270.1 8355.9 8403.9 8407.4 10001.8 10219.4 10233.8 10247.1 10318.8 8590.4 8634.7 8692.9 8800.6 9029.4 8466.3 8480.8 8494.9 8638.6 8779.2 7108.3 7262.7 7293.9 7294.9 7313.3 5495.9 5505.4 5580.3 5589.6 5839.8 5689.7 5751.7 5818.8 5844.0 5874.4 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | [#4] prototype.html Cycles:180 Average:5412.68 Median:6090.33 stddev:1629.42 (26.8%) stddev-sans-first:1589.18 10:01:53 INFO - PID 29315 | Values: 356.1 370.4 373.4 380.3 381.6 6187.0 6231.3 6237.3 6249.2 6292.4 6077.8 6102.0 6123.9 6137.6 6141.6 4565.8 4735.6 4742.5 4748.7 4767.9 4737.4 4739.8 4760.3 4774.9 4786.8 4651.9 4662.5 4675.7 4679.0 4682.3 4695.9 4699.2 4708.8 4709.8 4718.5 4082.8 4089.7 4099.2 4104.9 4106.3 5996.5 6004.0 6026.2 6061.4 6078.7 5332.4 5370.2 5390.6 5408.8 5414.8 6492.1 6498.2 6512.0 6534.4 6538.3 4446.0 4458.9 4468.0 4476.7 4477.3 6424.4 6838.4 6911.1 6928.9 6946.2 4538.4 4554.9 4561.3 4567.1 4588.6 4581.7 4612.3 4619.2 4622.3 4629.4 5194.8 5389.3 5389.4 5396.2 5401.1 6557.9 6559.2 6561.1 6567.1 6571.8 1598.3 1614.8 1614.9 1619.3 1620.4 1018.3 1066.0 1080.4 1082.1 1089.0 5803.8 5817.7 5849.3 5856.9 5882.0 6749.5 6776.4 6784.4 6789.4 6859.8 5786.0 5822.2 5824.9 5836.4 5872.1 3582.3 3608.9 3623.7 3629.3 3650.8 6506.8 6528.4 6571.2 6593.1 6614.7 6931.9 6934.4 6952.9 6981.7 6987.2 6481.0 6506.9 6585.4 6587.9 6592.4 6724.6 6773.0 6777.9 6780.3 6790.7 6675.6 6676.8 6716.2 6731.4 6753.5 6212.2 6499.5 6529.8 6551.5 6569.4 4544.9 4568.1 4573.2 4573.5 4574.5 6728.0 6748.9 6771.9 6799.8 6842.4 6287.6 6561.9 6563.8 6569.5 6618.2 6566.4 6583.6 6587.8 6598.4 6611.2 6492.5 6532.0 6551.0 6568.2 6570.4 6596.5 6623.8 6667.8 6684.0 6689.2 6430.8 6440.6 6443.9 6459.7 6465.7 10:01:53 INFO - PID 29315 | 10:01:53 INFO - PID 29315 | [#5] yui.html Cycles:180 Average:19508.36 Median:29026.78 stddev:25227.00 (86.9%) stddev-sans-first:25258.73 10:01:53 INFO - PID 29315 | Values: 819.2 823.3 844.0 853.7 864.1 16325.8 16864.8 16983.9 17052.7 20338.5 18886.4 18945.0 19212.3 19220.2 19226.2 950.9 992.8 994.8 997.8 1001.5 972.1 982.7 983.0 985.2 1000.5 1049.3 1052.7 1054.9 1058.8 1059.7 1039.2 1039.9 1045.4 1047.8 1052.1 764.6 767.1 768.4 770.0 770.0 16982.7 17045.7 17203.8 17224.1 18228.4 18621.9 18987.1 19063.9 19087.6 19249.1 14735.4 14886.8 14917.9 14935.9 14975.1 3445.1 3486.3 3489.4 3511.6 3535.0 95136.5 95891.0 96993.5 97159.5 98538.0 14819.4 15074.4 15177.2 15214.0 15399.3 26862.3 28194.7 28346.6 28355.1 28434.1 7897.9 8117.5 8449.7 8472.9 8492.9 3955.6 4013.5 4038.4 4046.0 4075.4 4316.9 4390.8 4398.8 4435.4 4437.6 857.7 866.4 881.0 882.7 886.9 685.3 697.9 708.8 715.7 721.6 9895.2 10665.1 10746.8 11216.8 11353.5 691.7 693.8 694.5 722.2 727.3 4509.2 4754.6 4763.8 4957.9 5023.7 90650.0 91870.0 92425.5 92509.0 92988.0 79438.6 80185.0 81018.6 81513.0 82226.6 69757.0 71371.0 71722.3 71764.0 72537.0 9613.5 10188.4 10254.6 10398.8 10401.9 28869.9 29183.7 29474.1 29723.9 30184.2 37673.8 37776.6 37911.4 38207.2 38484.6 14310.9 14720.3 14751.9 14818.1 14975.1 17451.7 18226.8 18707.9 18784.4 19203.4 16709.8 17271.9 17310.7 17339.4 17539.1 17510.0 17515.2 17694.8 17738.6 18172.6 16105.4 17329.6 17366.2 17627.6 17805.4 10060.3 10143.3 10285.9 10534.0 10930.1 12378.6 13015.5 13028.2 13142.4 13148.3 10:01:53 INFO - PID 29315 | -------- Summary: end -------- 10:01:53 INFO - PID 29315 | 10:01:54 INFO - TEST-INFO | 29315: exit 0 10:01:54 INFO - TEST-OK | dromaeo_css | took 1143119ms 10:01:54 INFO - TEST-START | kraken 10:01:54 INFO - operating with platform_type : linux_ 10:01:54 INFO - Initialising browser for kraken test... 10:01:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51449/getInfo.html -profile /tmp/tmpc07o8z/profile 10:01:54 INFO - TEST-INFO | started process 29737 (/builds/slave/test/build/application/firefox/firefox http://localhost:51449/getInfo.html) 10:02:28 INFO - TEST-INFO | 29737: killed by SIGTERM 10:02:28 INFO - Browser initialized. 10:02:28 INFO - Running cycle 1/1 for kraken test... 10:02:28 INFO - TEST-INFO | started process 29966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc07o8z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:40 INFO - PID 29966 | RSS: Main: 191475712 10:02:40 INFO - PID 29966 | 10:02:43 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51449/tests/kraken/driver.html?testName=audio-beat-detection) 10:02:44 INFO - PID 29966 | RSS: Main: 195788800 10:02:44 INFO - PID 29966 | 10:02:46 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51449/tests/kraken/driver.html?testName=audio-dft) 10:02:47 INFO - PID 29966 | RSS: Main: 194101248 10:02:47 INFO - PID 29966 | 10:02:50 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51449/tests/kraken/driver.html?testName=audio-fft) 10:02:51 INFO - PID 29966 | RSS: Main: 189960192 10:02:51 INFO - PID 29966 | 10:02:53 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51449/tests/kraken/driver.html?testName=audio-oscillator) 10:02:53 INFO - PID 29966 | RSS: Main: 190689280 10:02:53 INFO - PID 29966 | 10:02:55 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51449/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:02:56 INFO - PID 29966 | RSS: Main: 190877696 10:02:56 INFO - PID 29966 | 10:02:59 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51449/tests/kraken/driver.html?testName=imaging-darkroom) 10:03:00 INFO - PID 29966 | RSS: Main: 191729664 10:03:00 INFO - PID 29966 | 10:03:03 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51449/tests/kraken/driver.html?testName=imaging-desaturate) 10:03:04 INFO - PID 29966 | RSS: Main: 190623744 10:03:04 INFO - PID 29966 | 10:03:07 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51449/tests/kraken/driver.html?testName=json-parse-financial) 10:03:07 INFO - PID 29966 | RSS: Main: 191651840 10:03:07 INFO - PID 29966 | 10:03:09 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51449/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:03:10 INFO - PID 29966 | RSS: Main: 191676416 10:03:10 INFO - PID 29966 | 10:03:11 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:03:12 INFO - PID 29966 | RSS: Main: 191307776 10:03:12 INFO - PID 29966 | 10:03:14 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:03:15 INFO - PID 29966 | RSS: Main: 192167936 10:03:15 INFO - PID 29966 | 10:03:18 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:03:18 INFO - PID 29966 | RSS: Main: 192057344 10:03:18 INFO - PID 29966 | 10:03:22 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:03:22 INFO - PID 29966 | RSS: Main: 191827968 10:03:22 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | Cycle 1(1): loaded http://localhost:51449/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51449/tests/kraken/driver.html?testName=ai-astar) 10:03:24 INFO - PID 29966 | RSS: Main: 193298432 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | __start_tp_report 10:03:24 INFO - PID 29966 | _x_x_mozilla_page_load 10:03:24 INFO - PID 29966 | _x_x_mozilla_page_load_details 10:03:24 INFO - PID 29966 | |i|pagename|runs| 10:03:24 INFO - PID 29966 | |0;ai-astar;103;119;110;112;110;109;111;110;109;110 10:03:24 INFO - PID 29966 | |1;audio-beat-detection;164;121;126;175;122;128;127;121;143;120 10:03:24 INFO - PID 29966 | |2;audio-dft;163;165;162;165;167;169;174;166;174;164 10:03:24 INFO - PID 29966 | |3;audio-fft;74;78;73;112;74;76;76;75;98;74 10:03:24 INFO - PID 29966 | |4;audio-oscillator;83;81;97;88;86;86;95;82;82;102 10:03:24 INFO - PID 29966 | |5;imaging-gaussian-blur;114;115;115;114;114;113;114;114;114;116 10:03:24 INFO - PID 29966 | |6;imaging-darkroom;152;150;151;152;153;152;150;155;155;154 10:03:24 INFO - PID 29966 | |7;imaging-desaturate;95;95;96;94;95;95;94;94;94;94 10:03:24 INFO - PID 29966 | |8;json-parse-financial;57;54;54;56;54;54;56;64;54;58 10:03:24 INFO - PID 29966 | |9;json-stringify-tinderbox;55;56;56;57;57;57;57;57;56;55 10:03:24 INFO - PID 29966 | |10;stanford-crypto-aes;87;87;87;86;89;88;88;88;108;97 10:03:24 INFO - PID 29966 | |11;stanford-crypto-ccm;134;135;140;131;132;133;130;133;141;132 10:03:24 INFO - PID 29966 | |12;stanford-crypto-pbkdf2;194;200;188;204;203;201;197;191;193;197 10:03:24 INFO - PID 29966 | |13;stanford-crypto-sha256-iterative;74;70;72;71;76;71;73;70;72;71 10:03:24 INFO - PID 29966 | __end_tp_report 10:03:24 INFO - PID 29966 | __start_cc_report 10:03:24 INFO - PID 29966 | _x_x_mozilla_cycle_collect,997 10:03:24 INFO - PID 29966 | __end_cc_report 10:03:24 INFO - PID 29966 | __startTimestamp1496682204704__endTimestamp 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | ------- Summary: start ------- 10:03:24 INFO - PID 29966 | Number of tests: 14 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:3.89 (3.5%) stddev-sans-first:3.10 10:03:24 INFO - PID 29966 | Values: 103.0 119.0 110.0 112.0 110.0 109.0 111.0 110.0 109.0 110.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:127.50 stddev:19.68 (15.4%) stddev-sans-first:17.78 10:03:24 INFO - PID 29966 | Values: 164.0 121.0 126.0 175.0 122.0 128.0 127.0 121.0 143.0 120.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.50 stddev:4.23 (2.5%) stddev-sans-first:4.24 10:03:24 INFO - PID 29966 | Values: 163.0 165.0 162.0 165.0 167.0 169.0 174.0 166.0 174.0 164.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:13.15 (17.4%) stddev-sans-first:13.70 10:03:24 INFO - PID 29966 | Values: 74.0 78.0 73.0 112.0 74.0 76.0 76.0 75.0 98.0 74.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:86.00 stddev:7.30 (8.5%) stddev-sans-first:7.50 10:03:24 INFO - PID 29966 | Values: 83.0 81.0 97.0 88.0 86.0 86.0 95.0 82.0 82.0 102.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:03:24 INFO - PID 29966 | Values: 114.0 115.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 116.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.50 stddev:1.84 (1.2%) stddev-sans-first:1.94 10:03:24 INFO - PID 29966 | Values: 152.0 150.0 151.0 152.0 153.0 152.0 150.0 155.0 155.0 154.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:03:24 INFO - PID 29966 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:3.14 (5.6%) stddev-sans-first:3.32 10:03:24 INFO - PID 29966 | Values: 57.0 54.0 54.0 56.0 54.0 54.0 56.0 64.0 54.0 58.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 10:03:24 INFO - PID 29966 | Values: 55.0 56.0 56.0 57.0 57.0 57.0 57.0 57.0 56.0 55.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:6.88 (7.8%) stddev-sans-first:7.18 10:03:24 INFO - PID 29966 | Values: 87.0 87.0 87.0 86.0 89.0 88.0 88.0 88.0 108.0 97.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:133.50 stddev:3.67 (2.7%) stddev-sans-first:3.89 10:03:24 INFO - PID 29966 | Values: 134.0 135.0 140.0 131.0 132.0 133.0 130.0 133.0 141.0 132.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.80 Median:198.50 stddev:5.29 (2.7%) stddev-sans-first:5.51 10:03:24 INFO - PID 29966 | Values: 194.0 200.0 188.0 204.0 203.0 201.0 197.0 191.0 193.0 197.0 10:03:24 INFO - PID 29966 | 10:03:24 INFO - PID 29966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.89 (2.6%) stddev-sans-first:1.86 10:03:24 INFO - PID 29966 | Values: 74.0 70.0 72.0 71.0 76.0 71.0 73.0 70.0 72.0 71.0 10:03:24 INFO - PID 29966 | -------- Summary: end -------- 10:03:24 INFO - PID 29966 | 10:03:25 INFO - TEST-INFO | 29966: exit 0 10:03:25 INFO - TEST-OK | kraken | took 91578ms 10:03:25 INFO - SUITE-END | took 1234s 10:03:26 INFO - Completed test suite (00:20:35) 10:03:26 INFO - javascript benchmark 10:03:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7628.947115567221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.244360131768, 3092.9638571078685, 3111.4866047102228, 3128.3117714102905, 3139.105354973832, 5949.7025148742605, 5980.1926739890105, 6026.578139530235, 6029.065494848294, 6036.818895433138, 5933.7033148342625, 5958.0, 5976.073708575178, 5978.850528736783, 6036.8490787730325, 5497.0, 5610.803621873235, 5620.932022915643, 5625.0, 5642.971785141069, 5451.863703407407, 5608.691521966311, 5630.493255606994, 5656.943430565703, 5657.717114144297, 5567.248421463091, 5655.57583181261, 5671.291088613923, 5690.5447564194765, 5717.456841600062, 5468.589855760833, 5505.504504594605, 5522.199281104217, 5533.916991245134, 5574.944250557523, 5558.360788509332, 5561.360443549003, 5588.0, 5609.130584759328, 5622.91565626516, 6012.458878700938, 6024.608400453956, 6040.667763273018, 6041.8187454376, 6046.365131661156, 6310.0, 6446.129772480702, 6542.214934207926, 6551.0500977358015, 6554.344565543455, 6459.5478316517865, 6471.611703297817, 6516.0877477153235, 6539.378759017934, 6561.540692151551, 6018.1574579558455, 6020.571200319588, 6052.727627256784, 6066.211392518989, 6120.479759220516, 6487.7080531376205, 6634.13756211699, 6687.230968438595, 6692.364225398579, 6709.29552397001, 6280.214973128359, 6283.96858015707, 6363.236411630634, 6364.395382438661, 6389.0, 6524.347565243438, 6528.445082167974, 6530.771423000172, 6535.542512024208, 6555.508336874754, 6442.323556026643, 6478.514111441661, 6479.222493300834, 6493.967530162414, 6537.901931471032, 6230.813075607739, 6291.433770960635, 6340.334264902119, 6448.0, 6474.417302442708, 5237.528622424, 5309.65487243328, 5311.7344132793205, 5357.651752636066, 5365.839024829262, 4533.863984080483, 4544.863654090383, 4576.382188404589, 4589.655775816827, 4596.678232523691, 5572.693501857356, 5655.802046928337, 5662.292213473316, 5666.660000399989, 5682.176084467729, 6562.934370656232, 6567.0, 6610.0745895574655, 6611.140551728245, 6611.834704132339, 5664.631798933056, 5681.34664513578, 5700.315962084576, 5701.771929122871, 5751.367349591542, 5622.072358060956, 5673.886522269531, 5736.655800651891, 5741.052726300197, 5751.683657398883, 6207.565470417027, 6304.401081897304, 6324.462420694293, 6330.49356051524, 6335.841603959938, 6438.163038804925, 6489.448396886318, 6532.281449040506, 6540.953447448385, 6572.80281591553, 6133.946794548733, 6203.96898015507, 6205.410486003822, 6298.496120310272, 6305.148804911279, 6283.7800676976085, 6343.746250150127, 6387.201599800025, 6397.136386587751, 6403.135576697273, 6519.250286217146, 6542.1168142300185, 6551.672416379257, 6553.541252112306, 6562.80311590653, 6151.50787936955, 6246.281677607133, 6305.464035557029, 6345.7144428499905, 6361.236651601837, 6189.071639254148, 6272.341404152681, 6292.1505596743855, 6299.811005669837, 6320.083587879823, 6249.031400132987, 6284.780032698834, 6312.2740884796995, 6331.113644089739, 6338.619682819046, 6434.0, 6440.967795161182, 6445.5165862561435, 6448.290688024407, 6457.0637257596445, 6048.304444988707, 6112.837854638657, 6122.733612273432, 6192.287886892885, 6222.937770622236], "value": 5932.725425574796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.3162193349219, 768.6118510152372, 790.7706765038138, 1141.6632093532412, 1149.4080548517509, 37543.43684844726, 38630.806845965766, 38634.227315453674, 38636.61363386365, 38808.223835523306, 40041.799791001, 40462.393064104064, 40633.39049914254, 40688.38967415491, 40738.7963060185, 7269.236730143338, 7418.96290518548, 7452.55284682918, 7592.050993625797, 7592.658330375147, 7414.332710056094, 7472.4395670324675, 7474.813129671747, 7482.588457634828, 7491.962540187292, 7501.66242519088, 7505.061867266591, 7555.773326800205, 7559.62201889906, 7561.508501947384, 7483.027206463179, 7504.887426688604, 7504.887426688604, 7508.286712762333, 7510.460355627083, 7323.084614423197, 7369.520981136263, 7381.409487241008, 7383.8154046149275, 7414.555126692416, 35978.82010589956, 36227.09432264188, 36230.63769362299, 36243.275134497424, 36279.63720362789, 3352.932941341184, 3381.2899291148888, 3386.7121294689982, 3407.7444191685477, 3407.812570308632, 27951.86024069887, 28022.299442513897, 28090.578641320397, 28135.718642813514, 28158.577621335695, 3637.290728307981, 3642.690371318441, 3644.927101457956, 3659.835307411173, 3660.249648821985, 167512.0, 169172.0, 176095.0, 184474.0, 184567.07716461466, 43688.3446748299, 43830.34254486185, 43885.341719874225, 43917.29075220201, 43997.120057598666, 45458.77270613626, 45719.0, 45832.3125153123, 45921.5407845924, 45965.310520342224, 13820.585382438543, 13910.374033168531, 13948.651283717785, 13951.162930224218, 13976.860231397759, 11057.834132488018, 11209.271397359309, 11249.550017999352, 11253.831192532118, 11275.605353812742, 13507.527236546674, 13592.11651242666, 13603.591892243248, 13726.794098088536, 13844.723105537832, 5624.325080990226, 5674.0565307111165, 5708.600397972102, 5744.034100835048, 5784.21913041734, 964.4117088575963, 995.2833959549113, 1002.4486532407293, 1002.8144793213279, 1011.2163073617858, 21689.240876569245, 22437.43906402353, 22465.10139594398, 23022.539549208923, 23045.884770576038, 1066.722652110457, 1076.0, 1081.491698901515, 1083.9566417343217, 1084.2139448899484, 11770.882291176978, 11997.10075856878, 12067.396630168456, 12354.208639747187, 12951.222926624432, 203470.0, 205805.0, 205889.0, 206796.0, 206805.0, 49817.50182498201, 50116.49883501118, 50167.49832501701, 50275.74862125666, 50303.74848125736, 1398.1471302505463, 1425.6863490032176, 1433.3621538415514, 1440.0567628203544, 1447.7249322628668, 21156.576868462853, 22216.444588885406, 23424.414389640395, 23701.644475332538, 23894.163704270268, 36672.08319792026, 45483.77258113688, 46667.0, 46724.0, 46760.53239467562, 180641.0, 182020.0, 182255.0, 182850.0, 183367.0, 32849.34301314008, 33930.0, 34048.48927266143, 34248.91759741635, 34586.30827383488, 40085.599144008185, 41612.50324980511, 41839.58160418357, 43102.35346469743, 43298.567014330714, 30167.547486787276, 30936.381272374878, 30963.535546966363, 31564.0, 32520.67479325271, 30064.549031764105, 30089.54865676973, 30523.389532209676, 31057.0, 31775.0, 33527.49708754322, 35313.1171720709, 35351.46972795359, 35373.115672108404, 35451.0, 29071.0, 29686.0, 29902.551461728526, 30267.69732302649, 31418.685813141576, 21925.451863703536, 24243.51512969766, 24356.75643243545, 24485.0, 24517.387065322797], "value": 16363.17038333862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.1693861461235, 415.7775590059318, 418.5814185814186, 425.08606496033525, 439.08450879915375, 14745.852541474582, 15288.464903728373, 20189.798102018976, 20692.89653551732, 20900.89549552252, 21263.36209913701, 22135.57288542294, 22262.220822271225, 22312.330630081124, 22342.10631574739, 5858.472737453618, 5863.061910094386, 5888.087346461305, 5907.468327850493, 6013.398660133996, 5815.563832712563, 5903.616264942786, 5911.852203694921, 5921.141434491996, 5928.87351403232, 5583.162525621149, 5870.412958704117, 5877.706114694248, 5881.8823623527505, 5900.055991041434, 5859.326177489579, 5884.882302353972, 5894.204282421882, 5900.557458190653, 5907.704614769265, 5278.1291086970605, 5290.1800220965815, 5317.308749862532, 5319.680819150824, 5335.9466405336225, 24532.754672453226, 24886.626700599507, 24896.875515622305, 24897.128600498894, 24961.375965600822, 1919.8368138708227, 1950.2589016173904, 1958.3831093205595, 1960.1865225931222, 1960.647083524965, 16314.592135196597, 17004.574885627833, 17018.65962680752, 17030.0, 17035.23341449638, 2136.6154092263387, 2155.374941267031, 2194.8902554872193, 2197.121151539381, 2219.966700499494, 108247.45876270568, 110479.44760276227, 110828.0, 112263.43868280607, 112353.0, 11211.159163062803, 11361.54553817838, 11417.714557136138, 11618.825717614243, 12079.51681932713, 16483.752743708854, 16485.58786030335, 16492.25784839685, 16493.6701265974, 16498.0, 8247.004662984418, 8278.337732981467, 8287.50274983503, 8362.665493380196, 8363.330933525303, 7781.299683028441, 7794.454388192772, 7879.0, 7898.526088434713, 7916.564588947663, 7515.135759387631, 7563.281488258606, 7571.167171611119, 7595.848083038309, 7744.6902123914415, 2094.476380904774, 2100.233414803616, 2117.385958072173, 2180.2805074325433, 2192.1121945612053, 898.2275243290765, 935.5322338830584, 942.79258563116, 943.688582767685, 981.548487695668, 17985.820141798675, 18466.907665461586, 19475.026248687507, 19767.604647906963, 19795.10922008513, 964.6382606522554, 998.3959704378747, 1001.244060734141, 1002.8896821349646, 1040.869891263592, 9615.56729947154, 11419.429028548539, 12631.431585578672, 13222.801657975138, 13400.865991340157, 425808.0, 425878.0, 430137.0, 433325.0, 435323.0, 96430.51784741171, 99963.50018249862, 100396.49801751091, 100454.0, 100722.0, 1207.927524348542, 1214.423149004216, 1249.5314257153568, 1251.7809383357876, 1262.5644152767281, 17517.299308027537, 19120.808791911903, 19920.203191872162, 20028.898410586975, 20277.695834562197, 48212.5178748222, 48522.75738621284, 49056.509434905194, 49616.75191624019, 50454.49545504498, 62192.37807622047, 62294.688526557075, 62450.68774656098, 62897.371026289155, 62926.37073629388, 9603.9039609603, 9755.902440975784, 9773.41359518431, 9810.65662701802, 9853.16248118918, 13471.191728495929, 14566.92716536453, 14659.780103298246, 14691.926540367658, 16164.030158190546, 11674.066074713832, 11692.123090768056, 11740.471678774646, 12651.240925544496, 12819.423125959167, 11465.885341146482, 11727.76544469123, 11824.050651783991, 12096.879031209575, 13734.381952811947, 12709.237445753284, 12754.68113297175, 13296.534621288209, 13431.12697674648, 13486.190828550318, 9923.801523969336, 9985.850212246967, 10000.899990999997, 10054.34646747959, 10108.0, 13812.0, 13937.163770173822, 13978.860211398163, 14087.647808804451, 14131.929340353232], "value": 10040.546968708197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.5959822655864, 1332.8200692906462, 1336.4186578838205, 1345.1727187779506, 1348.4538761801468, 10193.286469947107, 10581.84127238091, 10589.0, 11217.719557011078, 11577.768444631103, 11277.154213433983, 11423.657290281284, 11471.827922581148, 11475.311481311106, 11508.769824603503, 2277.840551161415, 2328.9184878529254, 2336.9883150584224, 2354.458474550854, 2357.1867705641525, 2266.909323627053, 2346.7418583955837, 2379.3456799380137, 2380.500094980048, 2389.0682633772844, 2310.919117830876, 2314.1553333033407, 2318.0959425823944, 2339.9298021059394, 2349.447879748258, 2269.3645779181857, 2283.668868014145, 2289.164454973939, 2290.9541809163725, 2303.8963246653775, 2203.1848216159965, 2246.3036458697857, 2309.642005489135, 2313.699219101523, 2314.8148148148107, 10510.159187265, 10536.894631053668, 10577.153827693843, 10623.734406639818, 10630.840537391869, 6036.0945858121195, 6307.716152773136, 6329.810105696836, 6347.143135676717, 6349.0, 3656.2504686539196, 3664.285464334456, 3666.046827824758, 3731.3470142725187, 3775.9811200944096, 1268.7589358021946, 1269.2384569258463, 1287.710265190334, 1290.8511424831906, 1299.7010687541824, 13843.0, 14380.92809535956, 15203.543893683096, 15264.618384540365, 15362.615934601612, 5002.824901128443, 5021.623378246573, 5191.299174611455, 5233.215017747292, 5242.18746094356, 12027.518899244107, 12083.939580302042, 12093.274403535816, 12095.697607559705, 12097.516099355928, 6033.607815491979, 6146.262448506119, 6148.846278843064, 6151.938480615226, 6159.692015399212, 5668.26312579362, 5750.769969201185, 5761.135829625506, 5764.625299355613, 5927.4665280125, 4020.296448121567, 4153.210889930964, 4156.605122513356, 4165.083681590046, 4165.958340416618, 1141.7488152606413, 1170.8887655672697, 1171.2328424881716, 1182.2020136407891, 1183.5325046606715, 779.9883001754978, 796.7092011415791, 802.293981296467, 805.8428606421809, 808.2523665609287, 6086.756529738849, 6115.082737589397, 6204.875902481925, 6229.314775374705, 6640.136782218281, 954.6706386296717, 963.1812958984807, 973.6884197056874, 978.5351957819978, 1004.1314263162458, 3686.5391826021746, 3715.0, 3735.9813200933822, 3810.6760925321105, 3925.6074392560517, 13493.392797324144, 13938.163710177421, 14060.578182654537, 14327.78508322376, 14347.713045739027, 13783.897288216918, 14096.71806563863, 14163.575092747235, 14178.645533861736, 14222.288885555681, 7958.6418611162635, 8126.593670316461, 8130.024397072271, 8139.226773456512, 8198.262156405952, 5994.790182343597, 6273.3099359071375, 6458.192725909262, 6552.3447655234095, 6601.9009714853355, 11950.223235489666, 12051.457684404048, 12901.741965160832, 12920.483180672667, 13103.803442948172, 12727.681807954505, 12937.805932911202, 12950.676233094247, 13087.0, 13131.75248351405, 8111.594420278844, 8270.131636178356, 8355.874661880198, 8403.873941890753, 8407.369447291356, 10001.849972250568, 10219.386836789816, 10233.846492302473, 10247.077763001365, 10318.845217321896, 8590.441621294596, 8634.654613815377, 8692.91307086921, 8800.647974080965, 9029.413088149511, 8466.322694184328, 8480.830383392175, 8494.91505084966, 8638.56807159627, 8779.165979231962, 7108.253633368422, 7262.709491620276, 7293.927060729325, 7294.890576641248, 7313.268673132644, 5495.890082198413, 5505.449455054462, 5580.274564306615, 5589.608727389043, 5839.795607153729, 5689.687067211343, 5751.7411716472025, 5818.796342128006, 5844.0, 5874.383189765013], "value": 5075.593932925238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.0830860534125, 370.41104643616643, 373.38018888644837, 380.2547007864585, 381.6279127850344, 6187.0, 6231.283402408724, 6237.282712488065, 6249.156363890874, 6292.3707629237115, 6077.781609712456, 6102.0, 6123.908141377872, 6137.6317420954665, 6141.600795948271, 4565.7717114144325, 4735.621150307967, 4742.4824056301995, 4748.691335063227, 4767.880802979918, 4737.40782402198, 4739.834105806298, 4760.285957106427, 4774.928376074362, 4786.808527658907, 4651.88370290742, 4662.463816661094, 4675.672702910798, 4678.994016286498, 4682.344471773954, 4695.859124226278, 4699.201135806921, 4708.835190768324, 4709.764511774431, 4718.457377401608, 4082.8159833648206, 4089.6728261739286, 4099.241640296525, 4104.897377565555, 4106.342985122366, 5996.4603185713495, 6003.969980150115, 6026.2165918430765, 6061.363556826558, 6078.665673387962, 5332.373985689729, 5370.194470829368, 5390.649607775482, 5408.8377348679605, 5414.756335964852, 6492.123563318939, 6498.187726534184, 6512.023196520512, 6534.444572211368, 6538.280789113193, 4445.977770111161, 4458.9331160032625, 4467.994701192239, 4476.731396116244, 4477.328400739882, 6424.357564243585, 6838.350356716153, 6911.136107986502, 6928.861422771516, 6946.235914049451, 4538.411555955455, 4554.908901821945, 4561.338605902126, 4567.086582683477, 4588.564086411786, 4581.679282450196, 4612.331211974312, 4619.214733495314, 4622.2835460503675, 4629.444466663955, 5194.7922083116255, 5389.326334208224, 5389.407165211824, 5396.244525766396, 5401.135818269058, 6557.934420655828, 6559.16343423842, 6561.130077927768, 6567.113439685677, 6571.80284591463, 1598.3366902735468, 1614.8465895739887, 1614.9434769783002, 1619.3279788887714, 1620.424749214012, 1018.2668478695327, 1065.9893401066045, 1080.378782200238, 1082.1018554599664, 1088.9782204355868, 5803.82588522345, 5817.680027598522, 5849.327327357409, 5856.912146317809, 5881.9705901470215, 6749.493787965824, 6776.424003959719, 6784.423324017415, 6789.422899053636, 6859.794206173823, 5785.971070144707, 5822.184894114827, 5824.912626310609, 5836.387179346192, 5872.0898260769645, 3582.3193593217206, 3608.855645774192, 3623.695469630931, 3629.274145170976, 3650.8357123928954, 6506.837329066811, 6528.445082167974, 6571.211454625475, 6593.14289142418, 6614.735410583523, 6931.920423872818, 6934.410575101072, 6952.930470695228, 6981.726653915127, 6987.196472405739, 6480.967595161994, 6506.869862602722, 6585.440237579764, 6587.901181482186, 6592.406683398517, 6724.630145341857, 6773.0, 6777.864442711217, 6780.288069752605, 6790.660466976533, 6675.632840193836, 6676.76631317921, 6716.227633821977, 6731.394174524316, 6753.459723222032, 6212.161358216583, 6499.545031847725, 6529.771457998947, 6551.50863685216, 6569.408753212234, 4544.931826022546, 4568.132054909556, 4573.153966516205, 4573.507438445989, 4574.4510658721165, 6728.0, 6748.932510675027, 6771.864562708817, 6799.796006119825, 6842.384185423336, 6287.622742635456, 6561.901571476336, 6563.7702680405955, 6569.5035886362875, 6618.172728408949, 6566.376194261537, 6583.572067815577, 6587.769428069994, 6598.406143447113, 6611.173603299588, 6492.5455218134275, 6532.0, 6551.0, 6568.244651864906, 6570.441512471493, 6596.472282217507, 6623.768168114093, 6667.799966001027, 6684.030815531623, 6689.163854518185, 6430.7749228776765, 6440.645764482999, 6443.874720760334, 6459.709313081016, 6465.741370345134], "value": 4888.86003806218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.2135549872122, 823.2919689067405, 843.9578021098947, 853.6542700206414, 864.0581765875195, 16325.836741632595, 16864.83135168648, 16983.91508042458, 17052.658946821055, 20338.491537711565, 18886.43340699781, 18945.0, 19212.32756853507, 19220.231190752387, 19226.230950761987, 950.904909509047, 992.7964767222738, 994.8259054665441, 997.8154041502308, 1001.4542074569378, 972.1493693018608, 982.6609819612258, 983.0, 985.1773768902974, 1000.5047501486774, 1049.2812423489895, 1052.6736711619421, 1054.9261551691384, 1058.8358804385293, 1059.7191744187796, 1039.2050081687514, 1039.9116075133622, 1045.372776334201, 1047.8061558611605, 1052.079430498314, 764.5947647746704, 767.1446337333832, 768.4352001279055, 769.9730509432198, 769.9807504812369, 16982.660346792996, 17045.7443138353, 17203.827961720348, 17224.052677102754, 18228.36200732981, 18621.906890465598, 18987.145578449003, 19063.90468047651, 19087.61824763497, 19249.13378897953, 14735.410583576644, 14886.776698349533, 14917.925410372987, 14935.925320373328, 14975.1014939104, 3445.1214940190093, 3486.250456151914, 3489.3893568625645, 3511.5961664408665, 3534.9823250883837, 95136.52431737797, 95890.9999999993, 96993.51503242509, 97159.51420242924, 98538.0, 14819.40722371093, 15074.397024119131, 15177.24113794306, 15214.0, 15399.307031183624, 26862.328441788723, 28194.71805281962, 28346.574801377996, 28355.14934551967, 28434.146975590764, 7897.921020789833, 8117.47236429642, 8449.704260350858, 8472.915270847336, 8492.915070849336, 3955.604439556079, 4013.478247827764, 4038.394240863894, 4046.0, 4075.3683179107284, 4316.892077698083, 4390.8024138913825, 4398.8020539075815, 4435.35687325336, 4437.5784300491405, 857.7255278311005, 866.358894418126, 880.9735707928772, 882.7131182365757, 886.8935727712586, 685.2907241005536, 697.8988046733297, 708.8050786033882, 715.6815217228284, 721.570665454054, 9895.158911492459, 10665.146788256921, 10746.78506429867, 11216.831747523795, 11353.489092990836, 691.6645426967916, 693.7987983484834, 694.4826104552141, 722.2163952112018, 727.287258486686, 4509.233430316854, 4754.595859351994, 4763.833265835679, 4957.900841983213, 5023.723695196726, 90650.0, 91870.0, 92425.53787231156, 92509.0, 92988.0, 79438.6028069856, 80185.0, 81018.5949070251, 81513.0, 82226.58886705528, 69757.0, 71371.0, 71722.2827771726, 71764.0, 72537.0, 9613.471259080537, 10188.388696678223, 10254.6410875619, 10398.844017339594, 10401.947990260303, 28869.855650721613, 29183.708162918098, 29474.115776526738, 29723.85138074296, 30184.24539386533, 37673.811630942764, 37776.62223377731, 37911.43132852954, 38207.235855283296, 38484.615153848106, 14310.85689143137, 14720.263986800832, 14751.92624036873, 14818.110913345234, 14975.1014939104, 17451.650966980844, 18226.817731822513, 18707.919364302517, 18784.436466906016, 19203.423897283104, 16709.8096047176, 17271.91364043222, 17310.65378692394, 17339.393121240697, 17539.123043847503, 17510.0, 17515.21181546808, 17694.8498347607, 17738.5565360867, 18172.636547268718, 16105.436309729103, 17329.566760830578, 17366.218520166876, 17627.55931101733, 17805.376811811526, 10060.295779295378, 10143.34068285559, 10285.9485702571, 10534.0, 10930.070943969533, 12378.62864114078, 13015.544455943997, 13028.218306901616, 13142.40859161321, 13148.276844773629], "value": 8150.513441871666, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 119.0, 110.0, 112.0, 110.0, 109.0, 111.0, 110.0, 109.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 121.0, 126.0, 175.0, 122.0, 128.0, 127.0, 121.0, 143.0, 120.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 165.0, 167.0, 169.0, 174.0, 166.0, 174.0, 164.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 73.0, 112.0, 74.0, 76.0, 76.0, 75.0, 98.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 97.0, 88.0, 86.0, 86.0, 95.0, 82.0, 82.0, 102.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 151.0, 152.0, 153.0, 152.0, 150.0, 155.0, 155.0, 154.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 56.0, 54.0, 54.0, 56.0, 64.0, 54.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 89.0, 88.0, 88.0, 88.0, 108.0, 97.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 140.0, 131.0, 132.0, 133.0, 130.0, 133.0, 141.0, 132.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 200.0, 188.0, 204.0, 203.0, 201.0, 197.0, 191.0, 193.0, 197.0], "value": 196.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 72.0, 71.0, 76.0, 71.0, 73.0, 70.0, 72.0, 71.0], "value": 72.0, "unit": "score"}]}]} 10:03:26 INFO - Return code: 0 10:03:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:03:26 INFO - # TBPL SUCCESS # 10:03:26 INFO - Running post-action listener: _resource_record_post_action 10:03:26 INFO - [mozharness: 2017-06-05 17:03:26.555572Z] Finished run-tests step (success) 10:03:26 INFO - Running post-run listener: _resource_record_post_run 10:03:26 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434233344; Read time: 20; Write time: 242256 10:03:26 INFO - TinderboxPrint: CPU usage
12.7% 10:03:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:03:26 INFO - TinderboxPrint: I/O write bytes / time
434,233,344 / 242,256 10:03:26 INFO - TinderboxPrint: CPU idle
8,731.4 (87.3%) 10:03:26 INFO - TinderboxPrint: CPU user
1,215.7 (12.2%) 10:03:26 INFO - TinderboxPrint: Swap in / out
0 / 0 10:03:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104280064; Read time: 0; Write time: 67348 10:03:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:03:26 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329953280; Read time: 20; Write time: 174908 10:03:27 INFO - Running post-run listener: _upload_blobber_files 10:03:27 INFO - Blob upload gear active. 10:03:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:03:27 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 10:03:27 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'] 10:03:27 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 10:03:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:03:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:03:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:28 INFO - (blobuploader) - INFO - Done attempting. 10:03:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:03:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:03:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:29 INFO - (blobuploader) - INFO - Done attempting. 10:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:03:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:03:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:36 INFO - (blobuploader) - INFO - Done attempting. 10:03:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:03:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:03:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:03:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:03:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:03:37 INFO - (blobuploader) - INFO - Done attempting. 10:03:37 INFO - (blobuploader) - INFO - Iteration through files over. 10:03:37 INFO - Return code: 0 10:03:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:03:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:03:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639cba94adf161d2e96b71472aa270ebb04c25891a0ef6c2c6017aa67aceb0ab911aa04119424ee5ec3febc58132b3251d6c6786040aa450975f2baa47ea28c7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/802603bbfe534f3ba9c893bfe1c4c5478922d1ae7050487e30dc5a893a5b62276885a48fd67fd36d514c628809ff4f4b3cb5026b99f4c5c0d3ca0f5d8ce52fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/035491298b035632c204e59233f3f8e71fc59f9435aecb11f2f1491f44a8aecd3dc5d428ffd26ac9d6271299229b4f7bd07b5ebc057f609e28e7d4e332b25077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25965a952e03b61619cf126c66aa6e5053d11359db8aac1d18d978f1000384e56a93a2dee6d12d44e564d70abddeaa3377ea3978722f14337d8c03f803bca70d"} 10:03:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:03:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:03:37 INFO - Contents: 10:03:37 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639cba94adf161d2e96b71472aa270ebb04c25891a0ef6c2c6017aa67aceb0ab911aa04119424ee5ec3febc58132b3251d6c6786040aa450975f2baa47ea28c7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/802603bbfe534f3ba9c893bfe1c4c5478922d1ae7050487e30dc5a893a5b62276885a48fd67fd36d514c628809ff4f4b3cb5026b99f4c5c0d3ca0f5d8ce52fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/035491298b035632c204e59233f3f8e71fc59f9435aecb11f2f1491f44a8aecd3dc5d428ffd26ac9d6271299229b4f7bd07b5ebc057f609e28e7d4e332b25077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25965a952e03b61619cf126c66aa6e5053d11359db8aac1d18d978f1000384e56a93a2dee6d12d44e564d70abddeaa3377ea3978722f14337d8c03f803bca70d"} 10:03:37 INFO - Running post-run listener: copy_logs_to_upload_dir 10:03:37 INFO - Copying logs to upload dir... 10:03:37 INFO - mkdir: /builds/slave/test/build/upload/logs 10:03:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.504574 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-05 10:03:36.417610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 10:03:36.422558) ========= 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=826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029 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/639cba94adf161d2e96b71472aa270ebb04c25891a0ef6c2c6017aa67aceb0ab911aa04119424ee5ec3febc58132b3251d6c6786040aa450975f2baa47ea28c7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/802603bbfe534f3ba9c893bfe1c4c5478922d1ae7050487e30dc5a893a5b62276885a48fd67fd36d514c628809ff4f4b3cb5026b99f4c5c0d3ca0f5d8ce52fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/035491298b035632c204e59233f3f8e71fc59f9435aecb11f2f1491f44a8aecd3dc5d428ffd26ac9d6271299229b4f7bd07b5ebc057f609e28e7d4e332b25077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25965a952e03b61619cf126c66aa6e5053d11359db8aac1d18d978f1000384e56a93a2dee6d12d44e564d70abddeaa3377ea3978722f14337d8c03f803bca70d"} build_url:https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/AHdxqNkdTG-2Uapx0N6E-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/639cba94adf161d2e96b71472aa270ebb04c25891a0ef6c2c6017aa67aceb0ab911aa04119424ee5ec3febc58132b3251d6c6786040aa450975f2baa47ea28c7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/802603bbfe534f3ba9c893bfe1c4c5478922d1ae7050487e30dc5a893a5b62276885a48fd67fd36d514c628809ff4f4b3cb5026b99f4c5c0d3ca0f5d8ce52fff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/035491298b035632c204e59233f3f8e71fc59f9435aecb11f2f1491f44a8aecd3dc5d428ffd26ac9d6271299229b4f7bd07b5ebc057f609e28e7d4e332b25077", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25965a952e03b61619cf126c66aa6e5053d11359db8aac1d18d978f1000384e56a93a2dee6d12d44e564d70abddeaa3377ea3978722f14337d8c03f803bca70d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 10:03:36.448236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 10:03:36.448607) ========= 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=826874ccc97bd7bf541b4875000001d5-1496680899.632409-1167359029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 10:03:36.530917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 10:03:36.534295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 10:03:36.534642) ========= ========= Total master_lag: 0.16 =========