builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1496162636.78 results: success (0) revision: c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.776168) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.776637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.776910) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.792476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.792810) ========= 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=df17445c3590ff7897617a0e00000225-1496162636.623193-963772990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 09:43:57-- 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% 223M=0s 2017-05-30 09:43:57 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109378 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.994080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:56.994429) ========= 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=df17445c3590ff7897617a0e00000225-1496162636.623193-963772990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017624 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:57.072380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 09:43:57.072775) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f --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 c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f --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=df17445c3590ff7897617a0e00000225-1496162636.623193-963772990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 09:43:57,653 truncating revision to first 12 chars 2017-05-30 09:43:57,653 Setting DEBUG logging. 2017-05-30 09:43:57,653 attempt 1/10 2017-05-30 09:43:57,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c3cd8c58fa87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 09:43:58,662 unpacking tar archive at: mozilla-central-c3cd8c58fa87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 09:43:58.409616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:58.409993) ========= script_repo_revision: c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:58.410415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:58.410687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 09:43:58.419460) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-30 09:43:58.419839) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=df17445c3590ff7897617a0e00000225-1496162636.623193-963772990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:59 INFO - MultiFileLogger online at 20170530 09:43:59 in /builds/slave/test 09:43:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:43:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:59 INFO - {'append_to_log': False, 09:43:59 INFO - 'base_work_dir': '/builds/slave/test', 09:43:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:43:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:59 INFO - 'branch': 'Firefox-Non-PGO', 09:43:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:59 INFO - 'config_files': ('talos/linux_config.py',), 09:43:59 INFO - 'default_actions': ('clobber', 09:43:59 INFO - 'read-buildbot-config', 09:43:59 INFO - 'download-and-extract', 09:43:59 INFO - 'populate-webroot', 09:43:59 INFO - 'create-virtualenv', 09:43:59 INFO - 'install', 09:43:59 INFO - 'setup-mitmproxy', 09:43:59 INFO - 'run-tests'), 09:43:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:59 INFO - 'download_minidump_stackwalk': True, 09:43:59 INFO - 'download_symbols': 'ondemand', 09:43:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:59 INFO - 'gecko_profile': False, 09:43:59 INFO - 'gecko_profile_interval': 0, 09:43:59 INFO - 'installer_path': 'installer.exe', 09:43:59 INFO - 'log_level': 'info', 09:43:59 INFO - 'log_name': 'talos', 09:43:59 INFO - 'log_to_console': True, 09:43:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:59 INFO - 'opt_config_files': (), 09:43:59 INFO - 'pip_index': False, 09:43:59 INFO - 'suite': 'dromaeojs-e10s', 09:43:59 INFO - 'system_bits': '32', 09:43:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:59 INFO - 'title': 'talos-linux64-ix-021', 09:43:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:59 INFO - 'use_talos_json': True, 09:43:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:59 INFO - 'work_dir': 'build'} 09:43:59 INFO - [mozharness: 2017-05-30 16:43:59.099611Z] Running clobber step. 09:43:59 INFO - Running pre-action listener: _resource_record_pre_action 09:43:59 INFO - Running main action method: clobber 09:43:59 INFO - rmtree: /builds/slave/test/build 09:43:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:00 INFO - Running post-action listener: _resource_record_post_action 09:44:00 INFO - [mozharness: 2017-05-30 16:44:00.132392Z] Finished clobber step (success) 09:44:00 INFO - [mozharness: 2017-05-30 16:44:00.132494Z] Running read-buildbot-config step. 09:44:00 INFO - Running pre-action listener: _resource_record_pre_action 09:44:00 INFO - Running main action method: read_buildbot_config 09:44:00 INFO - Using buildbot properties: 09:44:00 INFO - { 09:44:00 INFO - "project": "", 09:44:00 INFO - "product": "firefox", 09:44:00 INFO - "who": "ryanvm@gmail.com", 09:44:00 INFO - "installer_path": "public/build/target.tar.bz2", 09:44:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:44:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:44:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:44:00 INFO - "stage_platform": "linux64", 09:44:00 INFO - "basedir": "/builds/slave/test", 09:44:00 INFO - "buildnumber": 644, 09:44:00 INFO - "platform": "ubuntu64_hw", 09:44:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:44:00 INFO - "slavebuilddir": "test", 09:44:00 INFO - "taskId": "EqaPza7kQTGxuIqNX4UUpg", 09:44:00 INFO - "branch": "mozilla-central", 09:44:00 INFO - "script_repo_revision": "production", 09:44:00 INFO - "revision": "c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f", 09:44:00 INFO - "slavename": "talos-linux64-ix-021", 09:44:00 INFO - "repo_path": "mozilla-central" 09:44:00 INFO - } 09:44:00 INFO - Finding installer, test and symbols from parent task. 09:44:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EqaPza7kQTGxuIqNX4UUpg'}, attempt #1 09:44:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EqaPza7kQTGxuIqNX4UUpg'}, attempt #1 09:44:01 INFO - Task dependencies: VUV82kEoRCiyhq_AMZUJuw 09:44:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw'}, attempt #1 09:44:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2 09:44:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/test_packages.json 09:44:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.crashreporter-symbols.zip 09:44:01 INFO - Running post-action listener: _resource_record_post_action 09:44:01 INFO - [mozharness: 2017-05-30 16:44:01.502826Z] Finished read-buildbot-config step (success) 09:44:01 INFO - [mozharness: 2017-05-30 16:44:01.503090Z] Running download-and-extract step. 09:44:01 INFO - Running pre-action listener: _resource_record_pre_action 09:44:01 INFO - Running main action method: download_and_extract 09:44:01 INFO - mkdir: /builds/slave/test/build/tests 09:44:01 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:44:01 INFO - trying https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.test_packages.json 09:44:01 INFO - Downloading https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:44:02 INFO - Downloaded 986 bytes. 09:44:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:44:02 INFO - Using the following test package requirements: 09:44:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:44:02 INFO - u'common': [u'target.common.tests.zip'], 09:44:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:44:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:44:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:44:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:44:02 INFO - u'mozbase': [u'target.common.tests.zip'], 09:44:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:44:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:44:02 INFO - u'web-platform': [u'target.common.tests.zip', 09:44:02 INFO - u'target.web-platform.tests.zip'], 09:44:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:44:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:44:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.common.tests.zip 09:44:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:44:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.common.tests.zip into memory 09:44:03 INFO - Content-Length response header: 63528765 09:44:03 INFO - Bytes received: 63528765 09:44:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:44:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.common.tests.zip 09:44:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:44:14 INFO - Fetch https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.common.tests.zip into memory 09:44:15 INFO - Content-Length response header: 63528765 09:44:15 INFO - Bytes received: 63528765 09:44:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.talos.tests.zip 09:44:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:44:27 INFO - Fetch https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.talos.tests.zip into memory 09:44:28 INFO - Content-Length response header: 14447425 09:44:28 INFO - Bytes received: 14447425 09:44: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:44:28 INFO - trying https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2 09:44:28 INFO - Downloading https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:44:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:44:29 INFO - Downloaded 54235359 bytes. 09:44:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2 09:44:29 INFO - mkdir: /builds/slave/test/properties 09:44:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:44:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:44:29 INFO - Contents: 09:44:29 INFO - build_url:https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2 09:44:29 INFO - Running post-action listener: _resource_record_post_action 09:44:29 INFO - Running post-action listener: set_extra_try_arguments 09:44:29 INFO - [mozharness: 2017-05-30 16:44:29.769895Z] Finished download-and-extract step (success) 09:44:29 INFO - [mozharness: 2017-05-30 16:44:29.769992Z] Running populate-webroot step. 09:44:29 INFO - Running pre-action listener: _resource_record_pre_action 09:44:29 INFO - Running main action method: populate_webroot 09:44:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:44:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:44:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:44:29 INFO - '--tppagecycles', 09:44:29 INFO - '7'], 09:44:29 INFO - 'tests': ['tsvgm']}}, 09:44:29 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:44:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:44:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:44:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['damp', 'tps']}, 09:44:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'tests': ['damp', 'tps']}, 09:44:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['dromaeo_dom']}, 09:44:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:44:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:44:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:44:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:44:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['a11yr', 09:44:29 INFO - 'ts_paint', 09:44:29 INFO - 'tpaint', 09:44:29 INFO - 'sessionrestore', 09:44:29 INFO - 'sessionrestore_no_auto_restore', 09:44:29 INFO - 'tabpaint']}, 09:44:29 INFO - 'other-e10s': {'tests': ['a11yr', 09:44:29 INFO - 'ts_paint', 09:44:29 INFO - 'tpaint', 09:44:29 INFO - 'sessionrestore', 09:44:29 INFO - 'sessionrestore_no_auto_restore', 09:44:29 INFO - 'tabpaint']}, 09:44:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:44:29 INFO - 'ts_paint', 09:44:29 INFO - 'tpaint', 09:44:29 INFO - 'sessionrestore', 09:44:29 INFO - 'sessionrestore_no_auto_restore', 09:44:29 INFO - 'tabpaint']}, 09:44:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:44:29 INFO - 'ts_paint', 09:44:29 INFO - 'tpaint', 09:44:29 INFO - 'sessionrestore', 09:44:29 INFO - 'sessionrestore_no_auto_restore', 09:44:29 INFO - 'tabpaint']}, 09:44:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['a11yr', 09:44:29 INFO - 'ts_paint', 09:44:29 INFO - 'tpaint', 09:44:29 INFO - 'sessionrestore', 09:44:29 INFO - 'sessionrestore_no_auto_restore', 09:44:29 INFO - 'tabpaint']}, 09:44:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['a11yr', 09:44:29 INFO - 'ts_paint', 09:44:29 INFO - 'tpaint', 09:44:29 INFO - 'sessionrestore', 09:44:29 INFO - 'sessionrestore_no_auto_restore', 09:44:29 INFO - 'tabpaint']}, 09:44:29 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:44:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:44:29 INFO - 'bloom_basic_ref']}, 09:44:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:44:29 INFO - 'talos_options': ['--mitmproxy', 09:44:29 INFO - 'mitmproxy-recording-1.mp', 09:44:29 INFO - '--firstNonBlankPaint'], 09:44:29 INFO - 'tests': ['Quantum_1']}, 09:44:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['tsvgx', 09:44:29 INFO - 'tsvgr_opacity', 09:44:29 INFO - 'tart', 09:44:29 INFO - 'tscrollx', 09:44:29 INFO - 'cart', 09:44:29 INFO - 'tsvg_static']}, 09:44:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:44:29 INFO - 'tsvgr_opacity', 09:44:29 INFO - 'tart', 09:44:29 INFO - 'tscrollx', 09:44:29 INFO - 'cart', 09:44:29 INFO - 'tsvg_static']}, 09:44:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'talos_options': ['--disable-e10s'], 09:44:29 INFO - 'tests': ['tp5o']}, 09:44:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:44:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'talos_options': ['--disable-e10s', 09:44:29 INFO - '--xperf_path', 09:44:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:29 INFO - 'tests': ['tp5n']}, 09:44:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:44:29 INFO - 'talos_options': ['--xperf_path', 09:44:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:29 INFO - 'tests': ['tp5n']}}, 09:44:29 INFO - 'talos.zip': {'path': '', 09:44:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:44:29 INFO - Running post-action listener: _resource_record_post_action 09:44:29 INFO - [mozharness: 2017-05-30 16:44:29.784363Z] Finished populate-webroot step (success) 09:44:29 INFO - [mozharness: 2017-05-30 16:44:29.784458Z] Running create-virtualenv step. 09:44:29 INFO - Running pre-action listener: _resource_record_pre_action 09:44:29 INFO - Running main action method: create_virtualenv 09:44:29 INFO - Creating virtualenv /builds/slave/test/build/venv 09:44:29 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:44:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:44:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:44:29 INFO - Using real prefix '/usr' 09:44:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:44:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:44:32 INFO - Installing pip.................done. 09:44:32 INFO - Return code: 0 09:44:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:44:32 INFO - Reading from file tmpfile_stdout 09:44:32 INFO - Output received: 09:44:32 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:44:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:44:32 INFO - Using env: {'DISPLAY': ':0', 09:44:32 INFO - 'HOME': '/home/cltbld', 09:44:32 INFO - 'LANG': 'en_US.UTF-8', 09:44:32 INFO - 'LANGUAGE': 'en_US:en', 09:44:32 INFO - 'LOGNAME': 'cltbld', 09:44:32 INFO - 'MAIL': '/var/mail/cltbld', 09:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:32 INFO - 'MOZ_NO_REMOTE': '1', 09:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:32 INFO - 'NO_EM_RESTART': '1', 09:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:32 INFO - 'PWD': '/builds/slave/test', 09:44:32 INFO - 'SHELL': '/bin/bash', 09:44:32 INFO - 'SHLVL': '1', 09:44:32 INFO - 'TERM': 'linux', 09:44:32 INFO - 'TMOUT': '86400', 09:44:32 INFO - 'USER': 'cltbld', 09:44:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:32 INFO - '_': '/tools/buildbot/bin/python'} 09:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:32 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:44:32 INFO - Cleaning up... 09:44:32 INFO - Return code: 0 09:44:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:44:32 INFO - Using env: {'DISPLAY': ':0', 09:44:32 INFO - 'HOME': '/home/cltbld', 09:44:32 INFO - 'LANG': 'en_US.UTF-8', 09:44:32 INFO - 'LANGUAGE': 'en_US:en', 09:44:32 INFO - 'LOGNAME': 'cltbld', 09:44:32 INFO - 'MAIL': '/var/mail/cltbld', 09:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:32 INFO - 'MOZ_NO_REMOTE': '1', 09:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:32 INFO - 'NO_EM_RESTART': '1', 09:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:32 INFO - 'PWD': '/builds/slave/test', 09:44:32 INFO - 'SHELL': '/bin/bash', 09:44:32 INFO - 'SHLVL': '1', 09:44:32 INFO - 'TERM': 'linux', 09:44:32 INFO - 'TMOUT': '86400', 09:44:32 INFO - 'USER': 'cltbld', 09:44:32 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:32 INFO - '_': '/tools/buildbot/bin/python'} 09:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:32 INFO - Downloading/unpacking psutil>=3.1.1 09:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:44:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:34 INFO - Installing collected packages: psutil 09:44:34 INFO - Running setup.py install for psutil 09:44:34 INFO - building 'psutil._psutil_linux' extension 09:44:34 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:44:34 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:44:34 INFO - building 'psutil._psutil_posix' extension 09:44:34 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:44:34 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:44:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:34 INFO - Successfully installed psutil 09:44:34 INFO - Cleaning up... 09:44:34 INFO - Return code: 0 09:44:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:44:34 INFO - Using env: {'DISPLAY': ':0', 09:44:34 INFO - 'HOME': '/home/cltbld', 09:44:34 INFO - 'LANG': 'en_US.UTF-8', 09:44:34 INFO - 'LANGUAGE': 'en_US:en', 09:44:34 INFO - 'LOGNAME': 'cltbld', 09:44:34 INFO - 'MAIL': '/var/mail/cltbld', 09:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:34 INFO - 'MOZ_NO_REMOTE': '1', 09:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:34 INFO - 'NO_EM_RESTART': '1', 09:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:34 INFO - 'PWD': '/builds/slave/test', 09:44:34 INFO - 'SHELL': '/bin/bash', 09:44:34 INFO - 'SHLVL': '1', 09:44:34 INFO - 'TERM': 'linux', 09:44:34 INFO - 'TMOUT': '86400', 09:44:34 INFO - 'USER': 'cltbld', 09:44:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:34 INFO - '_': '/tools/buildbot/bin/python'} 09:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:44:36 INFO - Installing collected packages: mozsystemmonitor 09:44:36 INFO - Running setup.py install for mozsystemmonitor 09:44:36 INFO - Successfully installed mozsystemmonitor 09:44:36 INFO - Cleaning up... 09:44:36 INFO - Return code: 0 09:44:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:44:36 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:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:36 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:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:36 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:36 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:44:36 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:44:36 INFO - Using env: {'DISPLAY': ':0', 09:44:36 INFO - 'HOME': '/home/cltbld', 09:44:36 INFO - 'LANG': 'en_US.UTF-8', 09:44:36 INFO - 'LANGUAGE': 'en_US:en', 09:44:36 INFO - 'LOGNAME': 'cltbld', 09:44:36 INFO - 'MAIL': '/var/mail/cltbld', 09:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:36 INFO - 'MOZ_NO_REMOTE': '1', 09:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:36 INFO - 'NO_EM_RESTART': '1', 09:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:36 INFO - 'PWD': '/builds/slave/test', 09:44:36 INFO - 'SHELL': '/bin/bash', 09:44:36 INFO - 'SHLVL': '1', 09:44:36 INFO - 'TERM': 'linux', 09:44:36 INFO - 'TMOUT': '86400', 09:44:36 INFO - 'USER': 'cltbld', 09:44:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:36 INFO - '_': '/tools/buildbot/bin/python'} 09:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:36 INFO - Downloading/unpacking jsonschema==2.5.1 09:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:44:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:44:37 INFO - warning: no files found matching '*.txt' 09:44:37 INFO - no previously-included directories found matching 'build' 09:44:37 INFO - no previously-included directories found matching 'dist' 09:44:37 INFO - no previously-included directories found matching '.git*' 09:44:37 INFO - Installing collected packages: jsonschema, functools32 09:44:37 INFO - Running setup.py install for functools32 09:44:37 INFO - warning: no files found matching '*.txt' 09:44:37 INFO - no previously-included directories found matching 'build' 09:44:37 INFO - no previously-included directories found matching 'dist' 09:44:37 INFO - no previously-included directories found matching '.git*' 09:44:37 INFO - Successfully installed jsonschema functools32 09:44:37 INFO - Cleaning up... 09:44:37 INFO - Return code: 0 09:44:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:44:37 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:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:37 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:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:37 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:37 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:44:37 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:44:37 INFO - Using env: {'DISPLAY': ':0', 09:44:37 INFO - 'HOME': '/home/cltbld', 09:44:37 INFO - 'LANG': 'en_US.UTF-8', 09:44:37 INFO - 'LANGUAGE': 'en_US:en', 09:44:37 INFO - 'LOGNAME': 'cltbld', 09:44:37 INFO - 'MAIL': '/var/mail/cltbld', 09:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:37 INFO - 'MOZ_NO_REMOTE': '1', 09:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:37 INFO - 'NO_EM_RESTART': '1', 09:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:37 INFO - 'PWD': '/builds/slave/test', 09:44:37 INFO - 'SHELL': '/bin/bash', 09:44:37 INFO - 'SHLVL': '1', 09:44:37 INFO - 'TERM': 'linux', 09:44:37 INFO - 'TMOUT': '86400', 09:44:37 INFO - 'USER': 'cltbld', 09:44:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:37 INFO - '_': '/tools/buildbot/bin/python'} 09:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:44:38 INFO - Cleaning up... 09:44:38 INFO - Return code: 0 09:44:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:38 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:38 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:44:38 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:44:38 INFO - Using env: {'DISPLAY': ':0', 09:44:38 INFO - 'HOME': '/home/cltbld', 09:44:38 INFO - 'LANG': 'en_US.UTF-8', 09:44:38 INFO - 'LANGUAGE': 'en_US:en', 09:44:38 INFO - 'LOGNAME': 'cltbld', 09:44:38 INFO - 'MAIL': '/var/mail/cltbld', 09:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:38 INFO - 'MOZ_NO_REMOTE': '1', 09:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:38 INFO - 'NO_EM_RESTART': '1', 09:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:38 INFO - 'PWD': '/builds/slave/test', 09:44:38 INFO - 'SHELL': '/bin/bash', 09:44:38 INFO - 'SHLVL': '1', 09:44:38 INFO - 'TERM': 'linux', 09:44:38 INFO - 'TMOUT': '86400', 09:44:38 INFO - 'USER': 'cltbld', 09:44:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:38 INFO - '_': '/tools/buildbot/bin/python'} 09:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:44:38 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:44:38 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:44:38 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:44:38 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:44:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:44:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:44:39 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:44:39 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:44:39 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:44:39 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:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:44:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:44:39 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:44:39 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:44:39 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:44:39 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:44:39 INFO - Downloading docopt-0.6.1.tar.gz 09:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:44:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:44:40 INFO - Running setup.py install for blobuploader 09:44:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:44:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:44:40 INFO - Running setup.py install for requests 09:44:40 INFO - Running setup.py install for docopt 09:44:40 INFO - Successfully installed blobuploader requests docopt 09:44:40 INFO - Cleaning up... 09:44:40 INFO - Return code: 0 09:44:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:40 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:40 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:44:40 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:44:40 INFO - Using env: {'DISPLAY': ':0', 09:44:40 INFO - 'HOME': '/home/cltbld', 09:44:40 INFO - 'LANG': 'en_US.UTF-8', 09:44:40 INFO - 'LANGUAGE': 'en_US:en', 09:44:40 INFO - 'LOGNAME': 'cltbld', 09:44:40 INFO - 'MAIL': '/var/mail/cltbld', 09:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:40 INFO - 'MOZ_NO_REMOTE': '1', 09:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:40 INFO - 'NO_EM_RESTART': '1', 09:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:40 INFO - 'PWD': '/builds/slave/test', 09:44:40 INFO - 'SHELL': '/bin/bash', 09:44:40 INFO - 'SHLVL': '1', 09:44:40 INFO - 'TERM': 'linux', 09:44:40 INFO - 'TMOUT': '86400', 09:44:40 INFO - 'USER': 'cltbld', 09:44:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:40 INFO - '_': '/tools/buildbot/bin/python'} 09:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:40 INFO - Running setup.py (path:/tmp/pip-2R6Aq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:40 INFO - Running setup.py (path:/tmp/pip-oy0XGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:40 INFO - Running setup.py (path:/tmp/pip-WqVeSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:41 INFO - Running setup.py (path:/tmp/pip-9tMq8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:41 INFO - Running setup.py (path:/tmp/pip-hg8Twi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:41 INFO - Running setup.py (path:/tmp/pip-jdBEe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:41 INFO - Running setup.py (path:/tmp/pip-uyGtsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:41 INFO - Running setup.py (path:/tmp/pip-bqIQCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:41 INFO - Running setup.py (path:/tmp/pip-KD_VrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:41 INFO - Running setup.py (path:/tmp/pip-2_Uwdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:41 INFO - Running setup.py (path:/tmp/pip-KtGdSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:41 INFO - Running setup.py (path:/tmp/pip-Mhdc8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:41 INFO - Running setup.py (path:/tmp/pip-V0_6YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:41 INFO - Running setup.py (path:/tmp/pip-bhXpsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:41 INFO - Running setup.py (path:/tmp/pip-noWfLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:41 INFO - Running setup.py (path:/tmp/pip-4rYqNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:41 INFO - Running setup.py (path:/tmp/pip-hKEpTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:44:42 INFO - Running setup.py install for manifestparser 09:44:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Running setup.py install for mozcrash 09:44:42 INFO - Running setup.py install for mozdebug 09:44:42 INFO - Running setup.py install for mozdevice 09:44:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Running setup.py install for mozfile 09:44:42 INFO - Running setup.py install for mozhttpd 09:44:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Running setup.py install for mozinfo 09:44:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Running setup.py install for mozInstall 09:44:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:44:42 INFO - Running setup.py install for mozleak 09:44:42 INFO - Running setup.py install for mozlog 09:44:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Running setup.py install for moznetwork 09:44:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Running setup.py install for mozprocess 09:44:43 INFO - Running setup.py install for mozprofile 09:44:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Running setup.py install for mozrunner 09:44:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Running setup.py install for mozscreenshot 09:44:43 INFO - Running setup.py install for moztest 09:44:43 INFO - Running setup.py install for mozversion 09:44:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:44:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:44:43 INFO - Cleaning up... 09:44:43 INFO - Return code: 0 09:44:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:43 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:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:43 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:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:43 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:43 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:44:43 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:44:43 INFO - Using env: {'DISPLAY': ':0', 09:44:43 INFO - 'HOME': '/home/cltbld', 09:44:43 INFO - 'LANG': 'en_US.UTF-8', 09:44:43 INFO - 'LANGUAGE': 'en_US:en', 09:44:43 INFO - 'LOGNAME': 'cltbld', 09:44:43 INFO - 'MAIL': '/var/mail/cltbld', 09:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:43 INFO - 'MOZ_NO_REMOTE': '1', 09:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:43 INFO - 'NO_EM_RESTART': '1', 09:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:43 INFO - 'PWD': '/builds/slave/test', 09:44:43 INFO - 'SHELL': '/bin/bash', 09:44:43 INFO - 'SHLVL': '1', 09:44:43 INFO - 'TERM': 'linux', 09:44:43 INFO - 'TMOUT': '86400', 09:44:43 INFO - 'USER': 'cltbld', 09:44:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:43 INFO - '_': '/tools/buildbot/bin/python'} 09:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:44 INFO - Running setup.py (path:/tmp/pip-NYpcNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:44 INFO - Running setup.py (path:/tmp/pip-81NWat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:44 INFO - Running setup.py (path:/tmp/pip-xykcRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:44 INFO - Running setup.py (path:/tmp/pip-tuEET3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:44 INFO - Running setup.py (path:/tmp/pip-svlEo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:44 INFO - Running setup.py (path:/tmp/pip-xGIF5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:44 INFO - Running setup.py (path:/tmp/pip-2CQ5my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:44 INFO - Running setup.py (path:/tmp/pip-6J9NnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:44 INFO - Running setup.py (path:/tmp/pip-5b3OB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:44 INFO - Running setup.py (path:/tmp/pip-lFK3Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:44 INFO - Running setup.py (path:/tmp/pip-CY1Ek0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:44 INFO - Running setup.py (path:/tmp/pip-BrjNp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:44 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:44:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:44 INFO - Running setup.py (path:/tmp/pip-vdNGG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:45 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:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:45 INFO - Running setup.py (path:/tmp/pip-zFj20H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:45 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:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:45 INFO - Running setup.py (path:/tmp/pip-0aTR_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:45 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:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:45 INFO - Running setup.py (path:/tmp/pip-oU_qCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:45 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:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:45 INFO - Running setup.py (path:/tmp/pip-w07HLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:45 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:44:45 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:44:45 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:44:45 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:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:45 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:44:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44:45 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:44:45 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:44:45 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:44:45 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:44:46 INFO - Downloading blessings-1.6.tar.gz 09:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:46 INFO - Installing collected packages: blessings 09:44:46 INFO - Running setup.py install for blessings 09:44:46 INFO - Successfully installed blessings 09:44:46 INFO - Cleaning up... 09:44:46 INFO - Return code: 0 09:44:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:46 INFO - Reading from file tmpfile_stdout 09:44:46 INFO - Current package versions: 09:44:46 INFO - argparse == 1.2.1 09:44:46 INFO - blessings == 1.6 09:44:46 INFO - blobuploader == 1.2.4 09:44:46 INFO - docopt == 0.6.1 09:44:46 INFO - functools32 == 3.2.3-2 09:44:46 INFO - jsonschema == 2.5.1 09:44:46 INFO - manifestparser == 1.1 09:44:46 INFO - mozInstall == 1.12 09:44:46 INFO - mozcrash == 1.0 09:44:46 INFO - mozdebug == 0.1 09:44:46 INFO - mozdevice == 0.51 09:44:46 INFO - mozfile == 1.2 09:44:46 INFO - mozhttpd == 0.7 09:44:46 INFO - mozinfo == 0.9 09:44:46 INFO - mozleak == 0.1 09:44:46 INFO - mozlog == 3.4 09:44:46 INFO - moznetwork == 0.27 09:44:46 INFO - mozprocess == 0.25 09:44:46 INFO - mozprofile == 0.28 09:44:46 INFO - mozrunner == 6.13 09:44:46 INFO - mozscreenshot == 0.1 09:44:46 INFO - mozsystemmonitor == 0.3 09:44:46 INFO - moztest == 0.8 09:44:46 INFO - mozversion == 1.4 09:44:46 INFO - psutil == 3.1.1 09:44:46 INFO - requests == 1.2.3 09:44:46 INFO - wsgiref == 0.1.2 09:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:46 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:46 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:44:46 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:44:46 INFO - Using env: {'DISPLAY': ':0', 09:44:46 INFO - 'HOME': '/home/cltbld', 09:44:46 INFO - 'LANG': 'en_US.UTF-8', 09:44:46 INFO - 'LANGUAGE': 'en_US:en', 09:44:46 INFO - 'LOGNAME': 'cltbld', 09:44:46 INFO - 'MAIL': '/var/mail/cltbld', 09:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:46 INFO - 'MOZ_NO_REMOTE': '1', 09:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:46 INFO - 'NO_EM_RESTART': '1', 09:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:46 INFO - 'PWD': '/builds/slave/test', 09:44:46 INFO - 'SHELL': '/bin/bash', 09:44:46 INFO - 'SHLVL': '1', 09:44:46 INFO - 'TERM': 'linux', 09:44:46 INFO - 'TMOUT': '86400', 09:44:46 INFO - 'USER': 'cltbld', 09:44:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:46 INFO - '_': '/tools/buildbot/bin/python'} 09:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:47 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:44:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:44:47 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:44:47 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:44:47 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:44:47 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:44:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:44:48 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:44:48 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:44:48 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:44:48 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:44:48 INFO - Installing collected packages: marionette-driver 09:44:48 INFO - Running setup.py install for marionette-driver 09:44:48 INFO - Successfully installed marionette-driver 09:44:48 INFO - Cleaning up... 09:44:48 INFO - Return code: 0 09:44:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:44:48 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:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:48 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:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:48 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 0x211c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2499ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, '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': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', '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:44:48 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:44:48 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:44:48 INFO - Using env: {'DISPLAY': ':0', 09:44:48 INFO - 'HOME': '/home/cltbld', 09:44:48 INFO - 'LANG': 'en_US.UTF-8', 09:44:48 INFO - 'LANGUAGE': 'en_US:en', 09:44:48 INFO - 'LOGNAME': 'cltbld', 09:44:48 INFO - 'MAIL': '/var/mail/cltbld', 09:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:48 INFO - 'MOZ_NO_REMOTE': '1', 09:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:44:48 INFO - 'NO_EM_RESTART': '1', 09:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:48 INFO - 'PWD': '/builds/slave/test', 09:44:48 INFO - 'SHELL': '/bin/bash', 09:44:48 INFO - 'SHLVL': '1', 09:44:48 INFO - 'TERM': 'linux', 09:44:48 INFO - 'TMOUT': '86400', 09:44:48 INFO - 'USER': 'cltbld', 09:44:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:48 INFO - '_': '/tools/buildbot/bin/python'} 09:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:44:48 INFO - Cleaning up... 09:44:48 INFO - Return code: 0 09:44:48 INFO - Running post-action listener: _resource_record_post_action 09:44:48 INFO - Running post-action listener: _start_resource_monitoring 09:44:48 INFO - Starting resource monitoring. 09:44:48 INFO - [mozharness: 2017-05-30 16:44:48.646760Z] Finished create-virtualenv step (success) 09:44:48 INFO - [mozharness: 2017-05-30 16:44:48.647306Z] Running install step. 09:44:48 INFO - Running pre-action listener: _resource_record_pre_action 09:44:48 INFO - Running main action method: install 09:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:48 INFO - Reading from file tmpfile_stdout 09:44:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:48 INFO - Reading from file tmpfile_stdout 09:44:48 INFO - Output received: 09:44:48 INFO - Usage: mozinstall [options] installer 09:44:48 INFO - Options: 09:44:48 INFO - -h, --help show this help message and exit 09:44:48 INFO - -d DEST, --destination=DEST 09:44:48 INFO - Directory to install application into. [default: 09:44:48 INFO - "/builds/slave/test"] 09:44:48 INFO - --app=APP Application being installed. [default: firefox] 09:44:48 INFO - mkdir: /builds/slave/test/build/application 09:44:48 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:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:45:04 INFO - Reading from file tmpfile_stdout 09:45:04 INFO - Output received: 09:45:04 INFO - /builds/slave/test/build/application/firefox/firefox 09:45:04 INFO - Running post-action listener: _resource_record_post_action 09:45:04 INFO - [mozharness: 2017-05-30 16:45:04.673287Z] Finished install step (success) 09:45:04 INFO - [mozharness: 2017-05-30 16:45:04.673568Z] Running setup-mitmproxy step. 09:45:04 INFO - Running pre-action listener: _resource_record_pre_action 09:45:04 INFO - Running main action method: setup_mitmproxy 09:45:04 INFO - Skipping: mitmproxy is not required 09:45:04 INFO - Running post-action listener: _resource_record_post_action 09:45:04 INFO - [mozharness: 2017-05-30 16:45:04.674697Z] Finished setup-mitmproxy step (success) 09:45:04 INFO - [mozharness: 2017-05-30 16:45:04.674919Z] Running run-tests step. 09:45:04 INFO - Running pre-action listener: _resource_record_pre_action 09:45:04 INFO - Running main action method: run_tests 09:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:04 INFO - Python 2.7.3 09:45:04 INFO - Return code: 0 09:45:04 INFO - grabbing minidump binary from tooltool 09:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2496e40>, '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 0x2497fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2498440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:45:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:45:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:45:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:04 INFO - Return code: 0 09:45:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:45:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:04 INFO - ENV: RUST_BACKTRACE is now 1 09:45:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:45:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:45:04 INFO - Using env: {'DISPLAY': ':0', 09:45:04 INFO - 'HOME': '/home/cltbld', 09:45:04 INFO - 'LANG': 'en_US.UTF-8', 09:45:04 INFO - 'LANGUAGE': 'en_US:en', 09:45:04 INFO - 'LOGNAME': 'cltbld', 09:45:04 INFO - 'MAIL': '/var/mail/cltbld', 09:45:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:04 INFO - 'MOZ_NO_REMOTE': '1', 09:45:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:04 INFO - 'NO_EM_RESTART': '1', 09:45:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:04 INFO - 'PWD': '/builds/slave/test', 09:45:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:04 INFO - 'RUST_BACKTRACE': '1', 09:45:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:45:04 INFO - 'SHELL': '/bin/bash', 09:45:04 INFO - 'SHLVL': '1', 09:45:04 INFO - 'TERM': 'linux', 09:45:04 INFO - 'TMOUT': '86400', 09:45:04 INFO - 'USER': 'cltbld', 09:45:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1496162636.623193-963772990', 09:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:04 INFO - '_': '/tools/buildbot/bin/python'} 09:45:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:45:04 INFO - mozversion application_buildid: 20170530161351 09:45:04 INFO - mozversion application_changeset: c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f 09:45:04 INFO - mozversion application_display_name: Nightly 09:45:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:04 INFO - mozversion application_name: Firefox 09:45:04 INFO - mozversion application_remotingname: firefox 09:45:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:45:04 INFO - mozversion application_vendor: Mozilla 09:45:04 INFO - mozversion application_version: 55.0a1 09:45:04 INFO - mozversion platform_buildid: 20170530161351 09:45:04 INFO - mozversion platform_changeset: c3cd8c58fa87d571874f2bcc34ec0864ac7acd5f 09:45:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:45:04 INFO - mozversion platform_version: 55.0a1 09:45:04 INFO - using testdate: 1496162704 09:45:04 INFO - actual date: 1496162704 09:45:04 INFO - starting webserver on 'localhost:53987' 09:45:04 INFO - SUITE-START | Running 2 tests 09:45:04 INFO - TEST-START | dromaeo_css 09:45:04 INFO - operating with platform_type : linux_ 09:45:04 INFO - Initialising browser for dromaeo_css test... 09:45:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53987/getInfo.html -profile /tmp/tmpyjfdBx/profile 09:45:05 INFO - TEST-INFO | started process 30683 (/builds/slave/test/build/application/firefox/firefox http://localhost:53987/getInfo.html) 09:45:40 INFO - TEST-INFO | 30683: killed by SIGTERM 09:45:40 INFO - Browser initialized. 09:45:40 INFO - Running cycle 1/1 for dromaeo_css test... 09:45:40 INFO - TEST-INFO | started process 30881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyjfdBx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:52 INFO - PID 30881 | RSS: Main: 182222848 09:45:52 INFO - PID 30881 | 09:48:57 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:53987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53987/tests/dromaeo/cssquery-ext.html) 09:48:58 INFO - PID 30881 | RSS: Main: 178147328 09:48:58 INFO - PID 30881 | 09:52:00 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:53987/tests/dromaeo/cssquery-ext.html (next: http://localhost:53987/tests/dromaeo/cssquery-jquery.html) 09:52:01 INFO - PID 30881 | RSS: Main: 183218176 09:52:01 INFO - PID 30881 | 09:55:03 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:53987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53987/tests/dromaeo/cssquery-mootools.html) 09:55:03 INFO - PID 30881 | RSS: Main: 180617216 09:55:03 INFO - PID 30881 | 09:58:05 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:53987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53987/tests/dromaeo/cssquery-prototype.html) 09:58:06 INFO - PID 30881 | RSS: Main: 184070144 09:58:06 INFO - PID 30881 | 10:01:09 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:53987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53987/tests/dromaeo/cssquery-yui.html) 10:01:09 INFO - PID 30881 | RSS: Main: 182710272 10:01:09 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | Cycle 1(1): loaded http://localhost:53987/tests/dromaeo/cssquery-yui.html (next: http://localhost:53987/tests/dromaeo/cssquery-dojo.html) 10:04:11 INFO - PID 30881 | RSS: Main: 180752384 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | __start_tp_report 10:04:11 INFO - PID 30881 | _x_x_mozilla_page_load 10:04:11 INFO - PID 30881 | _x_x_mozilla_page_load_details 10:04:11 INFO - PID 30881 | |i|pagename|runs| 10:04:11 INFO - PID 30881 | |0;dojo.html;2671.3455203475146;2689.354554906823;2701.135636596289;2727.5499542575476;2727.645406097207;5267.078261304266;5333.546648534874;5367.543758780498;5397.298351214336;5434.184872269162;5283.049051170788;5317.9468205317935;5356.062689029414;5375.6774593524415;5385.892282154355;4463.4866990296205;4681.110588988098;4736.147493451177;4777.713337199762;4799.088173247089;4794.640401969848;4849.0301939612045;4853.174960256747;4859.1010663027455;4864.659473836833;4681.485036645966;4732.455767586737;4755.83354582588;4773.785179666923;4798.976005119952;4727.149113159629;4798.112349215371;4804.567588917014;4809.615230781564;4813.951860481386;4704.976475117637;4712.128256272601;4721;4725.787339569728;4787.234042553175;5334.093204155303;5335.1197052486295;5350;5378.354597448292;5396.703181325026;5668.461496157858;5729.742161602738;5739.741711622945;5755.597108202427;5759.884802303931;5916.792912248051;5932.288125424977;5945.405459454063;5958.106284057383;5973.133895585159;5430.647007944471;5441.891162176735;5448.400675925645;5463.289772329572;5464.836054918359;5866.882662346729;5909.349971503131;6034.155218269446;6043.2748070231855;6050.213472248667;5626.662400255997;5714.085746280575;5719.5996280260815;5740.56945729072;5762.596618236683;5714.657120572779;5827.3298570664065;5845.09401042839;5850.444207800252;5852.297724273115;5654.038813401731;5741.425857414309;5805.94194058054;5808.070708686674;5810.0994345875615;5712.971435142797;5721.998650236275;5741.45456181662;5786.392428795;5801.767929282866;4856;4861.7326047067045;4863.756812159378;4877.585405240523;4905.3132561441425;4135.6898232632675;4135.710500264952;4142.5857414258335;4174;4218.2196293685765;4766.785494652749;4821.493743156988;4825.1555977703765;4881.4630390657;4890.828820991248;5864.0031194697;5881.294244690579;5881.9705901470215;5882.676452795137;5902.409759024149;4832.565069143794;4878.07316609843;4881.267809828554;4884.145274576935;4893.388326459192;5134.05020071288;5136.255242989746;5144.588432925357;5147.176451767774;5160.354955630546;5193.7403129844115;5243.030039442715;5260.658057226268;5292.629515933848;5322.866928326823;5695.231143795535;5762.855928601818;5769;5878.059510478303;5933.614315069507;5242.737863106753;5308.814191503279;5328.307320048369;5329;5340.786368545215;5619.8595035124445;5733.3406658234835;5737.196792449144;5738.512226460798;5746.7701291949525;5754.53963682896;5878.794242201502;5879.823605291848;5882.382349853204;5882.647041177543;5604.271444712162;5630.662160270397;5642.407547207484;5729.140628905698;5733.655980641175;5604.523615492729;5659.434056594308;5685.857853553694;5691.914621280767;5702.51528620072;5503.449655034465;5522.834314970557;5523.917141242804;5572.4148964358155;5576;5566.359868614999;5584.804531841366;5698.800541981011;5702;5706.258186435737;5440.891182176255;5442.238086667949;5514.6691198528215;5528.06022976087;5555.166724991283 10:04:11 INFO - PID 30881 | |1;ext.html;690.9723611055558;750.8460765543063;762.2834535536597;1084.766775143344;1106.8395082713002;34321.31357372851;35243.2951340973;35292;35292.823535882315;35368.646313536854;36153.81923090387;36557;36564.45153322696;36572.81713591428;36581.817090914505;6784.525083244175;6907.033015377839;6953.930460695404;7057.294270572927;7058.788236352918;6873.896891546631;6952.374286314231;7005.404540614054;7006.789796306093;7013.964930175342;6913.688884000207;6985.755498557552;7012.193597736249;7012.544184628008;7018;6964.303569643046;6991.685374158175;7003.264657211022;7018.789436316919;7019.3682568569075;6807.693653785592;6873.347032031949;6877.862442751167;6883.346082122191;6888.965555172192;33642.49536256934;33751.156221094425;33793;33840.15399615029;33898.6610133898;3140.450421176308;3166.8258245796474;3182.3317103408313;3184.1721152500286;3187.442197615408;25479.23562293134;25787.226383208534;25833;25851.482970340487;25875.094371697087;3095.891643792479;3106.1147572941827;3120.0171945836987;3122.032170027299;3134.6865313468697;126219.10671339938;128488;138709.99999999898;150990;151198.24400878034;41773.58226417697;41817;41826.37260441096;41852.790736046125;41873;43266.7836660821;43474;43509.564904350555;43566.34650480245;43772.78113609411;11675.88324116748;11766.352850593128;11813.763724725457;11846.526138954518;11887.88112118885;9332;9337.346385752931;9364.25085993119;9365.063493650716;9397.201237894718;13143.605691829069;13143.67140821468;13160.539381121614;13175.209487430784;13291;5533.391326954032;5572.665640061609;5581;5608.9439105609235;5667.631603945731;872.1148034744739;910.2945217456391;915.4507295622707;918.0727465260002;940.6660635474308;20518.487037824172;20635.8968205161;21918.671219931715;22202;22270.443238919157;985.2216748768393;986.2701600815345;989.6536212325628;1004.8141093897652;1008.8738907636546;10948.781024379468;11589.594364197214;11647.359395233343;11684.88315116855;11705.414729263674;172926;173203;174418;174741;175007;42755;43028.354574681405;43207;43228;43298.35052474152;1182.1344204451568;1243.0801207106676;1244.520859469111;1244.5457408045997;1247.3326770177912;19946.30187943415;20836.47908802292;21532.461688457286;21547.353579392642;21637.13451461987;30785.8460707695;30880.845595771876;30912.845435773575;31093.68906310908;31176.22059448532;153874.23062884613;155123;155218;155251;155260.22369888079;29486.410271794874;29594.704052960056;29635.703642964156;30405.695943040286;30569.694303056684;37074;37199.25601488009;37662.81168594139;37810.43284350682;37813.43279850749;26676.866615667575;27899;28123.71876281293;28150;28999.56500652534;27595.44809103847;27681.723182767913;28698.13905582836;28797;28798.424031518833;31422;31841.681583183872;31879.840600796848;31891.202719931258;31940;26861.731382685924;27272.863635681693;27988.16035518938;28326.291842704097;28958.42083158283;22253.332400028026;22967.540649186587;23092.228932528204;23103.53792924166;23210.883945580164 10:04:11 INFO - PID 30881 | |2;jquery.html;400.8737247766955;409.22656179820143;413.34691187923084;429.3323881364478;432.398965438041;12956;16603.584910377245;17469.03920284384;18028.54928626785;18065;16804.57988550287;16839.242234099464;17038.50710604323;17406.738898916527;17550.736738948926;5459.727013649322;5621.156826476041;5657.547396208314;5671.943280567203;5675.659460432366;5305;5451.291332126838;5478.178273259023;5492.395836457987;5496.615236933416;5445.782168713266;5450.809221677242;5454.836354909339;5456.208849716789;5473.452654734515;5304.443033481487;5473.397926228132;5518.724063796834;5522.723863806794;5540.196671482653;4951.950480495185;4967.850964471072;4967.975160124176;4970.179920313144;4977.975110124463;21306.254281100242;21922.123115075377;21942.341729748132;22174.11303547856;22244.221452249254;1614.7981502312211;1654.2307826860447;1663.534210421072;1663.6506333669943;1670.0313817985539;14337.856621433757;14643.34104965279;14913.776293355608;15150.469733559383;15291.617709557238;2024.3522072936667;2058.8661736987196;2076.646970015101;2088.5405210853587;2119.4065661614773;86702.56648716779;87869.56065219697;89807;96494;100207;10746.140308775279;10764.300320479144;10940.288881222696;11148.665540033811;11177.49701263445;14269.500567480089;15076.39694412233;15174.848251517344;15240.542783716506;15277.847221527865;7392.186859445456;7431.108267007886;7503.287187717158;7550.395968322521;7584.5070070445245;6927.861442771116;6946.444284457332;7078.469114816409;7142.035825163641;7179.641017949186;6697.966510167418;6765.255821859591;6809.216940051958;6884;6910.516263861481;1996.2314508914174;2021.7270668459864;2029.6448121578665;2057.6501994660944;2191.4959559301133;836.6486075848159;862.3015357560396;884.5754038061638;892.3575025981283;900.3742399032609;17039.744403833953;17089.31642734277;17178.74231886523;17541.386051488393;17891.910540447214;870.2689740617911;874.1957399192758;879.6437442835662;886.1448702002598;901.6483571407157;9044.095590440904;9201.447913125234;9437.339386243035;9569.61721531145;9603.423794572349;366612;367495.3547758853;368380;370612;376219;79798.20201798023;81498;81643;82651;82745.58627206825;1080.713610893114;1085.1318944844093;1094;1104.9060829829393;1107.2802678259195;14411.42354305816;14554.708905822035;14685.926570367079;14710.485133020293;15203.315850786963;38351.23297533978;38534.22931541409;38684.64603738856;39909;39985.2002959945;48242.03515929591;48613.51386486231;49660.751696241285;50878;51109.744451277504;7942.920570794218;8115.959420203098;8216.234583941181;8218.383621228311;8261.09127995932;12186.451609677408;12333.198342107735;12359.443825028075;12801.48794048265;13218.933905330412;9356.345055846026;10064.496775161359;10267.794644106927;10317.690469285933;10490.947545262225;9104.180623743894;9781.951090244504;9940.552675129782;10170.237232207466;10283.12593429567;10164.745881353025;10394.844077338696;10574.84137737919;10753;10858.782824343627;7892;7996.440249182501;11435.942820285845;11743.88256117428;11917;9112.589933452879;10102.040306170902;10705.89294107049;11197.552097915992;11463.541458341573 10:04:11 INFO - PID 30881 | |3;mootools.html;1207.6256360528237;1261.7098067444488;1262.5833474953267;1265.1966001588987;1282.6023932580897;10122.240831937606;10421.687349379512;10435.582576696932;10481.056704896559;10703.678889633304;10437.478126093683;10567.630132945349;10613.57545698171;10623.78752424951;10629.362238265709;1952.8632995690307;1992.5417154054576;1994.7805741368438;2001.7097520859468;2010.346637342862;1945.5136215946013;1984.6130004649099;1994.481434826948;1996.3711430899293;2002.2791794953805;1941.1555973151653;1952.8828270303757;1959.098814545311;1960.2453055573635;1960.92156313748;1920.5582715975265;1925.0663428237294;1927.951801204967;1929.305450037985;1931.7199006144172;1904.5809921817179;1922.8750131241425;1976.3280484635293;1977.8615496915222;1984.335247692025;10300.639477618248;10385.63650272237;10389.896101038968;10396.32423892452;10413.114885234763;5427.348718153847;5613.803516876889;5614.859628509279;5621.072523033695;5633.436656334334;3280.934381312384;3394.932101357984;3437.3125374924866;3437.535932649085;3453.4129198036394;1121.293585041427;1138.1179585820971;1150.0569532982956;1172.6657902497748;1181.6986668399504;14021.509247176402;14486.20325882076;15058.698826023528;15197.6200594986;15235.162066086361;4693.9765301173275;4758.452777930513;4907.631927605444;4951.702897826142;4955.677880937727;11372.601958931398;11381.430928453545;11401;11442.885571144348;11455.140864435201;5613.494785469327;5659;5683.232763576864;5687.061634830289;5692.743826527816;5229.267902493654;5240.6069544784295;5266.868328291746;5278.392984806719;5286.418493965661;3716.940671908493;3749.1564398010228;3785.905352366158;3828.062124779391;3853.2678791029616;1084.4089970965842;1092.639428988432;1099.0932480703452;1108.4236197177422;1110.5169251375678;722.7325889420842;731.7292601737391;736.2379936765423;745.4371949178336;752.3905636434506;5720.247410388239;5756.33802112754;5867.911981320283;5913.497352725067;5916.467517923407;825.1913125137279;845.7082306604211;855.2174760094568;856.6958729650884;861.7199410191713;3944.487216661873;3991.880243592697;4018.819153138057;4025.677945764332;4031.871076098697;13042.934785326202;13860.306984650728;13869.722605547833;13942.86057139436;13980.510682126076;13489.730205395837;13609.455621775216;13655.86344136546;13718.451261949609;13773.173609583457;7229.8554028919125;7488.663010164556;7586.089669239726;7605.543667379975;7647.732329368446;6131.356207598138;6178.443940045418;6310.6213627182515;6311.873762524816;6405.903911441425;11913.463894124612;12269.631911042683;12305;12370.505179793068;12427.067969902113;12194.207376520499;12321.815172772236;12409.193402428813;12428.13003089775;12614.936925315315;8549.829003419773;8722.040575536812;8730.17063378978;8752.51861147643;8781.692640757543;9721.70834874955;9843.064908833649;9882.802343952937;9894.703158905244;9972.401655900669;8126.959365203136;8317.376196785144;8339.416240863082;8403.075661677089;8499.617517211616;7988.960055199686;8216.383771217063;8297.170282971896;8319.292860106958;8403.95798021006;7290;7366.521176123535;7457.92542074594;7478.513896596922;7490.812729681802;5354.946450535601;5355.544778693855;5504.394516603251;5521.199426083115;5552.861178470571;5430.972845135749;5437.429069947599;5484.561235101262;5550.0564903965615;5575.7490912909825 10:04:11 INFO - PID 30881 | |4;prototype.html;341.30203733365266;354.71799919064347;355.74030957401095;357.2479929747879;363.79809205890734;5477.643953143053;5593.427023569163;5604.887902241952;5612.691301978394;5644.266245388099;5315.73421328933;5458.68006097408;5472.91790623141;5482.616216864821;5485.204645326426;4072.816723247461;4089.6114869087387;4097.09863829957;4104.768569429174;4111.1366613011305;4010.13782036862;4084.836606535735;4097.487814023247;4098.754074755524;4125.64931980782;4026.3155263605113;4057.8376864925517;4058.686548667261;4068.8982775430554;4071.8982025449454;4022.4971878514893;4032.5362583303004;4037.4953130858494;4041.7979101044975;4088.1414902870433;3472.6006509251506;3514.4728290756334;3531.2407832316176;3531.2584357285;3545.929081418383;5254.973725131388;5316.494932981399;5358;5363.275957745694;5373.032854086263;4788.0663270662235;4808.9179934514805;4812.590929770974;4816.133096042711;4831.855044348676;5641.717914104278;5819.301683797971;5836.9124463133085;5839.328477225088;5846.590738648296;3948.4274780157;3961.445397644332;3961.8613348532663;3961.900952476211;3976.1252524444576;5935.554833387513;6103.877922441527;6152.938470615281;6167.198264225667;6203.9999999999545;4055.087605288845;4066.6580028590492;4072.1448495815616;4075.1849630074103;4081.3469844824685;4134.400511925754;4136.875893723193;4148.56440073794;4154.792260386968;4162.084341444877;4714.528547145258;4802.903941921142;4809.182438985381;4811.735354555463;4824.204006338985;5831.825045248649;5839.270091238595;5844.486870645663;5852.268466441695;5863.824085277449;1419.7506194548937;1432.4457963109935;1435.9353829077716;1436.3033928544648;1439.1221354973459;940.0505489455699;951.3198063384713;960.5245403525299;1064;1102.7077824376547;5002.499750024968;5020.447750747415;5023.095842748267;5047.848564543069;5048.0913435581215;5923.614965027259;6015.909761353583;6063.939360606426;6066.332703402622;6089.786857460056;4806.206975848946;4962.478939711278;4966.255061740768;4966.776495057731;4996.675216110941;3159.462891308483;3190.888318908827;3198.1844629619764;3213.855376508063;3214.1964508872784;5336.279602253724;5487.862803429946;5510.228568000483;5514.255575497336;5528.55771538284;6180.381961803873;6182.6599537024995;6187.628742275478;6219.502439804804;6240.375962403723;5483.314585676791;5491.9725401373535;5495.917561236584;5502.58730595207;5504.944950550604;5937.7921772737745;6009.707912798769;6014.428629280212;6050.273967123973;6065.72704228302;5928.822135335947;5950.9702451487465;5953.255843019622;5953.970230148821;5954.791582294599;5270.446603106619;5427.755750991136;5498.477644623755;5500.367457742411;5515.841673248663;4050.4531888194715;4059.512858457004;4079.4900637420324;4096.508418989741;4098.979505102456;5860.882782344244;5985.533544281679;6045.78839740607;6048.4858787003595;6057.636541807506;5741.569382296428;5787.710614469344;5810.128480727924;5829.621074630136;5831.854203644943;5790.594658373873;5804.332501762351;5807.564432667482;5814.703192238957;5844.288876563498;5628.549716022791;5673.546116310603;5682.977064128331;5704.087346024616;5738.311402631711;5796.913046304225;5828.388019257917;5841.824745257649;5870.148828419769;5904.3800400959;5462.863428414322;5649.604527683023;5665.971670141623;5673.432656734459;5710.65736055838 10:04:11 INFO - PID 30881 | |5;yui.html;694.3299715774277;719.7013239505609;752.3604935804567;753.0436345840783;769.7536788227768;12643.494260229603;12933.353332333392;14437.205953672545;15409.46066887659;15469.38122475101;15733.763993540077;16390.7541386879;16390.918045409755;16402.589935251624;16439;875.3697337916706;899.9775005624846;904.1546154345675;904.7331037344;906.1301150895116;881.8544940084878;887.6493784954971;888.9911100889005;889.3729920406098;894.6913314906346;901.2069378946518;930.7952250504878;948.8861336639613;956.3018996132827;957.4159762544842;922.4050487435634;925.6852670092201;928.0626567167142;928.3687092776909;929.0245242495387;681.0703389872788;683.8085336105898;683.8153698501377;684.3567046975827;686.2382755141789;14781;14811.777823332659;14915;15008.324625391884;15085.698286034218;16063.196840158062;16344;16903;16912.492625221264;16973.15134243283;12957.676058098528;13271.535496257584;13625.863741362558;13788.379522921492;13805.861941380557;3084.7686423518326;3096.628404591441;3099.891503797379;3100.0234925998466;3114.2837147455984;78454.21545784526;80690.59654701689;81537.59231203866;81753.59123204346;81864.59067704683;12501.624951251477;12964.611061668165;13085.803712944313;13304.135231210133;13426.328683565782;24092.638610420858;24275.150369736974;24564.385890352885;24626;24643.87678061634;6157.138000679908;6215.844603884849;6219.844503887439;6560.8359791005605;6761.22245941723;3144.402563512971;3187.856546455415;3192.393445245396;3203.919902002422;3212.421764082441;3811.294910441577;3853.0560012797046;3910.393888947218;3910.648041676263;3918.549366822795;792.7938735928585;833.4957350802798;839.7606682095574;845.3068483843313;846.3863698818308;577.1371799160198;581.0876923230572;581.3953488372131;584.1529781816383;608.984775380619;10051.346662466916;10161.593536258615;10286.228532860065;11032.338059716443;11242.550297988153;579.3887448741618;594.47983014862;595.312414161644;601.1703848688782;604.6130476495047;4515.525869783691;4655.6973796703105;4675.883102922454;4710.88222794426;4735.360726301974;89463.55268223748;89544;89806.39396346203;91404.54297728468;93318.53340733254;78011;78880;79358.20641793624;80880.59559702281;81198.18801812024;68275;68689.65655171692;69120.6543967277;69570;69825;8767.254783343487;9164.266858651425;9181.173694367539;9204.125608067223;9445.527723613654;29899.252518687208;30035.399292014474;30065;30297.848510758187;30301.848490757406;38009;38173.42739858849;38306.425403618414;38505.42241866318;38516.6148338513;14580.489682861049;14960.326785294905;14969.326380312694;15157.621059473602;15290;16410.261538231047;16627.66744665124;16982.23579938881;17437.21532531014;17461.738073928645;15025.173615451255;15722.921385393;16091;16120.113393763455;16320.18399080065;15558.61103472377;16012;16067.919660401623;16164.272607732444;16325.102119383548;14486.058406203563;15224.391024359345;15398.230088495306;15914.442994495137;16063.919680401523;10070.395776253448;10709.946450267698;10947.83578246311;11065.557377704801;11465.828012579652;11716.882831171579;11766;12517.749645006867;12591.622251332476;12639.557615483414 10:04:11 INFO - PID 30881 | __end_tp_report 10:04:11 INFO - PID 30881 | __start_cc_report 10:04:11 INFO - PID 30881 | _x_x_mozilla_cycle_collect,382 10:04:11 INFO - PID 30881 | __end_cc_report 10:04:11 INFO - PID 30881 | __startTimestamp1496163851690__endTimestamp 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | ------- Summary: start ------- 10:04:11 INFO - PID 30881 | Number of tests: 6 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | [#0] dojo.html Cycles:165 Average:5287.04 Median:5441.89 stddev:646.31 (11.9%) stddev-sans-first:614.85 10:04:11 INFO - PID 30881 | Values: 2671.3 2689.4 2701.1 2727.5 2727.6 5267.1 5333.5 5367.5 5397.3 5434.2 5283.0 5317.9 5356.1 5375.7 5385.9 4463.5 4681.1 4736.1 4777.7 4799.1 4794.6 4849.0 4853.2 4859.1 4864.7 4681.5 4732.5 4755.8 4773.8 4799.0 4727.1 4798.1 4804.6 4809.6 4814.0 4705.0 4712.1 4721.0 4725.8 4787.2 5334.1 5335.1 5350.0 5378.4 5396.7 5668.5 5729.7 5739.7 5755.6 5759.9 5916.8 5932.3 5945.4 5958.1 5973.1 5430.6 5441.9 5448.4 5463.3 5464.8 5866.9 5909.3 6034.2 6043.3 6050.2 5626.7 5714.1 5719.6 5740.6 5762.6 5714.7 5827.3 5845.1 5850.4 5852.3 5654.0 5741.4 5805.9 5808.1 5810.1 5713.0 5722.0 5741.5 5786.4 5801.8 4856.0 4861.7 4863.8 4877.6 4905.3 4135.7 4135.7 4142.6 4174.0 4218.2 4766.8 4821.5 4825.2 4881.5 4890.8 5864.0 5881.3 5882.0 5882.7 5902.4 4832.6 4878.1 4881.3 4884.1 4893.4 5134.1 5136.3 5144.6 5147.2 5160.4 5193.7 5243.0 5260.7 5292.6 5322.9 5695.2 5762.9 5769.0 5878.1 5933.6 5242.7 5308.8 5328.3 5329.0 5340.8 5619.9 5733.3 5737.2 5738.5 5746.8 5754.5 5878.8 5879.8 5882.4 5882.6 5604.3 5630.7 5642.4 5729.1 5733.7 5604.5 5659.4 5685.9 5691.9 5702.5 5503.4 5522.8 5523.9 5572.4 5576.0 5566.4 5584.8 5698.8 5702.0 5706.3 5440.9 5442.2 5514.7 5528.1 5555.2 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | [#1] ext.html Cycles:180 Average:30671.14 Median:17294.41 stddev:40485.75 (234.1%) stddev-sans-first:40536.73 10:04:11 INFO - PID 30881 | Values: 691.0 750.8 762.3 1084.8 1106.8 34321.3 35243.3 35292.0 35292.8 35368.6 36153.8 36557.0 36564.5 36572.8 36581.8 6784.5 6907.0 6953.9 7057.3 7058.8 6873.9 6952.4 7005.4 7006.8 7014.0 6913.7 6985.8 7012.2 7012.5 7018.0 6964.3 6991.7 7003.3 7018.8 7019.4 6807.7 6873.3 6877.9 6883.3 6889.0 33642.5 33751.2 33793.0 33840.2 33898.7 3140.5 3166.8 3182.3 3184.2 3187.4 25479.2 25787.2 25833.0 25851.5 25875.1 3095.9 3106.1 3120.0 3122.0 3134.7 126219.1 128488.0 138710.0 150990.0 151198.2 41773.6 41817.0 41826.4 41852.8 41873.0 43266.8 43474.0 43509.6 43566.3 43772.8 11675.9 11766.4 11813.8 11846.5 11887.9 9332.0 9337.3 9364.3 9365.1 9397.2 13143.6 13143.7 13160.5 13175.2 13291.0 5533.4 5572.7 5581.0 5608.9 5667.6 872.1 910.3 915.5 918.1 940.7 20518.5 20635.9 21918.7 22202.0 22270.4 985.2 986.3 989.7 1004.8 1008.9 10948.8 11589.6 11647.4 11684.9 11705.4 172926.0 173203.0 174418.0 174741.0 175007.0 42755.0 43028.4 43207.0 43228.0 43298.4 1182.1 1243.1 1244.5 1244.5 1247.3 19946.3 20836.5 21532.5 21547.4 21637.1 30785.8 30880.8 30912.8 31093.7 31176.2 153874.2 155123.0 155218.0 155251.0 155260.2 29486.4 29594.7 29635.7 30405.7 30569.7 37074.0 37199.3 37662.8 37810.4 37813.4 26676.9 27899.0 28123.7 28150.0 28999.6 27595.4 27681.7 28698.1 28797.0 28798.4 31422.0 31841.7 31879.8 31891.2 31940.0 26861.7 27272.9 27988.2 28326.3 28958.4 22253.3 22967.5 23092.2 23103.5 23210.9 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | [#2] jquery.html Cycles:180 Average:24994.33 Median:38609.44 stddev:61819.69 (160.1%) stddev-sans-first:61965.53 10:04:11 INFO - PID 30881 | Values: 400.9 409.2 413.3 429.3 432.4 12956.0 16603.6 17469.0 18028.5 18065.0 16804.6 16839.2 17038.5 17406.7 17550.7 5459.7 5621.2 5657.5 5671.9 5675.7 5305.0 5451.3 5478.2 5492.4 5496.6 5445.8 5450.8 5454.8 5456.2 5473.5 5304.4 5473.4 5518.7 5522.7 5540.2 4952.0 4967.9 4968.0 4970.2 4978.0 21306.3 21922.1 21942.3 22174.1 22244.2 1614.8 1654.2 1663.5 1663.7 1670.0 14337.9 14643.3 14913.8 15150.5 15291.6 2024.4 2058.9 2076.6 2088.5 2119.4 86702.6 87869.6 89807.0 96494.0 100207.0 10746.1 10764.3 10940.3 11148.7 11177.5 14269.5 15076.4 15174.8 15240.5 15277.8 7392.2 7431.1 7503.3 7550.4 7584.5 6927.9 6946.4 7078.5 7142.0 7179.6 6698.0 6765.3 6809.2 6884.0 6910.5 1996.2 2021.7 2029.6 2057.7 2191.5 836.6 862.3 884.6 892.4 900.4 17039.7 17089.3 17178.7 17541.4 17891.9 870.3 874.2 879.6 886.1 901.6 9044.1 9201.4 9437.3 9569.6 9603.4 366612.0 367495.4 368380.0 370612.0 376219.0 79798.2 81498.0 81643.0 82651.0 82745.6 1080.7 1085.1 1094.0 1104.9 1107.3 14411.4 14554.7 14685.9 14710.5 15203.3 38351.2 38534.2 38684.6 39909.0 39985.2 48242.0 48613.5 49660.8 50878.0 51109.7 7942.9 8116.0 8216.2 8218.4 8261.1 12186.5 12333.2 12359.4 12801.5 13218.9 9356.3 10064.5 10267.8 10317.7 10490.9 9104.2 9782.0 9940.6 10170.2 10283.1 10164.7 10394.8 10574.8 10753.0 10858.8 7892.0 7996.4 11435.9 11743.9 11917.0 9112.6 10102.0 10705.9 11197.6 11463.5 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | [#3] mootools.html Cycles:180 Average:6395.24 Median:3733.05 stddev:4165.26 (111.6%) stddev-sans-first:4158.70 10:04:11 INFO - PID 30881 | Values: 1207.6 1261.7 1262.6 1265.2 1282.6 10122.2 10421.7 10435.6 10481.1 10703.7 10437.5 10567.6 10613.6 10623.8 10629.4 1952.9 1992.5 1994.8 2001.7 2010.3 1945.5 1984.6 1994.5 1996.4 2002.3 1941.2 1952.9 1959.1 1960.2 1960.9 1920.6 1925.1 1928.0 1929.3 1931.7 1904.6 1922.9 1976.3 1977.9 1984.3 10300.6 10385.6 10389.9 10396.3 10413.1 5427.3 5613.8 5614.9 5621.1 5633.4 3280.9 3394.9 3437.3 3437.5 3453.4 1121.3 1138.1 1150.1 1172.7 1181.7 14021.5 14486.2 15058.7 15197.6 15235.2 4694.0 4758.5 4907.6 4951.7 4955.7 11372.6 11381.4 11401.0 11442.9 11455.1 5613.5 5659.0 5683.2 5687.1 5692.7 5229.3 5240.6 5266.9 5278.4 5286.4 3716.9 3749.2 3785.9 3828.1 3853.3 1084.4 1092.6 1099.1 1108.4 1110.5 722.7 731.7 736.2 745.4 752.4 5720.2 5756.3 5867.9 5913.5 5916.5 825.2 845.7 855.2 856.7 861.7 3944.5 3991.9 4018.8 4025.7 4031.9 13042.9 13860.3 13869.7 13942.9 13980.5 13489.7 13609.5 13655.9 13718.5 13773.2 7229.9 7488.7 7586.1 7605.5 7647.7 6131.4 6178.4 6310.6 6311.9 6405.9 11913.5 12269.6 12305.0 12370.5 12427.1 12194.2 12321.8 12409.2 12428.1 12614.9 8549.8 8722.0 8730.2 8752.5 8781.7 9721.7 9843.1 9882.8 9894.7 9972.4 8127.0 8317.4 8339.4 8403.1 8499.6 7989.0 8216.4 8297.2 8319.3 8404.0 7290.0 7366.5 7457.9 7478.5 7490.8 5354.9 5355.5 5504.4 5521.2 5552.9 5431.0 5437.4 5484.6 5550.1 5575.7 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | [#4] prototype.html Cycles:180 Average:4753.40 Median:5443.22 stddev:1427.16 (26.2%) stddev-sans-first:1392.21 10:04:11 INFO - PID 30881 | Values: 341.3 354.7 355.7 357.2 363.8 5477.6 5593.4 5604.9 5612.7 5644.3 5315.7 5458.7 5472.9 5482.6 5485.2 4072.8 4089.6 4097.1 4104.8 4111.1 4010.1 4084.8 4097.5 4098.8 4125.6 4026.3 4057.8 4058.7 4068.9 4071.9 4022.5 4032.5 4037.5 4041.8 4088.1 3472.6 3514.5 3531.2 3531.3 3545.9 5255.0 5316.5 5358.0 5363.3 5373.0 4788.1 4808.9 4812.6 4816.1 4831.9 5641.7 5819.3 5836.9 5839.3 5846.6 3948.4 3961.4 3961.9 3961.9 3976.1 5935.6 6103.9 6152.9 6167.2 6204.0 4055.1 4066.7 4072.1 4075.2 4081.3 4134.4 4136.9 4148.6 4154.8 4162.1 4714.5 4802.9 4809.2 4811.7 4824.2 5831.8 5839.3 5844.5 5852.3 5863.8 1419.8 1432.4 1435.9 1436.3 1439.1 940.1 951.3 960.5 1064.0 1102.7 5002.5 5020.4 5023.1 5047.8 5048.1 5923.6 6015.9 6063.9 6066.3 6089.8 4806.2 4962.5 4966.3 4966.8 4996.7 3159.5 3190.9 3198.2 3213.9 3214.2 5336.3 5487.9 5510.2 5514.3 5528.6 6180.4 6182.7 6187.6 6219.5 6240.4 5483.3 5492.0 5495.9 5502.6 5504.9 5937.8 6009.7 6014.4 6050.3 6065.7 5928.8 5951.0 5953.3 5954.0 5954.8 5270.4 5427.8 5498.5 5500.4 5515.8 4050.5 4059.5 4079.5 4096.5 4099.0 5860.9 5985.5 6045.8 6048.5 6057.6 5741.6 5787.7 5810.1 5829.6 5831.9 5790.6 5804.3 5807.6 5814.7 5844.3 5628.5 5673.5 5683.0 5704.1 5738.3 5796.9 5828.4 5841.8 5870.1 5904.4 5462.9 5649.6 5666.0 5673.4 5710.7 10:04:11 INFO - PID 30881 | 10:04:11 INFO - PID 30881 | [#5] yui.html Cycles:180 Average:18114.56 Median:20910.15 stddev:23752.45 (113.6%) stddev-sans-first:23783.07 10:04:11 INFO - PID 30881 | Values: 694.3 719.7 752.4 753.0 769.8 12643.5 12933.4 14437.2 15409.5 15469.4 15733.8 16390.8 16390.9 16402.6 16439.0 875.4 900.0 904.2 904.7 906.1 881.9 887.6 889.0 889.4 894.7 901.2 930.8 948.9 956.3 957.4 922.4 925.7 928.1 928.4 929.0 681.1 683.8 683.8 684.4 686.2 14781.0 14811.8 14915.0 15008.3 15085.7 16063.2 16344.0 16903.0 16912.5 16973.2 12957.7 13271.5 13625.9 13788.4 13805.9 3084.8 3096.6 3099.9 3100.0 3114.3 78454.2 80690.6 81537.6 81753.6 81864.6 12501.6 12964.6 13085.8 13304.1 13426.3 24092.6 24275.2 24564.4 24626.0 24643.9 6157.1 6215.8 6219.8 6560.8 6761.2 3144.4 3187.9 3192.4 3203.9 3212.4 3811.3 3853.1 3910.4 3910.6 3918.5 792.8 833.5 839.8 845.3 846.4 577.1 581.1 581.4 584.2 609.0 10051.3 10161.6 10286.2 11032.3 11242.6 579.4 594.5 595.3 601.2 604.6 4515.5 4655.7 4675.9 4710.9 4735.4 89463.6 89544.0 89806.4 91404.5 93318.5 78011.0 78880.0 79358.2 80880.6 81198.2 68275.0 68689.7 69120.7 69570.0 69825.0 8767.3 9164.3 9181.2 9204.1 9445.5 29899.3 30035.4 30065.0 30297.8 30301.8 38009.0 38173.4 38306.4 38505.4 38516.6 14580.5 14960.3 14969.3 15157.6 15290.0 16410.3 16627.7 16982.2 17437.2 17461.7 15025.2 15722.9 16091.0 16120.1 16320.2 15558.6 16012.0 16067.9 16164.3 16325.1 14486.1 15224.4 15398.2 15914.4 16063.9 10070.4 10709.9 10947.8 11065.6 11465.8 11716.9 11766.0 12517.7 12591.6 12639.6 10:04:11 INFO - PID 30881 | -------- Summary: end -------- 10:04:11 INFO - PID 30881 | 10:04:12 INFO - TEST-INFO | 30881: exit 0 10:04:12 INFO - TEST-OK | dromaeo_css | took 1147710ms 10:04:12 INFO - TEST-START | kraken 10:04:12 INFO - operating with platform_type : linux_ 10:04:12 INFO - Initialising browser for kraken test... 10:04:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53987/getInfo.html -profile /tmp/tmpekFczy/profile 10:04:12 INFO - TEST-INFO | started process 31289 (/builds/slave/test/build/application/firefox/firefox http://localhost:53987/getInfo.html) 10:04:48 INFO - TEST-INFO | 31289: killed by SIGTERM 10:04:48 INFO - Browser initialized. 10:04:48 INFO - Running cycle 1/1 for kraken test... 10:04:48 INFO - TEST-INFO | started process 31487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpekFczy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:00 INFO - PID 31487 | RSS: Main: 182538240 10:05:00 INFO - PID 31487 | 10:05:03 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53987/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:04 INFO - PID 31487 | RSS: Main: 186032128 10:05:04 INFO - PID 31487 | 10:05:06 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53987/tests/kraken/driver.html?testName=audio-dft) 10:05:07 INFO - PID 31487 | RSS: Main: 185262080 10:05:07 INFO - PID 31487 | 10:05:10 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53987/tests/kraken/driver.html?testName=audio-fft) 10:05:11 INFO - PID 31487 | RSS: Main: 181514240 10:05:11 INFO - PID 31487 | 10:05:13 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53987/tests/kraken/driver.html?testName=audio-oscillator) 10:05:13 INFO - PID 31487 | RSS: Main: 182026240 10:05:13 INFO - PID 31487 | 10:05:15 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:16 INFO - PID 31487 | RSS: Main: 182157312 10:05:16 INFO - PID 31487 | 10:05:19 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53987/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:20 INFO - PID 31487 | RSS: Main: 182980608 10:05:20 INFO - PID 31487 | 10:05:23 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53987/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:24 INFO - PID 31487 | RSS: Main: 181858304 10:05:24 INFO - PID 31487 | 10:05:27 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53987/tests/kraken/driver.html?testName=json-parse-financial) 10:05:28 INFO - PID 31487 | RSS: Main: 182702080 10:05:28 INFO - PID 31487 | 10:05:29 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:30 INFO - PID 31487 | RSS: Main: 182874112 10:05:30 INFO - PID 31487 | 10:05:32 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:32 INFO - PID 31487 | RSS: Main: 182620160 10:05:32 INFO - PID 31487 | 10:05:34 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:35 INFO - PID 31487 | RSS: Main: 182775808 10:05:35 INFO - PID 31487 | 10:05:38 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:39 INFO - PID 31487 | RSS: Main: 182792192 10:05:39 INFO - PID 31487 | 10:05:42 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:42 INFO - PID 31487 | RSS: Main: 182816768 10:05:42 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | Cycle 1(1): loaded http://localhost:53987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53987/tests/kraken/driver.html?testName=ai-astar) 10:05:44 INFO - PID 31487 | RSS: Main: 184508416 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | __start_tp_report 10:05:44 INFO - PID 31487 | _x_x_mozilla_page_load 10:05:44 INFO - PID 31487 | _x_x_mozilla_page_load_details 10:05:44 INFO - PID 31487 | |i|pagename|runs| 10:05:44 INFO - PID 31487 | |0;ai-astar;103;111;111;111;112;113;111;112;112;115 10:05:44 INFO - PID 31487 | |1;audio-beat-detection;152;127;126;167;127;122;127;126;147;127 10:05:44 INFO - PID 31487 | |2;audio-dft;164;165;163;167;168;168;167;165;164;163 10:05:44 INFO - PID 31487 | |3;audio-fft;78;75;77;107;75;75;74;76;92;74 10:05:44 INFO - PID 31487 | |4;audio-oscillator;85;84;100;84;84;83;102;84;84;112 10:05:44 INFO - PID 31487 | |5;imaging-gaussian-blur;118;115;114;114;115;114;115;113;114;114 10:05:44 INFO - PID 31487 | |6;imaging-darkroom;150;151;150;152;150;151;150;150;150;150 10:05:44 INFO - PID 31487 | |7;imaging-desaturate;95;95;94;94;94;94;94;95;94;95 10:05:44 INFO - PID 31487 | |8;json-parse-financial;55;55;55;55;58;57;56;58;56;56 10:05:44 INFO - PID 31487 | |9;json-stringify-tinderbox;56;56;56;57;56;56;57;57;59;55 10:05:44 INFO - PID 31487 | |10;stanford-crypto-aes;86;88;86;87;87;87;87;87;130;86 10:05:44 INFO - PID 31487 | |11;stanford-crypto-ccm;149;150;133;137;134;132;133;141;134;130 10:05:44 INFO - PID 31487 | |12;stanford-crypto-pbkdf2;189;192;191;195;190;194;192;194;200;192 10:05:44 INFO - PID 31487 | |13;stanford-crypto-sha256-iterative;74;75;73;73;76;70;76;72;74;70 10:05:44 INFO - PID 31487 | __end_tp_report 10:05:44 INFO - PID 31487 | __start_cc_report 10:05:44 INFO - PID 31487 | _x_x_mozilla_cycle_collect,1031 10:05:44 INFO - PID 31487 | __end_cc_report 10:05:44 INFO - PID 31487 | __startTimestamp1496163944852__endTimestamp 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | ------- Summary: start ------- 10:05:44 INFO - PID 31487 | Number of tests: 14 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.11 (2.8%) stddev-sans-first:1.32 10:05:44 INFO - PID 31487 | Values: 103.0 111.0 111.0 111.0 112.0 113.0 111.0 112.0 112.0 115.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:127.00 stddev:15.07 (11.9%) stddev-sans-first:14.64 10:05:44 INFO - PID 31487 | Values: 152.0 127.0 126.0 167.0 127.0 122.0 127.0 126.0 147.0 127.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:1.96 (1.2%) stddev-sans-first:2.01 10:05:44 INFO - PID 31487 | Values: 164.0 165.0 163.0 167.0 168.0 168.0 167.0 165.0 164.0 163.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.50 stddev:10.79 (14.3%) stddev-sans-first:11.41 10:05:44 INFO - PID 31487 | Values: 78.0 75.0 77.0 107.0 75.0 75.0 74.0 76.0 92.0 74.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:10.44 (12.4%) stddev-sans-first:10.91 10:05:44 INFO - PID 31487 | Values: 85.0 84.0 100.0 84.0 84.0 83.0 102.0 84.0 84.0 112.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:0.67 10:05:44 INFO - PID 31487 | Values: 118.0 115.0 114.0 114.0 115.0 114.0 115.0 113.0 114.0 114.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:05:44 INFO - PID 31487 | Values: 150.0 151.0 150.0 152.0 150.0 151.0 150.0 150.0 150.0 150.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:05:44 INFO - PID 31487 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.20 10:05:44 INFO - PID 31487 | Values: 55.0 55.0 55.0 55.0 58.0 57.0 56.0 58.0 56.0 56.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:1.08 (1.9%) stddev-sans-first:1.13 10:05:44 INFO - PID 31487 | Values: 56.0 56.0 56.0 57.0 56.0 56.0 57.0 57.0 59.0 55.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:87.00 stddev:13.68 (15.7%) stddev-sans-first:14.39 10:05:44 INFO - PID 31487 | Values: 86.0 88.0 86.0 87.0 87.0 87.0 87.0 87.0 130.0 86.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.50 stddev:7.09 (5.2%) stddev-sans-first:6.12 10:05:44 INFO - PID 31487 | Values: 149.0 150.0 133.0 137.0 134.0 132.0 133.0 141.0 134.0 130.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.90 Median:193.00 stddev:3.11 (1.6%) stddev-sans-first:2.96 10:05:44 INFO - PID 31487 | Values: 189.0 192.0 191.0 195.0 190.0 194.0 192.0 194.0 200.0 192.0 10:05:44 INFO - PID 31487 | 10:05:44 INFO - PID 31487 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:2.16 (2.9%) stddev-sans-first:2.28 10:05:44 INFO - PID 31487 | Values: 74.0 75.0 73.0 73.0 76.0 70.0 76.0 72.0 74.0 70.0 10:05:44 INFO - PID 31487 | -------- Summary: end -------- 10:05:44 INFO - PID 31487 | 10:05:46 INFO - TEST-INFO | 31487: exit 0 10:05:46 INFO - TEST-OK | kraken | took 93424ms 10:05:46 INFO - SUITE-END | took 1241s 10:05:46 INFO - Completed test suite (00:20:41) 10:05:46 INFO - javascript benchmark 10:05:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6842.597175539408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2671.3455203475146, 2689.354554906823, 2701.135636596289, 2727.5499542575476, 2727.645406097207, 5267.078261304266, 5333.546648534874, 5367.543758780498, 5397.298351214336, 5434.184872269162, 5283.049051170788, 5317.9468205317935, 5356.062689029414, 5375.6774593524415, 5385.892282154355, 4463.4866990296205, 4681.110588988098, 4736.147493451177, 4777.713337199762, 4799.088173247089, 4794.640401969848, 4849.0301939612045, 4853.174960256747, 4859.1010663027455, 4864.659473836833, 4681.485036645966, 4732.455767586737, 4755.83354582588, 4773.785179666923, 4798.976005119952, 4727.149113159629, 4798.112349215371, 4804.567588917014, 4809.615230781564, 4813.951860481386, 4704.976475117637, 4712.128256272601, 4721.0, 4725.787339569728, 4787.234042553175, 5334.093204155303, 5335.1197052486295, 5350.0, 5378.354597448292, 5396.703181325026, 5668.461496157858, 5729.742161602738, 5739.741711622945, 5755.597108202427, 5759.884802303931, 5916.792912248051, 5932.288125424977, 5945.405459454063, 5958.106284057383, 5973.133895585159, 5430.647007944471, 5441.891162176735, 5448.400675925645, 5463.289772329572, 5464.836054918359, 5866.882662346729, 5909.349971503131, 6034.155218269446, 6043.2748070231855, 6050.213472248667, 5626.662400255997, 5714.085746280575, 5719.5996280260815, 5740.56945729072, 5762.596618236683, 5714.657120572779, 5827.3298570664065, 5845.09401042839, 5850.444207800252, 5852.297724273115, 5654.038813401731, 5741.425857414309, 5805.94194058054, 5808.070708686674, 5810.0994345875615, 5712.971435142797, 5721.998650236275, 5741.45456181662, 5786.392428795, 5801.767929282866, 4856.0, 4861.7326047067045, 4863.756812159378, 4877.585405240523, 4905.3132561441425, 4135.6898232632675, 4135.710500264952, 4142.5857414258335, 4174.0, 4218.2196293685765, 4766.785494652749, 4821.493743156988, 4825.1555977703765, 4881.4630390657, 4890.828820991248, 5864.0031194697, 5881.294244690579, 5881.9705901470215, 5882.676452795137, 5902.409759024149, 4832.565069143794, 4878.07316609843, 4881.267809828554, 4884.145274576935, 4893.388326459192, 5134.05020071288, 5136.255242989746, 5144.588432925357, 5147.176451767774, 5160.354955630546, 5193.7403129844115, 5243.030039442715, 5260.658057226268, 5292.629515933848, 5322.866928326823, 5695.231143795535, 5762.855928601818, 5769.0, 5878.059510478303, 5933.614315069507, 5242.737863106753, 5308.814191503279, 5328.307320048369, 5329.0, 5340.786368545215, 5619.8595035124445, 5733.3406658234835, 5737.196792449144, 5738.512226460798, 5746.7701291949525, 5754.53963682896, 5878.794242201502, 5879.823605291848, 5882.382349853204, 5882.647041177543, 5604.271444712162, 5630.662160270397, 5642.407547207484, 5729.140628905698, 5733.655980641175, 5604.523615492729, 5659.434056594308, 5685.857853553694, 5691.914621280767, 5702.51528620072, 5503.449655034465, 5522.834314970557, 5523.917141242804, 5572.4148964358155, 5576.0, 5566.359868614999, 5584.804531841366, 5698.800541981011, 5702.0, 5706.258186435737, 5440.891182176255, 5442.238086667949, 5514.6691198528215, 5528.06022976087, 5555.166724991283], "value": 5237.844089200247, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.9723611055558, 750.8460765543063, 762.2834535536597, 1084.766775143344, 1106.8395082713002, 34321.31357372851, 35243.2951340973, 35292.0, 35292.823535882315, 35368.646313536854, 36153.81923090387, 36557.0, 36564.45153322696, 36572.81713591428, 36581.817090914505, 6784.525083244175, 6907.033015377839, 6953.930460695404, 7057.294270572927, 7058.788236352918, 6873.896891546631, 6952.374286314231, 7005.404540614054, 7006.789796306093, 7013.964930175342, 6913.688884000207, 6985.755498557552, 7012.193597736249, 7012.544184628008, 7018.0, 6964.303569643046, 6991.685374158175, 7003.264657211022, 7018.789436316919, 7019.3682568569075, 6807.693653785592, 6873.347032031949, 6877.862442751167, 6883.346082122191, 6888.965555172192, 33642.49536256934, 33751.156221094425, 33793.0, 33840.15399615029, 33898.6610133898, 3140.450421176308, 3166.8258245796474, 3182.3317103408313, 3184.1721152500286, 3187.442197615408, 25479.23562293134, 25787.226383208534, 25833.0, 25851.482970340487, 25875.094371697087, 3095.891643792479, 3106.1147572941827, 3120.0171945836987, 3122.032170027299, 3134.6865313468697, 126219.10671339938, 128488.0, 138709.99999999898, 150990.0, 151198.24400878034, 41773.58226417697, 41817.0, 41826.37260441096, 41852.790736046125, 41873.0, 43266.7836660821, 43474.0, 43509.564904350555, 43566.34650480245, 43772.78113609411, 11675.88324116748, 11766.352850593128, 11813.763724725457, 11846.526138954518, 11887.88112118885, 9332.0, 9337.346385752931, 9364.25085993119, 9365.063493650716, 9397.201237894718, 13143.605691829069, 13143.67140821468, 13160.539381121614, 13175.209487430784, 13291.0, 5533.391326954032, 5572.665640061609, 5581.0, 5608.9439105609235, 5667.631603945731, 872.1148034744739, 910.2945217456391, 915.4507295622707, 918.0727465260002, 940.6660635474308, 20518.487037824172, 20635.8968205161, 21918.671219931715, 22202.0, 22270.443238919157, 985.2216748768393, 986.2701600815345, 989.6536212325628, 1004.8141093897652, 1008.8738907636546, 10948.781024379468, 11589.594364197214, 11647.359395233343, 11684.88315116855, 11705.414729263674, 172926.0, 173203.0, 174418.0, 174741.0, 175007.0, 42755.0, 43028.354574681405, 43207.0, 43228.0, 43298.35052474152, 1182.1344204451568, 1243.0801207106676, 1244.520859469111, 1244.5457408045997, 1247.3326770177912, 19946.30187943415, 20836.47908802292, 21532.461688457286, 21547.353579392642, 21637.13451461987, 30785.8460707695, 30880.845595771876, 30912.845435773575, 31093.68906310908, 31176.22059448532, 153874.23062884613, 155123.0, 155218.0, 155251.0, 155260.22369888079, 29486.410271794874, 29594.704052960056, 29635.703642964156, 30405.695943040286, 30569.694303056684, 37074.0, 37199.25601488009, 37662.81168594139, 37810.43284350682, 37813.43279850749, 26676.866615667575, 27899.0, 28123.71876281293, 28150.0, 28999.56500652534, 27595.44809103847, 27681.723182767913, 28698.13905582836, 28797.0, 28798.424031518833, 31422.0, 31841.681583183872, 31879.840600796848, 31891.202719931258, 31940.0, 26861.731382685924, 27272.863635681693, 27988.16035518938, 28326.291842704097, 28958.42083158283, 22253.332400028026, 22967.540649186587, 23092.228932528204, 23103.53792924166, 23210.883945580164], "value": 14766.090178388622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.8737247766955, 409.22656179820143, 413.34691187923084, 429.3323881364478, 432.398965438041, 12956.0, 16603.584910377245, 17469.03920284384, 18028.54928626785, 18065.0, 16804.57988550287, 16839.242234099464, 17038.50710604323, 17406.738898916527, 17550.736738948926, 5459.727013649322, 5621.156826476041, 5657.547396208314, 5671.943280567203, 5675.659460432366, 5305.0, 5451.291332126838, 5478.178273259023, 5492.395836457987, 5496.615236933416, 5445.782168713266, 5450.809221677242, 5454.836354909339, 5456.208849716789, 5473.452654734515, 5304.443033481487, 5473.397926228132, 5518.724063796834, 5522.723863806794, 5540.196671482653, 4951.950480495185, 4967.850964471072, 4967.975160124176, 4970.179920313144, 4977.975110124463, 21306.254281100242, 21922.123115075377, 21942.341729748132, 22174.11303547856, 22244.221452249254, 1614.7981502312211, 1654.2307826860447, 1663.534210421072, 1663.6506333669943, 1670.0313817985539, 14337.856621433757, 14643.34104965279, 14913.776293355608, 15150.469733559383, 15291.617709557238, 2024.3522072936667, 2058.8661736987196, 2076.646970015101, 2088.5405210853587, 2119.4065661614773, 86702.56648716779, 87869.56065219697, 89807.0, 96494.0, 100207.0, 10746.140308775279, 10764.300320479144, 10940.288881222696, 11148.665540033811, 11177.49701263445, 14269.500567480089, 15076.39694412233, 15174.848251517344, 15240.542783716506, 15277.847221527865, 7392.186859445456, 7431.108267007886, 7503.287187717158, 7550.395968322521, 7584.5070070445245, 6927.861442771116, 6946.444284457332, 7078.469114816409, 7142.035825163641, 7179.641017949186, 6697.966510167418, 6765.255821859591, 6809.216940051958, 6884.0, 6910.516263861481, 1996.2314508914174, 2021.7270668459864, 2029.6448121578665, 2057.6501994660944, 2191.4959559301133, 836.6486075848159, 862.3015357560396, 884.5754038061638, 892.3575025981283, 900.3742399032609, 17039.744403833953, 17089.31642734277, 17178.74231886523, 17541.386051488393, 17891.910540447214, 870.2689740617911, 874.1957399192758, 879.6437442835662, 886.1448702002598, 901.6483571407157, 9044.095590440904, 9201.447913125234, 9437.339386243035, 9569.61721531145, 9603.423794572349, 366612.0, 367495.3547758853, 368380.0, 370612.0, 376219.0, 79798.20201798023, 81498.0, 81643.0, 82651.0, 82745.58627206825, 1080.713610893114, 1085.1318944844093, 1094.0, 1104.9060829829393, 1107.2802678259195, 14411.42354305816, 14554.708905822035, 14685.926570367079, 14710.485133020293, 15203.315850786963, 38351.23297533978, 38534.22931541409, 38684.64603738856, 39909.0, 39985.2002959945, 48242.03515929591, 48613.51386486231, 49660.751696241285, 50878.0, 51109.744451277504, 7942.920570794218, 8115.959420203098, 8216.234583941181, 8218.383621228311, 8261.09127995932, 12186.451609677408, 12333.198342107735, 12359.443825028075, 12801.48794048265, 13218.933905330412, 9356.345055846026, 10064.496775161359, 10267.794644106927, 10317.690469285933, 10490.947545262225, 9104.180623743894, 9781.951090244504, 9940.552675129782, 10170.237232207466, 10283.12593429567, 10164.745881353025, 10394.844077338696, 10574.84137737919, 10753.0, 10858.782824343627, 7892.0, 7996.440249182501, 11435.942820285845, 11743.88256117428, 11917.0, 9112.589933452879, 10102.040306170902, 10705.89294107049, 11197.552097915992, 11463.541458341573], "value": 8782.092870761333, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1207.6256360528237, 1261.7098067444488, 1262.5833474953267, 1265.1966001588987, 1282.6023932580897, 10122.240831937606, 10421.687349379512, 10435.582576696932, 10481.056704896559, 10703.678889633304, 10437.478126093683, 10567.630132945349, 10613.57545698171, 10623.78752424951, 10629.362238265709, 1952.8632995690307, 1992.5417154054576, 1994.7805741368438, 2001.7097520859468, 2010.346637342862, 1945.5136215946013, 1984.6130004649099, 1994.481434826948, 1996.3711430899293, 2002.2791794953805, 1941.1555973151653, 1952.8828270303757, 1959.098814545311, 1960.2453055573635, 1960.92156313748, 1920.5582715975265, 1925.0663428237294, 1927.951801204967, 1929.305450037985, 1931.7199006144172, 1904.5809921817179, 1922.8750131241425, 1976.3280484635293, 1977.8615496915222, 1984.335247692025, 10300.639477618248, 10385.63650272237, 10389.896101038968, 10396.32423892452, 10413.114885234763, 5427.348718153847, 5613.803516876889, 5614.859628509279, 5621.072523033695, 5633.436656334334, 3280.934381312384, 3394.932101357984, 3437.3125374924866, 3437.535932649085, 3453.4129198036394, 1121.293585041427, 1138.1179585820971, 1150.0569532982956, 1172.6657902497748, 1181.6986668399504, 14021.509247176402, 14486.20325882076, 15058.698826023528, 15197.6200594986, 15235.162066086361, 4693.9765301173275, 4758.452777930513, 4907.631927605444, 4951.702897826142, 4955.677880937727, 11372.601958931398, 11381.430928453545, 11401.0, 11442.885571144348, 11455.140864435201, 5613.494785469327, 5659.0, 5683.232763576864, 5687.061634830289, 5692.743826527816, 5229.267902493654, 5240.6069544784295, 5266.868328291746, 5278.392984806719, 5286.418493965661, 3716.940671908493, 3749.1564398010228, 3785.905352366158, 3828.062124779391, 3853.2678791029616, 1084.4089970965842, 1092.639428988432, 1099.0932480703452, 1108.4236197177422, 1110.5169251375678, 722.7325889420842, 731.7292601737391, 736.2379936765423, 745.4371949178336, 752.3905636434506, 5720.247410388239, 5756.33802112754, 5867.911981320283, 5913.497352725067, 5916.467517923407, 825.1913125137279, 845.7082306604211, 855.2174760094568, 856.6958729650884, 861.7199410191713, 3944.487216661873, 3991.880243592697, 4018.819153138057, 4025.677945764332, 4031.871076098697, 13042.934785326202, 13860.306984650728, 13869.722605547833, 13942.86057139436, 13980.510682126076, 13489.730205395837, 13609.455621775216, 13655.86344136546, 13718.451261949609, 13773.173609583457, 7229.8554028919125, 7488.663010164556, 7586.089669239726, 7605.543667379975, 7647.732329368446, 6131.356207598138, 6178.443940045418, 6310.6213627182515, 6311.873762524816, 6405.903911441425, 11913.463894124612, 12269.631911042683, 12305.0, 12370.505179793068, 12427.067969902113, 12194.207376520499, 12321.815172772236, 12409.193402428813, 12428.13003089775, 12614.936925315315, 8549.829003419773, 8722.040575536812, 8730.17063378978, 8752.51861147643, 8781.692640757543, 9721.70834874955, 9843.064908833649, 9882.802343952937, 9894.703158905244, 9972.401655900669, 8126.959365203136, 8317.376196785144, 8339.416240863082, 8403.075661677089, 8499.617517211616, 7988.960055199686, 8216.383771217063, 8297.170282971896, 8319.292860106958, 8403.95798021006, 7290.0, 7366.521176123535, 7457.92542074594, 7478.513896596922, 7490.812729681802, 5354.946450535601, 5355.544778693855, 5504.394516603251, 5521.199426083115, 5552.861178470571, 5430.972845135749, 5437.429069947599, 5484.561235101262, 5550.0564903965615, 5575.7490912909825], "value": 4756.113404782694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.30203733365266, 354.71799919064347, 355.74030957401095, 357.2479929747879, 363.79809205890734, 5477.643953143053, 5593.427023569163, 5604.887902241952, 5612.691301978394, 5644.266245388099, 5315.73421328933, 5458.68006097408, 5472.91790623141, 5482.616216864821, 5485.204645326426, 4072.816723247461, 4089.6114869087387, 4097.09863829957, 4104.768569429174, 4111.1366613011305, 4010.13782036862, 4084.836606535735, 4097.487814023247, 4098.754074755524, 4125.64931980782, 4026.3155263605113, 4057.8376864925517, 4058.686548667261, 4068.8982775430554, 4071.8982025449454, 4022.4971878514893, 4032.5362583303004, 4037.4953130858494, 4041.7979101044975, 4088.1414902870433, 3472.6006509251506, 3514.4728290756334, 3531.2407832316176, 3531.2584357285, 3545.929081418383, 5254.973725131388, 5316.494932981399, 5358.0, 5363.275957745694, 5373.032854086263, 4788.0663270662235, 4808.9179934514805, 4812.590929770974, 4816.133096042711, 4831.855044348676, 5641.717914104278, 5819.301683797971, 5836.9124463133085, 5839.328477225088, 5846.590738648296, 3948.4274780157, 3961.445397644332, 3961.8613348532663, 3961.900952476211, 3976.1252524444576, 5935.554833387513, 6103.877922441527, 6152.938470615281, 6167.198264225667, 6203.9999999999545, 4055.087605288845, 4066.6580028590492, 4072.1448495815616, 4075.1849630074103, 4081.3469844824685, 4134.400511925754, 4136.875893723193, 4148.56440073794, 4154.792260386968, 4162.084341444877, 4714.528547145258, 4802.903941921142, 4809.182438985381, 4811.735354555463, 4824.204006338985, 5831.825045248649, 5839.270091238595, 5844.486870645663, 5852.268466441695, 5863.824085277449, 1419.7506194548937, 1432.4457963109935, 1435.9353829077716, 1436.3033928544648, 1439.1221354973459, 940.0505489455699, 951.3198063384713, 960.5245403525299, 1064.0, 1102.7077824376547, 5002.499750024968, 5020.447750747415, 5023.095842748267, 5047.848564543069, 5048.0913435581215, 5923.614965027259, 6015.909761353583, 6063.939360606426, 6066.332703402622, 6089.786857460056, 4806.206975848946, 4962.478939711278, 4966.255061740768, 4966.776495057731, 4996.675216110941, 3159.462891308483, 3190.888318908827, 3198.1844629619764, 3213.855376508063, 3214.1964508872784, 5336.279602253724, 5487.862803429946, 5510.228568000483, 5514.255575497336, 5528.55771538284, 6180.381961803873, 6182.6599537024995, 6187.628742275478, 6219.502439804804, 6240.375962403723, 5483.314585676791, 5491.9725401373535, 5495.917561236584, 5502.58730595207, 5504.944950550604, 5937.7921772737745, 6009.707912798769, 6014.428629280212, 6050.273967123973, 6065.72704228302, 5928.822135335947, 5950.9702451487465, 5953.255843019622, 5953.970230148821, 5954.791582294599, 5270.446603106619, 5427.755750991136, 5498.477644623755, 5500.367457742411, 5515.841673248663, 4050.4531888194715, 4059.512858457004, 4079.4900637420324, 4096.508418989741, 4098.979505102456, 5860.882782344244, 5985.533544281679, 6045.78839740607, 6048.4858787003595, 6057.636541807506, 5741.569382296428, 5787.710614469344, 5810.128480727924, 5829.621074630136, 5831.854203644943, 5790.594658373873, 5804.332501762351, 5807.564432667482, 5814.703192238957, 5844.288876563498, 5628.549716022791, 5673.546116310603, 5682.977064128331, 5704.087346024616, 5738.311402631711, 5796.913046304225, 5828.388019257917, 5841.824745257649, 5870.148828419769, 5904.3800400959, 5462.863428414322, 5649.604527683023, 5665.971670141623, 5673.432656734459, 5710.65736055838], "value": 4308.894942353929, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.3299715774277, 719.7013239505609, 752.3604935804567, 753.0436345840783, 769.7536788227768, 12643.494260229603, 12933.353332333392, 14437.205953672545, 15409.46066887659, 15469.38122475101, 15733.763993540077, 16390.7541386879, 16390.918045409755, 16402.589935251624, 16439.0, 875.3697337916706, 899.9775005624846, 904.1546154345675, 904.7331037344, 906.1301150895116, 881.8544940084878, 887.6493784954971, 888.9911100889005, 889.3729920406098, 894.6913314906346, 901.2069378946518, 930.7952250504878, 948.8861336639613, 956.3018996132827, 957.4159762544842, 922.4050487435634, 925.6852670092201, 928.0626567167142, 928.3687092776909, 929.0245242495387, 681.0703389872788, 683.8085336105898, 683.8153698501377, 684.3567046975827, 686.2382755141789, 14781.0, 14811.777823332659, 14915.0, 15008.324625391884, 15085.698286034218, 16063.196840158062, 16344.0, 16903.0, 16912.492625221264, 16973.15134243283, 12957.676058098528, 13271.535496257584, 13625.863741362558, 13788.379522921492, 13805.861941380557, 3084.7686423518326, 3096.628404591441, 3099.891503797379, 3100.0234925998466, 3114.2837147455984, 78454.21545784526, 80690.59654701689, 81537.59231203866, 81753.59123204346, 81864.59067704683, 12501.624951251477, 12964.611061668165, 13085.803712944313, 13304.135231210133, 13426.328683565782, 24092.638610420858, 24275.150369736974, 24564.385890352885, 24626.0, 24643.87678061634, 6157.138000679908, 6215.844603884849, 6219.844503887439, 6560.8359791005605, 6761.22245941723, 3144.402563512971, 3187.856546455415, 3192.393445245396, 3203.919902002422, 3212.421764082441, 3811.294910441577, 3853.0560012797046, 3910.393888947218, 3910.648041676263, 3918.549366822795, 792.7938735928585, 833.4957350802798, 839.7606682095574, 845.3068483843313, 846.3863698818308, 577.1371799160198, 581.0876923230572, 581.3953488372131, 584.1529781816383, 608.984775380619, 10051.346662466916, 10161.593536258615, 10286.228532860065, 11032.338059716443, 11242.550297988153, 579.3887448741618, 594.47983014862, 595.312414161644, 601.1703848688782, 604.6130476495047, 4515.525869783691, 4655.6973796703105, 4675.883102922454, 4710.88222794426, 4735.360726301974, 89463.55268223748, 89544.0, 89806.39396346203, 91404.54297728468, 93318.53340733254, 78011.0, 78880.0, 79358.20641793624, 80880.59559702281, 81198.18801812024, 68275.0, 68689.65655171692, 69120.6543967277, 69570.0, 69825.0, 8767.254783343487, 9164.266858651425, 9181.173694367539, 9204.125608067223, 9445.527723613654, 29899.252518687208, 30035.399292014474, 30065.0, 30297.848510758187, 30301.848490757406, 38009.0, 38173.42739858849, 38306.425403618414, 38505.42241866318, 38516.6148338513, 14580.489682861049, 14960.326785294905, 14969.326380312694, 15157.621059473602, 15290.0, 16410.261538231047, 16627.66744665124, 16982.23579938881, 17437.21532531014, 17461.738073928645, 15025.173615451255, 15722.921385393, 16091.0, 16120.113393763455, 16320.18399080065, 15558.61103472377, 16012.0, 16067.919660401623, 16164.272607732444, 16325.102119383548, 14486.058406203563, 15224.391024359345, 15398.230088495306, 15914.442994495137, 16063.919680401523, 10070.395776253448, 10709.946450267698, 10947.83578246311, 11065.557377704801, 11465.828012579652, 11716.882831171579, 11766.0, 12517.749645006867, 12591.622251332476, 12639.557615483414], "value": 7373.2620406629085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 112.0, 113.0, 111.0, 112.0, 112.0, 115.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 126.0, 167.0, 127.0, 122.0, 127.0, 126.0, 147.0, 127.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 167.0, 168.0, 168.0, 167.0, 165.0, 164.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 77.0, 107.0, 75.0, 75.0, 74.0, 76.0, 92.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 100.0, 84.0, 84.0, 83.0, 102.0, 84.0, 84.0, 112.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 150.0, 151.0, 150.0, 150.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 58.0, 57.0, 56.0, 58.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 59.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 87.0, 87.0, 87.0, 87.0, 87.0, 130.0, 86.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 133.0, 137.0, 134.0, 132.0, 133.0, 141.0, 134.0, 130.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 192.0, 191.0, 195.0, 190.0, 194.0, 192.0, 194.0, 200.0, 192.0], "value": 192.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 73.0, 76.0, 70.0, 76.0, 72.0, 74.0, 70.0], "value": 73.3, "unit": "score"}]}]} 10:05:46 INFO - Return code: 0 10:05:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:46 INFO - # TBPL SUCCESS # 10:05:46 INFO - Running post-action listener: _resource_record_post_action 10:05:46 INFO - [mozharness: 2017-05-30 17:05:46.631603Z] Finished run-tests step (success) 10:05:46 INFO - Running post-run listener: _resource_record_post_run 10:05:46 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414515200; Read time: 16; Write time: 527008 10:05:46 INFO - TinderboxPrint: CPU usage
12.7% 10:05:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:05:46 INFO - TinderboxPrint: I/O write bytes / time
414,515,200 / 527,008 10:05:46 INFO - TinderboxPrint: CPU idle
8,760.2 (87.3%) 10:05:46 INFO - TinderboxPrint: CPU user
1,216.4 (12.1%) 10:05:46 INFO - TinderboxPrint: Swap in / out
0 / 0 10:05:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111738880; Read time: 0; Write time: 165840 10:05:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:05:46 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 302051328; Read time: 0; Write time: 361160 10:05:47 INFO - Running post-run listener: _upload_blobber_files 10:05:47 INFO - Blob upload gear active. 10:05:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:47 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:05:47 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:47 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:05:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:48 INFO - (blobuploader) - INFO - Done attempting. 10:05:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:55 INFO - (blobuploader) - INFO - Done attempting. 10:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:55 INFO - (blobuploader) - INFO - Done attempting. 10:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:56 INFO - (blobuploader) - INFO - Done attempting. 10:05:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:56 INFO - Return code: 0 10:05:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f48ede9826bec466ac59e5c2fcca3b63622e14314e819b7242a45d12cc8d7b83e55a7e1376627477afb0dc1b2d9efe542f6069615f4c8b45433d542ec2b0b638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35728494b4305b09a3f0fdea816b0ee61605dcbf1e4da3ac7dad449cab0caad56c6fcb2209991d18c9c226e0bedc877c1fbe3c219a3dc92344a07a2f80fb2531", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e323302e389a4895cfe8aa1b454649c39d54aa24dcd0b73a6b59c84d9cecec115a7d94baab83920c02fa88acdbce80a04a82bf0468c7aacf771ea3a1f74cb1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de3ed772020826bab08f6c6c9db35c561008181e51b3b0ecac585e83c07f11ba40fbef90b85a040e5d2b42c259e41da4650d21dfd3ef8a291512fa66949e6c46"} 10:05:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:56 INFO - Contents: 10:05:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f48ede9826bec466ac59e5c2fcca3b63622e14314e819b7242a45d12cc8d7b83e55a7e1376627477afb0dc1b2d9efe542f6069615f4c8b45433d542ec2b0b638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35728494b4305b09a3f0fdea816b0ee61605dcbf1e4da3ac7dad449cab0caad56c6fcb2209991d18c9c226e0bedc877c1fbe3c219a3dc92344a07a2f80fb2531", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e323302e389a4895cfe8aa1b454649c39d54aa24dcd0b73a6b59c84d9cecec115a7d94baab83920c02fa88acdbce80a04a82bf0468c7aacf771ea3a1f74cb1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de3ed772020826bab08f6c6c9db35c561008181e51b3b0ecac585e83c07f11ba40fbef90b85a040e5d2b42c259e41da4650d21dfd3ef8a291512fa66949e6c46"} 10:05:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:56 INFO - Copying logs to upload dir... 10:05:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.731614 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-30 10:05:56.190987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 10:05:56.195747) ========= 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=df17445c3590ff7897617a0e00000225-1496162636.623193-963772990 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-Non-PGO/sha512/f48ede9826bec466ac59e5c2fcca3b63622e14314e819b7242a45d12cc8d7b83e55a7e1376627477afb0dc1b2d9efe542f6069615f4c8b45433d542ec2b0b638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35728494b4305b09a3f0fdea816b0ee61605dcbf1e4da3ac7dad449cab0caad56c6fcb2209991d18c9c226e0bedc877c1fbe3c219a3dc92344a07a2f80fb2531", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e323302e389a4895cfe8aa1b454649c39d54aa24dcd0b73a6b59c84d9cecec115a7d94baab83920c02fa88acdbce80a04a82bf0468c7aacf771ea3a1f74cb1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de3ed772020826bab08f6c6c9db35c561008181e51b3b0ecac585e83c07f11ba40fbef90b85a040e5d2b42c259e41da4650d21dfd3ef8a291512fa66949e6c46"} build_url:https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/VUV82kEoRCiyhq_AMZUJuw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f48ede9826bec466ac59e5c2fcca3b63622e14314e819b7242a45d12cc8d7b83e55a7e1376627477afb0dc1b2d9efe542f6069615f4c8b45433d542ec2b0b638", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35728494b4305b09a3f0fdea816b0ee61605dcbf1e4da3ac7dad449cab0caad56c6fcb2209991d18c9c226e0bedc877c1fbe3c219a3dc92344a07a2f80fb2531", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e323302e389a4895cfe8aa1b454649c39d54aa24dcd0b73a6b59c84d9cecec115a7d94baab83920c02fa88acdbce80a04a82bf0468c7aacf771ea3a1f74cb1f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/de3ed772020826bab08f6c6c9db35c561008181e51b3b0ecac585e83c07f11ba40fbef90b85a040e5d2b42c259e41da4650d21dfd3ef8a291512fa66949e6c46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 10:05:56.222408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:05:56.222745) ========= 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=df17445c3590ff7897617a0e00000225-1496162636.623193-963772990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:05:56.304249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 10:05:56.304571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 10:05:56.304849) ========= ========= Total master_lag: 0.30 =========