builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1497173215.55 results: success (0) revision: 799d43edb324395cf02da6b028e803712334615f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.549885) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.550261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.550527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.602750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.603029) ========= 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=03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-11 02:26:55-- 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% 99.2M=0s 2017-06-11 02:26:55 (99.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185763 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.810602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.812459) ========= 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=03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.069041 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.893388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:55.893678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 799d43edb324395cf02da6b028e803712334615f --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 799d43edb324395cf02da6b028e803712334615f --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=03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-11 02:26:55,975 truncating revision to first 12 chars 2017-06-11 02:26:55,975 Setting DEBUG logging. 2017-06-11 02:26:55,975 attempt 1/10 2017-06-11 02:26:55,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/799d43edb324?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-11 02:26:56,556 unpacking tar archive at: mozilla-central-799d43edb324/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:56.810075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:56.810347) ========= script_repo_revision: 799d43edb324395cf02da6b028e803712334615f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:56.810688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:56.813766) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-11 02:26:56.830726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-11 02:26:56.831012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:26:57 INFO - MultiFileLogger online at 20170611 02:26:57 in /builds/slave/test 02:26:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:26:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:57 INFO - {'append_to_log': False, 02:26:57 INFO - 'base_work_dir': '/builds/slave/test', 02:26:57 INFO - 'blob_upload_branch': 'Firefox', 02:26:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:57 INFO - 'branch': 'Firefox', 02:26:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:57 INFO - 'config_files': ('talos/linux_config.py',), 02:26:57 INFO - 'default_actions': ('clobber', 02:26:57 INFO - 'read-buildbot-config', 02:26:57 INFO - 'download-and-extract', 02:26:57 INFO - 'populate-webroot', 02:26:57 INFO - 'create-virtualenv', 02:26:57 INFO - 'install', 02:26:57 INFO - 'setup-mitmproxy', 02:26:57 INFO - 'run-tests'), 02:26:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:57 INFO - 'download_minidump_stackwalk': True, 02:26:57 INFO - 'download_symbols': 'ondemand', 02:26:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:57 INFO - 'gecko_profile': False, 02:26:57 INFO - 'gecko_profile_interval': 0, 02:26:57 INFO - 'installer_path': 'installer.exe', 02:26:57 INFO - 'log_level': 'info', 02:26:57 INFO - 'log_name': 'talos', 02:26:57 INFO - 'log_to_console': True, 02:26:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:26:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:26:57 INFO - 'opt_config_files': (), 02:26:57 INFO - 'pip_index': False, 02:26:57 INFO - 'suite': 'dromaeojs-e10s', 02:26:57 INFO - 'system_bits': '32', 02:26:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:57 INFO - 'title': 'talos-linux64-ix-047', 02:26:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:57 INFO - 'use_talos_json': True, 02:26:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:57 INFO - 'work_dir': 'build'} 02:26:57 INFO - [mozharness: 2017-06-11 09:26:57.118904Z] Running clobber step. 02:26:57 INFO - Running pre-action listener: _resource_record_pre_action 02:26:57 INFO - Running main action method: clobber 02:26:57 INFO - rmtree: /builds/slave/test/build 02:26:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:59 INFO - Running post-action listener: _resource_record_post_action 02:26:59 INFO - [mozharness: 2017-06-11 09:26:59.050335Z] Finished clobber step (success) 02:26:59 INFO - [mozharness: 2017-06-11 09:26:59.050500Z] Running read-buildbot-config step. 02:26:59 INFO - Running pre-action listener: _resource_record_pre_action 02:26:59 INFO - Running main action method: read_buildbot_config 02:26:59 INFO - Using buildbot properties: 02:26:59 INFO - { 02:26:59 INFO - "project": "", 02:26:59 INFO - "product": "firefox", 02:26:59 INFO - "who": "archaeopteryx@coole-files.de", 02:26:59 INFO - "installer_path": "public/build/target.tar.bz2", 02:26:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:26:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:26:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:26:59 INFO - "stage_platform": "linux64-stylosequential", 02:26:59 INFO - "basedir": "/builds/slave/test", 02:26:59 INFO - "buildnumber": 56, 02:26:59 INFO - "platform": "ubuntu64_hw_styloseq", 02:26:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:26:59 INFO - "slavebuilddir": "test", 02:26:59 INFO - "taskId": "O8H8k-LCSxqWhM20wQ5png", 02:26:59 INFO - "branch": "mozilla-central", 02:26:59 INFO - "script_repo_revision": "production", 02:26:59 INFO - "revision": "799d43edb324395cf02da6b028e803712334615f", 02:26:59 INFO - "slavename": "talos-linux64-ix-047", 02:26:59 INFO - "repo_path": "mozilla-central" 02:26:59 INFO - } 02:26:59 INFO - Finding installer, test and symbols from parent task. 02:26:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8H8k-LCSxqWhM20wQ5png'}, attempt #1 02:26:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O8H8k-LCSxqWhM20wQ5png'}, attempt #1 02:26:59 INFO - Task dependencies: ZYKORsNyQEaGRSFd3Hpk5g 02:26:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g'}, attempt #1 02:27:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2 02:27:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/test_packages.json 02:27:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.crashreporter-symbols.zip 02:27:00 INFO - Running post-action listener: _resource_record_post_action 02:27:00 INFO - [mozharness: 2017-06-11 09:27:00.426266Z] Finished read-buildbot-config step (success) 02:27:00 INFO - [mozharness: 2017-06-11 09:27:00.426561Z] Running download-and-extract step. 02:27:00 INFO - Running pre-action listener: _resource_record_pre_action 02:27:00 INFO - Running main action method: download_and_extract 02:27:00 INFO - mkdir: /builds/slave/test/build/tests 02:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:00 INFO - trying https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.test_packages.json 02:27:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:27:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:27:01 INFO - Downloaded 989 bytes. 02:27:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:27:01 INFO - Using the following test package requirements: 02:27:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:27:01 INFO - u'common': [u'target.common.tests.zip'], 02:27:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:27:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:27:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:27:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:27:01 INFO - u'mozbase': [u'target.common.tests.zip'], 02:27:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:27:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:27:01 INFO - u'web-platform': [u'target.common.tests.zip', 02:27:01 INFO - u'target.web-platform.tests.tar.gz'], 02:27:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:27:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:27:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.common.tests.zip 02:27:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:27:01 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.common.tests.zip into memory 02:27:02 INFO - Content-Length response header: 67883645 02:27:02 INFO - Bytes received: 67883645 02:27:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:27:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.common.tests.zip 02:27:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:27:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.common.tests.zip into memory 02:27:15 INFO - Content-Length response header: 67883645 02:27:15 INFO - Bytes received: 67883645 02:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.talos.tests.zip 02:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.talos.tests.zip into memory 02:27:29 INFO - Content-Length response header: 14450010 02:27:29 INFO - Bytes received: 14450010 02:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:29 INFO - trying https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2 02:27:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:27:30 INFO - Downloaded 61403605 bytes. 02:27:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2 02:27:30 INFO - mkdir: /builds/slave/test/properties 02:27:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:27:30 INFO - Writing to file /builds/slave/test/properties/build_url 02:27:30 INFO - Contents: 02:27:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2 02:27:30 INFO - Running post-action listener: _resource_record_post_action 02:27:30 INFO - Running post-action listener: set_extra_try_arguments 02:27:30 INFO - [mozharness: 2017-06-11 09:27:30.782014Z] Finished download-and-extract step (success) 02:27:30 INFO - [mozharness: 2017-06-11 09:27:30.782162Z] Running populate-webroot step. 02:27:30 INFO - Running pre-action listener: _resource_record_pre_action 02:27:30 INFO - Running main action method: populate_webroot 02:27:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:30 INFO - '--tppagecycles', 02:27:30 INFO - '7'], 02:27:30 INFO - 'tests': ['tsvgm']}}, 02:27:30 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['damp', 'tps']}, 02:27:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'tests': ['damp', 'tps']}, 02:27:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['dromaeo_dom']}, 02:27:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:27:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:27:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:27:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['a11yr', 02:27:30 INFO - 'ts_paint', 02:27:30 INFO - 'tpaint', 02:27:30 INFO - 'sessionrestore', 02:27:30 INFO - 'sessionrestore_no_auto_restore', 02:27:30 INFO - 'tabpaint']}, 02:27:30 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:30 INFO - 'ts_paint', 02:27:30 INFO - 'tpaint', 02:27:30 INFO - 'sessionrestore', 02:27:30 INFO - 'sessionrestore_no_auto_restore', 02:27:30 INFO - 'tabpaint']}, 02:27:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:30 INFO - 'ts_paint', 02:27:30 INFO - 'tpaint', 02:27:30 INFO - 'sessionrestore', 02:27:30 INFO - 'sessionrestore_no_auto_restore', 02:27:30 INFO - 'tabpaint']}, 02:27:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:30 INFO - 'ts_paint', 02:27:30 INFO - 'tpaint', 02:27:30 INFO - 'sessionrestore', 02:27:30 INFO - 'sessionrestore_no_auto_restore', 02:27:30 INFO - 'tabpaint']}, 02:27:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['a11yr', 02:27:30 INFO - 'ts_paint', 02:27:30 INFO - 'tpaint', 02:27:30 INFO - 'sessionrestore', 02:27:30 INFO - 'sessionrestore_no_auto_restore', 02:27:30 INFO - 'tabpaint']}, 02:27:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['a11yr', 02:27:30 INFO - 'ts_paint', 02:27:30 INFO - 'tpaint', 02:27:30 INFO - 'sessionrestore', 02:27:30 INFO - 'sessionrestore_no_auto_restore', 02:27:30 INFO - 'tabpaint']}, 02:27:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:27:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:27:30 INFO - 'bloom_basic_ref']}, 02:27:30 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:27:30 INFO - 'talos_options': ['--mitmproxy', 02:27:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:27:30 INFO - '--firstNonBlankPaint'], 02:27:30 INFO - 'tests': ['quantum_pageload_google', 02:27:30 INFO - 'quantum_pageload_youtube', 02:27:30 INFO - 'quantum_pageload_amazon', 02:27:30 INFO - 'quantum_pageload_facebook']}, 02:27:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['tsvgx', 02:27:30 INFO - 'tsvgr_opacity', 02:27:30 INFO - 'tart', 02:27:30 INFO - 'tscrollx', 02:27:30 INFO - 'cart', 02:27:30 INFO - 'tsvg_static']}, 02:27:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:30 INFO - 'tsvgr_opacity', 02:27:30 INFO - 'tart', 02:27:30 INFO - 'tscrollx', 02:27:30 INFO - 'cart', 02:27:30 INFO - 'tsvg_static']}, 02:27:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'talos_options': ['--disable-e10s'], 02:27:30 INFO - 'tests': ['tp5o']}, 02:27:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:27:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'talos_options': ['--disable-e10s', 02:27:30 INFO - '--xperf_path', 02:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:30 INFO - 'tests': ['tp5n']}, 02:27:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:27:30 INFO - 'talos_options': ['--xperf_path', 02:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:30 INFO - 'tests': ['tp5n']}}, 02:27:30 INFO - 'talos.zip': {'path': '', 02:27:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:30 INFO - Running post-action listener: _resource_record_post_action 02:27:30 INFO - [mozharness: 2017-06-11 09:27:30.805697Z] Finished populate-webroot step (success) 02:27:30 INFO - [mozharness: 2017-06-11 09:27:30.805785Z] Running create-virtualenv step. 02:27:30 INFO - Running pre-action listener: _resource_record_pre_action 02:27:30 INFO - Running main action method: create_virtualenv 02:27:30 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:27:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:27:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:30 INFO - Using real prefix '/usr' 02:27:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:31 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:33 INFO - Installing pip.................done. 02:27:33 INFO - Return code: 0 02:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:27:33 INFO - Reading from file tmpfile_stdout 02:27:33 INFO - Output received: 02:27:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:27:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:33 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:27:33 INFO - Using env: {'DISPLAY': ':0', 02:27:33 INFO - 'HOME': '/home/cltbld', 02:27:33 INFO - 'LANG': 'en_US.UTF-8', 02:27:33 INFO - 'LANGUAGE': 'en_US:en', 02:27:33 INFO - 'LOGNAME': 'cltbld', 02:27:33 INFO - 'MAIL': '/var/mail/cltbld', 02:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:33 INFO - 'MOZ_NO_REMOTE': '1', 02:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:33 INFO - 'NO_EM_RESTART': '1', 02:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:33 INFO - 'PWD': '/builds/slave/test', 02:27:33 INFO - 'SHELL': '/bin/bash', 02:27:33 INFO - 'SHLVL': '1', 02:27:33 INFO - 'TERM': 'linux', 02:27:33 INFO - 'TMOUT': '86400', 02:27:33 INFO - 'USER': 'cltbld', 02:27:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:33 INFO - '_': '/tools/buildbot/bin/python'} 02:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:27:33 INFO - Cleaning up... 02:27:33 INFO - Return code: 0 02:27:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:33 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:27:33 INFO - Using env: {'DISPLAY': ':0', 02:27:33 INFO - 'HOME': '/home/cltbld', 02:27:33 INFO - 'LANG': 'en_US.UTF-8', 02:27:33 INFO - 'LANGUAGE': 'en_US:en', 02:27:33 INFO - 'LOGNAME': 'cltbld', 02:27:33 INFO - 'MAIL': '/var/mail/cltbld', 02:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:33 INFO - 'MOZ_NO_REMOTE': '1', 02:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:33 INFO - 'NO_EM_RESTART': '1', 02:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:33 INFO - 'PWD': '/builds/slave/test', 02:27:33 INFO - 'SHELL': '/bin/bash', 02:27:33 INFO - 'SHLVL': '1', 02:27:33 INFO - 'TERM': 'linux', 02:27:33 INFO - 'TMOUT': '86400', 02:27:33 INFO - 'USER': 'cltbld', 02:27:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:33 INFO - '_': '/tools/buildbot/bin/python'} 02:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:34 INFO - Downloading/unpacking psutil>=3.1.1 02:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:27:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:35 INFO - Installing collected packages: psutil 02:27:35 INFO - Running setup.py install for psutil 02:27:35 INFO - building 'psutil._psutil_linux' extension 02:27:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:27:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:27:36 INFO - building 'psutil._psutil_posix' extension 02:27:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:27:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:27:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:36 INFO - Successfully installed psutil 02:27:36 INFO - Cleaning up... 02:27:36 INFO - Return code: 0 02:27:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27: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')]} 02:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:27: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 mozsystemmonitor==0.3 02:27:36 INFO - Using env: {'DISPLAY': ':0', 02:27:36 INFO - 'HOME': '/home/cltbld', 02:27:36 INFO - 'LANG': 'en_US.UTF-8', 02:27:36 INFO - 'LANGUAGE': 'en_US:en', 02:27:36 INFO - 'LOGNAME': 'cltbld', 02:27:36 INFO - 'MAIL': '/var/mail/cltbld', 02:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:36 INFO - 'MOZ_NO_REMOTE': '1', 02:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:36 INFO - 'NO_EM_RESTART': '1', 02:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:36 INFO - 'PWD': '/builds/slave/test', 02:27:36 INFO - 'SHELL': '/bin/bash', 02:27:36 INFO - 'SHLVL': '1', 02:27:36 INFO - 'TERM': 'linux', 02:27:36 INFO - 'TMOUT': '86400', 02:27:36 INFO - 'USER': 'cltbld', 02:27:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:36 INFO - '_': '/tools/buildbot/bin/python'} 02:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:38 INFO - Installing collected packages: mozsystemmonitor 02:27:38 INFO - Running setup.py install for mozsystemmonitor 02:27:38 INFO - Successfully installed mozsystemmonitor 02:27:38 INFO - Cleaning up... 02:27:38 INFO - Return code: 0 02:27:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27: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', '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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:27: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 jsonschema==2.5.1 02:27:38 INFO - Using env: {'DISPLAY': ':0', 02:27:38 INFO - 'HOME': '/home/cltbld', 02:27:38 INFO - 'LANG': 'en_US.UTF-8', 02:27:38 INFO - 'LANGUAGE': 'en_US:en', 02:27:38 INFO - 'LOGNAME': 'cltbld', 02:27:38 INFO - 'MAIL': '/var/mail/cltbld', 02:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:38 INFO - 'MOZ_NO_REMOTE': '1', 02:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:38 INFO - 'NO_EM_RESTART': '1', 02:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:38 INFO - 'PWD': '/builds/slave/test', 02:27:38 INFO - 'SHELL': '/bin/bash', 02:27:38 INFO - 'SHLVL': '1', 02:27:38 INFO - 'TERM': 'linux', 02:27:38 INFO - 'TMOUT': '86400', 02:27:38 INFO - 'USER': 'cltbld', 02:27:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:38 INFO - '_': '/tools/buildbot/bin/python'} 02:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:38 INFO - Downloading/unpacking jsonschema==2.5.1 02:27: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 02:27: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 02:27: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 02:27: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 02:27:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:27: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 02:27: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 02:27: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 02:27: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 02:27:39 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:39 INFO - warning: no files found matching '*.txt' 02:27:39 INFO - no previously-included directories found matching 'build' 02:27:39 INFO - no previously-included directories found matching 'dist' 02:27:39 INFO - no previously-included directories found matching '.git*' 02:27:39 INFO - Installing collected packages: jsonschema, functools32 02:27:39 INFO - Running setup.py install for functools32 02:27:40 INFO - warning: no files found matching '*.txt' 02:27:40 INFO - no previously-included directories found matching 'build' 02:27:40 INFO - no previously-included directories found matching 'dist' 02:27:40 INFO - no previously-included directories found matching '.git*' 02:27:40 INFO - Successfully installed jsonschema functools32 02:27:40 INFO - Cleaning up... 02:27:40 INFO - Return code: 0 02:27:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27: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')]} 02:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:40 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:27:40 INFO - Using env: {'DISPLAY': ':0', 02:27:40 INFO - 'HOME': '/home/cltbld', 02:27:40 INFO - 'LANG': 'en_US.UTF-8', 02:27:40 INFO - 'LANGUAGE': 'en_US:en', 02:27:40 INFO - 'LOGNAME': 'cltbld', 02:27:40 INFO - 'MAIL': '/var/mail/cltbld', 02:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:40 INFO - 'MOZ_NO_REMOTE': '1', 02:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:40 INFO - 'NO_EM_RESTART': '1', 02:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:40 INFO - 'PWD': '/builds/slave/test', 02:27:40 INFO - 'SHELL': '/bin/bash', 02:27:40 INFO - 'SHLVL': '1', 02:27:40 INFO - 'TERM': 'linux', 02:27:40 INFO - 'TMOUT': '86400', 02:27:40 INFO - 'USER': 'cltbld', 02:27:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:40 INFO - '_': '/tools/buildbot/bin/python'} 02:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:27:40 INFO - Cleaning up... 02:27:40 INFO - Return code: 0 02:27:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27: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')]} 02:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:40 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:27:40 INFO - Using env: {'DISPLAY': ':0', 02:27:40 INFO - 'HOME': '/home/cltbld', 02:27:40 INFO - 'LANG': 'en_US.UTF-8', 02:27:40 INFO - 'LANGUAGE': 'en_US:en', 02:27:40 INFO - 'LOGNAME': 'cltbld', 02:27:40 INFO - 'MAIL': '/var/mail/cltbld', 02:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:40 INFO - 'MOZ_NO_REMOTE': '1', 02:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:40 INFO - 'NO_EM_RESTART': '1', 02:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:40 INFO - 'PWD': '/builds/slave/test', 02:27:40 INFO - 'SHELL': '/bin/bash', 02:27:40 INFO - 'SHLVL': '1', 02:27:40 INFO - 'TERM': 'linux', 02:27:40 INFO - 'TMOUT': '86400', 02:27:40 INFO - 'USER': 'cltbld', 02:27:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:40 INFO - '_': '/tools/buildbot/bin/python'} 02:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:40 INFO - Downloading/unpacking blobuploader==1.2.4 02:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:41 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:42 INFO - Downloading docopt-0.6.1.tar.gz 02:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:42 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:42 INFO - Running setup.py install for blobuploader 02:27:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:42 INFO - Running setup.py install for requests 02:27:42 INFO - Running setup.py install for docopt 02:27:42 INFO - Successfully installed blobuploader requests docopt 02:27:42 INFO - Cleaning up... 02:27:42 INFO - Return code: 0 02:27:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:42 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:27:42 INFO - Using env: {'DISPLAY': ':0', 02:27:42 INFO - 'HOME': '/home/cltbld', 02:27:42 INFO - 'LANG': 'en_US.UTF-8', 02:27:42 INFO - 'LANGUAGE': 'en_US:en', 02:27:42 INFO - 'LOGNAME': 'cltbld', 02:27:42 INFO - 'MAIL': '/var/mail/cltbld', 02:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:42 INFO - 'MOZ_NO_REMOTE': '1', 02:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:42 INFO - 'NO_EM_RESTART': '1', 02:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:42 INFO - 'PWD': '/builds/slave/test', 02:27:42 INFO - 'SHELL': '/bin/bash', 02:27:42 INFO - 'SHLVL': '1', 02:27:42 INFO - 'TERM': 'linux', 02:27:42 INFO - 'TMOUT': '86400', 02:27:42 INFO - 'USER': 'cltbld', 02:27:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:42 INFO - '_': '/tools/buildbot/bin/python'} 02:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:43 INFO - Running setup.py (path:/tmp/pip-rfSgX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:43 INFO - Running setup.py (path:/tmp/pip-48jSaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:43 INFO - Running setup.py (path:/tmp/pip-VJGOYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:43 INFO - Running setup.py (path:/tmp/pip-rxpBDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:43 INFO - Running setup.py (path:/tmp/pip-4CWZ8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:43 INFO - Running setup.py (path:/tmp/pip-QmVoJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:43 INFO - Running setup.py (path:/tmp/pip-enKcS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:43 INFO - Running setup.py (path:/tmp/pip-lUW51G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:43 INFO - Running setup.py (path:/tmp/pip-uFnji4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:43 INFO - Running setup.py (path:/tmp/pip-ps1DGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:43 INFO - Running setup.py (path:/tmp/pip-MOOwHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:43 INFO - Running setup.py (path:/tmp/pip-0I9RNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:43 INFO - Running setup.py (path:/tmp/pip-FUK8QW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:43 INFO - Running setup.py (path:/tmp/pip-beXR6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:44 INFO - Running setup.py (path:/tmp/pip-wSw17F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:44 INFO - Running setup.py (path:/tmp/pip-Q9VMUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:44 INFO - Running setup.py (path:/tmp/pip-1CIc2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:44 INFO - Running setup.py install for manifestparser 02:27:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:44 INFO - Running setup.py install for mozcrash 02:27:44 INFO - Running setup.py install for mozdebug 02:27:44 INFO - Running setup.py install for mozdevice 02:27:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:44 INFO - Running setup.py install for mozfile 02:27:44 INFO - Running setup.py install for mozhttpd 02:27:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:44 INFO - Running setup.py install for mozinfo 02:27:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:44 INFO - Running setup.py install for mozInstall 02:27:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Running setup.py install for mozleak 02:27:45 INFO - Running setup.py install for mozlog 02:27:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Running setup.py install for moznetwork 02:27:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Running setup.py install for mozprocess 02:27:45 INFO - Running setup.py install for mozprofile 02:27:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Running setup.py install for mozrunner 02:27:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:45 INFO - Running setup.py install for mozscreenshot 02:27:45 INFO - Running setup.py install for moztest 02:27:45 INFO - Running setup.py install for mozversion 02:27:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:46 INFO - Cleaning up... 02:27:46 INFO - Return code: 0 02:27:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:46 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:27:46 INFO - Using env: {'DISPLAY': ':0', 02:27:46 INFO - 'HOME': '/home/cltbld', 02:27:46 INFO - 'LANG': 'en_US.UTF-8', 02:27:46 INFO - 'LANGUAGE': 'en_US:en', 02:27:46 INFO - 'LOGNAME': 'cltbld', 02:27:46 INFO - 'MAIL': '/var/mail/cltbld', 02:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:46 INFO - 'MOZ_NO_REMOTE': '1', 02:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:46 INFO - 'NO_EM_RESTART': '1', 02:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:46 INFO - 'PWD': '/builds/slave/test', 02:27:46 INFO - 'SHELL': '/bin/bash', 02:27:46 INFO - 'SHLVL': '1', 02:27:46 INFO - 'TERM': 'linux', 02:27:46 INFO - 'TMOUT': '86400', 02:27:46 INFO - 'USER': 'cltbld', 02:27:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:46 INFO - '_': '/tools/buildbot/bin/python'} 02:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:46 INFO - Running setup.py (path:/tmp/pip-4KjrL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:46 INFO - Running setup.py (path:/tmp/pip-e1IKpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:46 INFO - Running setup.py (path:/tmp/pip-6eBxIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:46 INFO - Running setup.py (path:/tmp/pip-ok6N8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:46 INFO - Running setup.py (path:/tmp/pip-vEMUsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:46 INFO - Running setup.py (path:/tmp/pip-fLkE5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:46 INFO - Running setup.py (path:/tmp/pip-DO9gn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:46 INFO - Running setup.py (path:/tmp/pip-tEyKcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:46 INFO - Running setup.py (path:/tmp/pip-V4rjEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:46 INFO - Running setup.py (path:/tmp/pip-BBMY2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:46 INFO - Running setup.py (path:/tmp/pip-mdtXUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:47 INFO - Running setup.py (path:/tmp/pip-gXIdqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:47 INFO - Running setup.py (path:/tmp/pip-hdSaw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:47 INFO - Running setup.py (path:/tmp/pip-FgzZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:47 INFO - Running setup.py (path:/tmp/pip-cae8ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:47 INFO - Running setup.py (path:/tmp/pip-SbpHf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:47 INFO - Running setup.py (path:/tmp/pip-MjhMFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:27:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27: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 02:27: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 02:27: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 02:27: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 02:27:48 INFO - Downloading blessings-1.6.tar.gz 02:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:27:48 INFO - Installing collected packages: blessings 02:27:48 INFO - Running setup.py install for blessings 02:27:48 INFO - Successfully installed blessings 02:27:48 INFO - Cleaning up... 02:27:48 INFO - Return code: 0 02:27:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:49 INFO - Reading from file tmpfile_stdout 02:27:49 INFO - Current package versions: 02:27:49 INFO - argparse == 1.2.1 02:27:49 INFO - blessings == 1.6 02:27:49 INFO - blobuploader == 1.2.4 02:27:49 INFO - docopt == 0.6.1 02:27:49 INFO - functools32 == 3.2.3-2 02:27:49 INFO - jsonschema == 2.5.1 02:27:49 INFO - manifestparser == 1.1 02:27:49 INFO - mozInstall == 1.13 02:27:49 INFO - mozcrash == 1.0 02:27:49 INFO - mozdebug == 0.1 02:27:49 INFO - mozdevice == 0.51 02:27:49 INFO - mozfile == 1.2 02:27:49 INFO - mozhttpd == 0.7 02:27:49 INFO - mozinfo == 0.10 02:27:49 INFO - mozleak == 0.1 02:27:49 INFO - mozlog == 3.4 02:27:49 INFO - moznetwork == 0.27 02:27:49 INFO - mozprocess == 0.25 02:27:49 INFO - mozprofile == 0.28 02:27:49 INFO - mozrunner == 6.13 02:27:49 INFO - mozscreenshot == 0.1 02:27:49 INFO - mozsystemmonitor == 0.3 02:27:49 INFO - moztest == 0.8 02:27:49 INFO - mozversion == 1.4 02:27:49 INFO - psutil == 3.1.1 02:27:49 INFO - requests == 1.2.3 02:27:49 INFO - wsgiref == 0.1.2 02:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:49 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:27:49 INFO - Using env: {'DISPLAY': ':0', 02:27:49 INFO - 'HOME': '/home/cltbld', 02:27:49 INFO - 'LANG': 'en_US.UTF-8', 02:27:49 INFO - 'LANGUAGE': 'en_US:en', 02:27:49 INFO - 'LOGNAME': 'cltbld', 02:27:49 INFO - 'MAIL': '/var/mail/cltbld', 02:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:49 INFO - 'MOZ_NO_REMOTE': '1', 02:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:49 INFO - 'NO_EM_RESTART': '1', 02:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:49 INFO - 'PWD': '/builds/slave/test', 02:27:49 INFO - 'SHELL': '/bin/bash', 02:27:49 INFO - 'SHLVL': '1', 02:27:49 INFO - 'TERM': 'linux', 02:27:49 INFO - 'TMOUT': '86400', 02:27:49 INFO - 'USER': 'cltbld', 02:27:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:49 INFO - '_': '/tools/buildbot/bin/python'} 02:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:27:49 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:50 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:27:50 INFO - Installing collected packages: marionette-driver 02:27:50 INFO - Running setup.py install for marionette-driver 02:27:50 INFO - Successfully installed marionette-driver 02:27:50 INFO - Cleaning up... 02:27:50 INFO - Return code: 0 02:27:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:50 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 0x1e333b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, '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': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:27:50 INFO - Using env: {'DISPLAY': ':0', 02:27:50 INFO - 'HOME': '/home/cltbld', 02:27:50 INFO - 'LANG': 'en_US.UTF-8', 02:27:50 INFO - 'LANGUAGE': 'en_US:en', 02:27:50 INFO - 'LOGNAME': 'cltbld', 02:27:50 INFO - 'MAIL': '/var/mail/cltbld', 02:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:50 INFO - 'MOZ_NO_REMOTE': '1', 02:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:50 INFO - 'NO_EM_RESTART': '1', 02:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:50 INFO - 'PWD': '/builds/slave/test', 02:27:50 INFO - 'SHELL': '/bin/bash', 02:27:50 INFO - 'SHLVL': '1', 02:27:50 INFO - 'TERM': 'linux', 02:27:50 INFO - 'TMOUT': '86400', 02:27:50 INFO - 'USER': 'cltbld', 02:27:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:50 INFO - '_': '/tools/buildbot/bin/python'} 02:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:27:50 INFO - Cleaning up... 02:27:50 INFO - Return code: 0 02:27:50 INFO - Running post-action listener: _resource_record_post_action 02:27:50 INFO - Running post-action listener: _start_resource_monitoring 02:27:50 INFO - Starting resource monitoring. 02:27:50 INFO - [mozharness: 2017-06-11 09:27:50.819880Z] Finished create-virtualenv step (success) 02:27:50 INFO - [mozharness: 2017-06-11 09:27:50.820799Z] Running install step. 02:27:50 INFO - Running pre-action listener: _resource_record_pre_action 02:27:50 INFO - Running main action method: install 02:27:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:51 INFO - Reading from file tmpfile_stdout 02:27:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:51 INFO - Reading from file tmpfile_stdout 02:27:51 INFO - Output received: 02:27:51 INFO - Usage: mozinstall [options] installer 02:27:51 INFO - Options: 02:27:51 INFO - -h, --help show this help message and exit 02:27:51 INFO - -d DEST, --destination=DEST 02:27:51 INFO - Directory to install application into. [default: 02:27:51 INFO - "/builds/slave/test"] 02:27:51 INFO - --app=APP Application being installed. [default: firefox] 02:27:51 INFO - mkdir: /builds/slave/test/build/application 02:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:28:08 INFO - Reading from file tmpfile_stdout 02:28:08 INFO - Output received: 02:28:08 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:08 INFO - Running post-action listener: _resource_record_post_action 02:28:08 INFO - [mozharness: 2017-06-11 09:28:08.945108Z] Finished install step (success) 02:28:08 INFO - [mozharness: 2017-06-11 09:28:08.945387Z] Running setup-mitmproxy step. 02:28:08 INFO - Running pre-action listener: _resource_record_pre_action 02:28:08 INFO - Running main action method: setup_mitmproxy 02:28:08 INFO - Skipping: mitmproxy is not required 02:28:08 INFO - Running post-action listener: _resource_record_post_action 02:28:08 INFO - [mozharness: 2017-06-11 09:28:08.946636Z] Finished setup-mitmproxy step (success) 02:28:08 INFO - [mozharness: 2017-06-11 09:28:08.946860Z] Running run-tests step. 02:28:08 INFO - Running pre-action listener: _resource_record_pre_action 02:28:08 INFO - Running main action method: run_tests 02:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:08 INFO - Python 2.7.3 02:28:08 INFO - Return code: 0 02:28:08 INFO - grabbing minidump binary from tooltool 02:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:08 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 0x21af140>, '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 0x21afa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21afed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:28:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:28:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:28:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:09 INFO - Return code: 0 02:28:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:09 INFO - ENV: RUST_BACKTRACE is now 1 02:28:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:28:09 INFO - Using env: {'DISPLAY': ':0', 02:28:09 INFO - 'HOME': '/home/cltbld', 02:28:09 INFO - 'LANG': 'en_US.UTF-8', 02:28:09 INFO - 'LANGUAGE': 'en_US:en', 02:28:09 INFO - 'LOGNAME': 'cltbld', 02:28:09 INFO - 'MAIL': '/var/mail/cltbld', 02:28:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:09 INFO - 'MOZ_NO_REMOTE': '1', 02:28:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:09 INFO - 'NO_EM_RESTART': '1', 02:28:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:09 INFO - 'PWD': '/builds/slave/test', 02:28:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:09 INFO - 'RUST_BACKTRACE': '1', 02:28:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:28:09 INFO - 'SHELL': '/bin/bash', 02:28:09 INFO - 'SHLVL': '1', 02:28:09 INFO - 'TERM': 'linux', 02:28:09 INFO - 'TMOUT': '86400', 02:28:09 INFO - 'USER': 'cltbld', 02:28:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739', 02:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:09 INFO - '_': '/tools/buildbot/bin/python'} 02:28:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:28:09 INFO - mozversion application_buildid: 20170611083556 02:28:09 INFO - mozversion application_changeset: 799d43edb324395cf02da6b028e803712334615f 02:28:09 INFO - mozversion application_display_name: Nightly 02:28:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:09 INFO - mozversion application_name: Firefox 02:28:09 INFO - mozversion application_remotingname: firefox 02:28:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:28:09 INFO - mozversion application_vendor: Mozilla 02:28:09 INFO - mozversion application_version: 55.0a1 02:28:09 INFO - mozversion platform_buildid: 20170611083556 02:28:09 INFO - mozversion platform_changeset: 799d43edb324395cf02da6b028e803712334615f 02:28:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:28:09 INFO - mozversion platform_version: 55.0a1 02:28:09 INFO - using testdate: 1497173289 02:28:09 INFO - actual date: 1497173289 02:28:09 INFO - starting webserver on 'localhost:34802' 02:28:09 INFO - SUITE-START | Running 2 tests 02:28:09 INFO - TEST-START | dromaeo_css 02:28:09 INFO - operating with platform_type : linux_ 02:28:09 INFO - Initialising browser for dromaeo_css test... 02:28:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34802/getInfo.html -profile /tmp/tmp1yPb3s/profile 02:28:09 INFO - TEST-INFO | started process 3332 (/builds/slave/test/build/application/firefox/firefox http://localhost:34802/getInfo.html) 02:28:45 INFO - TEST-INFO | 3332: killed by SIGTERM 02:28:45 INFO - Browser initialized. 02:28:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:45 INFO - TEST-INFO | started process 3563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yPb3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:57 INFO - PID 3563 | RSS: Main: 190054400 02:28:57 INFO - PID 3563 | 02:31:58 INFO - PID 3563 | Cycle 1(1): loaded http://localhost:34802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34802/tests/dromaeo/cssquery-ext.html) 02:32:00 INFO - PID 3563 | RSS: Main: 187195392 02:32:00 INFO - PID 3563 | 02:35:02 INFO - PID 3563 | Cycle 1(1): loaded http://localhost:34802/tests/dromaeo/cssquery-ext.html (next: http://localhost:34802/tests/dromaeo/cssquery-jquery.html) 02:35:02 INFO - PID 3563 | RSS: Main: 189558784 02:35:02 INFO - PID 3563 | 02:38:04 INFO - PID 3563 | Cycle 1(1): loaded http://localhost:34802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34802/tests/dromaeo/cssquery-mootools.html) 02:38:05 INFO - PID 3563 | RSS: Main: 191074304 02:38:05 INFO - PID 3563 | 02:41:06 INFO - PID 3563 | Cycle 1(1): loaded http://localhost:34802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34802/tests/dromaeo/cssquery-prototype.html) 02:41:07 INFO - PID 3563 | RSS: Main: 188362752 02:41:07 INFO - PID 3563 | 02:44:10 INFO - PID 3563 | Cycle 1(1): loaded http://localhost:34802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34802/tests/dromaeo/cssquery-yui.html) 02:44:10 INFO - PID 3563 | RSS: Main: 191492096 02:44:10 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | Cycle 1(1): loaded http://localhost:34802/tests/dromaeo/cssquery-yui.html (next: http://localhost:34802/tests/dromaeo/cssquery-dojo.html) 02:47:12 INFO - PID 3563 | RSS: Main: 190144512 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | __start_tp_report 02:47:12 INFO - PID 3563 | _x_x_mozilla_page_load 02:47:12 INFO - PID 3563 | _x_x_mozilla_page_load_details 02:47:12 INFO - PID 3563 | |i|pagename|runs| 02:47:12 INFO - PID 3563 | |0;dojo.html;2958.3639517503734;3012.0361484325017;3046.223213080664;3049.679783622721;3062.816231026139;5748.338941021784;5762.798302059424;5800.7679692812235;5848.590598658096;5864.824055278343;5755.712214389285;5792.82621521355;5815.447532484418;5829.504492118175;5844;5287.444818294081;5301.151815709478;5339.733013349336;5351.57187425005;5380.865478363033;5402.027635025694;5440.047991601474;5444.727763611823;5462.0441422751055;5479.863003424906;5373.086575282211;5384.596155288349;5425.782968681248;5427.972860135714;5435.456454354572;5307.893842123136;5316.574674026068;5399.325084364455;5429.40276569579;5457.481539253765;5120.948790512084;5187.325647665817;5269.762860671279;5274.525292723635;5282.788688452457;5713;5726.971365143189;5769.567282453832;5781.421857814227;5795.478406943395;6153.415425534612;6217.937820621781;6222.253329600477;6228.657423841687;6239.906401403982;6266.122742816009;6268.153799237136;6271.749130034793;6275.152854364648;6288.339724328971;5657.151427285858;5716.942830571724;5807.390224026501;5817.650940943557;5859.033259512218;6273.498120150468;6336.58812177207;6388.041793730885;6440.4847612190915;6452.612843229421;6113.205283313141;6122.479589234876;6129.724162412702;6131.040261761288;6136.171616831671;6173.536984726074;6216.44052035319;6222.253329600477;6223.844403889849;6261.686915654199;6103.633781973096;6172.166757487771;6173.722182501798;6175.073738939195;6184.381561843779;6145.310039739018;6189.35011823752;6200.689965501707;6212.9068063979075;6217.689115544295;5179.300794392784;5179.585633149339;5201.791928322825;5205.245239440335;5227.477252274742;4384.824607015684;4408.757518336458;4460.197164510354;4482.439695038121;4517.34498497716;5473.17902314648;5487;5490.945090549123;5492.395836457987;5497.175423686479;6130.642739936431;6211.3167551569295;6254.343293954069;6300.180976473029;6319.304876463585;5486.643368181056;5490.176473529003;5503.3120859892515;5540.833774986757;5551.500364967173;5582.944170558242;5586.804461843816;5593.636413633101;5607.887842243133;5640.266765320482;6126.816195514052;6143.846403839851;6144.8771024579255;6149.13912052313;6153.84615384619;6271.874562508816;6289.088082228142;6300.117983482224;6307.30619631831;6330.050492426173;5976.970115149396;6060.303065147565;6100.2984656763265;6113.083037544404;6129.509639228761;6113.480354169767;6156.230471191101;6187.102870083902;6196.81409557714;6199.721012554356;6313.147725057059;6350.333215012542;6362.395572420613;6367.363263673596;6369.649669268049;6130.601510901777;6151.784687535915;6166.537509686881;6170.598911070766;6171;6125.448709616156;6150.446459818638;6154.723037463235;6159.476444502088;6161.599496032743;5909.52723782105;5920.200772895604;5995.91006134917;6020.819375418744;6043.063325184604;6101.481374083252;6135.141080248858;6159.538034647329;6164.568480206342;6204.751809927552;5981.700914954322;6018.789342372996;6022.036474164112;6034.788782392595;6072.119542666377 02:47:12 INFO - PID 3563 | |1;ext.html;714.2785786355782;751.6091632351181;766.7393086350642;784.3725019984015;789.6920201121562;36106.45840312394;36976.26047479052;37019.25961480776;37020.259594808085;37161.814190929006;33410;33544;33559.161020974425;33576.49635255467;33580;6545.312742162064;6595.53831231814;6598.208215014205;6649.501287403464;6659.33406659335;6404.583702059374;6498.252700939405;6498.772542960997;6505.056766768839;6511.804645860608;6471.579347342407;6485.935140648604;6489.156409666761;6493.383128602775;6510.804675859732;6422.357764223563;6458.741650334005;6466.191726034246;6487.708053137573;6490.772822951221;5998.040313549811;6048.455638992467;6048.939510604881;6051.213342265477;6939.444844412435;34531;34851.477227841606;34906.47640285398;35045;35050.47424288612;3283.4582293921476;3331.583552055993;3331.850066747002;3335.7998520088872;3348.882789102394;27270.5909411359;27276.590851137247;27310.726892731018;27343.589846152325;27442.17673469799;3054.083774867531;3064.6169228846393;3077.584526088994;3094.845257737104;3095.241665791873;166203;167356;168178;168278;168535.99999999878;44397.11205775866;44688.3296750549;44694.776526117814;44753.55246447494;44822.32766508505;46013.76993115013;46054.309185362246;46064.53935460669;46150.5384946153;46177.538224617994;14365.20991345486;14399.712005759826;14521;14531.200783956983;14561;11612.477438515287;11692.649220523397;11757.235779674294;11761.823572646417;11769.764604708029;13118.147320424141;13228.801567976489;13247.602571922858;13458.663533411547;13512.662183445296;5486.670799751948;5527.364353099365;5556.638818476786;5589.189567512688;5649.378568357477;985.2216748768536;993.8211121997965;1007.1690855044618;1026.8973102689672;1031.3863251365426;21450.141994320365;22015.889920550293;22206.333809985405;22934.42663933415;27441.588376173975;1087.2009073331096;1096.780643871229;1097.5445190246119;1104.2380757277454;1107.4628805029554;12277.69305767345;12431.875681243071;12461.626151215478;12576.685582860502;12590.24458532491;206958;208209;208364;208853;209976;34225.31549369048;35491.4676279856;35514.46728299077;46792.53207467882;47362;1268.245393990574;1427.6930459950952;1434.5624584501618;1446.3997441061842;1449.9057561258485;23167.420814479774;24617.630735538623;25120;25227.74772252254;25420.74579254184;34324.828375857964;34657.826710866284;34702.65297346994;34706.47940280847;34733.1316717074;169811;169975;170313;170586;170596;31037;31201;31218.531722023734;31300.217494561908;31301.373972519967;37566.812165938994;37567.43648845324;38270.80864595659;39379.21241575095;39500;27358;28486.715132849236;28564.285892852844;29066.564001540417;29784.10647680573;27956.30109247285;28088;29007.274818129714;29410.264743381587;29518.409631807674;32114.51828222532;32282.515762264055;32378.838105809322;32569.674303256663;32609.510857337635;26663;27641.447171056065;28489.715102848706;28503.28741781472;30106.24734381658;21140.894295528426;23407.882960585768;23555.646665300377;23569.764302356758;23598.528029439658 02:47:12 INFO - PID 3563 | |2;jquery.html;469.19298806053575;487.1941691980709;490.54341309205864;500.3495455907321;509.36838320482565;19530.414087577377;19733.703994440093;20286.391408257758;20358.389248322535;20441.386758397235;18020.54948626285;21013.054412551435;22268.8886555567;22371.552568948653;22407.99164037618;5720.427957204288;5778.768849246025;5795.1886735857015;5829.5919285650025;5855.8536036599;5785.566082543826;5809.564282678795;5866.6480011199255;5874.73563689635;5895.380984996578;5661.688607126627;5876.853078673024;5888.440598143169;5938.970305148489;5966.045432730764;5891.499222566087;5918.911216331759;5937.6140550864275;5940.138679891413;5947.256592925884;5461.563074954034;5461.590380721462;5479.835604931858;5482.068048431736;5488.286522752057;24526.754732452624;24871.378215544755;24903.62644560333;24906;24969.50060998788;1907.9713804292946;1914.8946807925558;1941.883486990785;1946.6009468059015;1954.784973652897;15661.373545058184;16319.510414687578;16327.591810204722;16360.509184724477;16374.345026198938;2183.290430610058;2212.2920665387082;2250.561140577588;2255.391044418014;2256.8420210585264;93956;99917;99924.50037749765;100009;115278;12254.20347677398;12419.627411177678;12444.502219911283;12458.501659933683;13132;18663.88016719001;18708.438746837615;18791.15439805212;18822.247110115717;18859.434216973514;8456.746297611082;8882.600282987281;8892.822143557092;8962.775930601656;9107;8260.215279548433;8427.536485493356;8462.238398544161;8488.363372747068;8558.871616925751;7672.309492145734;7787.844243115106;7872.763817085496;7979.720709775246;7995.440319177602;2352.752960939111;2363.5981883079917;2406.5307265083493;2407.4944261704886;2465.8898516083914;957.5834511987308;962.6775030364767;966.4877614864133;1003.934744241622;1006.8892421833592;17750.644987100186;17792.199351029234;17906.194221260073;18152.63694726098;18503.35238266654;965.99034009659;980.6910823090703;1002.8595996560488;1010.540204207084;1019.5717798524637;9854;9961.900380996098;9981.550830212658;10013;10184.287099902936;380649;396531;396751;399796;403144;93176;94297.52851235837;94451;94594.52702736443;94626;983.7343917142332;1024.0834453164375;1026.2508368890751;1124.7852319494925;1146.954121835134;14995.625109371917;18290.26838926428;18539.165737541574;18731.719024214373;18944.715829262295;43964.560354396046;45253.77373113245;46035.3094703573;47371.28943065926;47960.520394797;57130;57373.426265738475;58112;58200.4179958195;58207;10782.784344313226;10973.341599504056;11021.228514003942;11063.778724425627;11080.61217857371;15216.239188040332;16840.57898552546;16887.831121688625;17086.572835679206;17454.30182792674;13501.72996540044;14006.649833754238;14337.64155896111;14406.135631861702;14468;11934.462949167135;12119.272843629411;12505.874941250835;12853.614391567893;12990.155639883378;13566.38951247216;14186;14198.148111113367;14235.217063061631;14270;10834.67495975122;10847.91520847909;10863.565457381615;10878.564857405932;10879.891201087888;12673.493060277486;13553.59339219825;13749.656258593615;13808.17150970945;13823.447062117804 02:47:12 INFO - PID 3563 | |3;mootools.html;1183.1244878789696;1186.1519013905056;1203.6629743671772;1204.7229137298416;1214.1136970011892;11758.764824703512;12285.324307163102;12304.138710290283;12368.752624947496;12374.257544547334;10270.435126068063;10562;10635.468226588679;11698;12101.092418068658;2456.6806315179;2482.7889629381525;2482.8510289382602;2485.478049609584;2493.2146373892165;2413.987930060347;2446.2416650838295;2448.8285819992607;2475.4553998120473;2478.0583378316214;2419.637054441839;2428.7571242875747;2431.465077682907;2432.136591510015;2434.7686969737847;2093.340597711716;2132.989335053315;2137.3053757528864;2140.818030467412;2142.046789178816;2315.235972129193;2327.8254130940245;2334.6498025296173;2347.424880904189;2353.623420252751;11713.824292635532;11867.703307417298;11980.400979950968;12004.339761313124;12045.63863084109;6410;6638.435732962704;6639.43564796988;6640.236372817139;6640.369164929324;3833.21419109082;4007.6393124618926;4094.447249621293;4163.521195062546;4178.937315940263;1263.7535680542298;1285.7814171590758;1306.1575283941804;1341.590814801485;1381.5095641047485;18072.638547229115;18132.63734725298;18173.909130454394;18195.45413637593;18286.35997740086;5552.167174923713;5670.914936275959;5696.943030569641;5826.912596311059;5847.44449277318;14748.63128421798;14756.188409637358;14800.629984250265;14815;14821.92589037048;6625.105610742585;6659.101021362151;6673.699683514254;6701;6708.127943367331;6100.877982440326;6133.815985520441;6217;6274.686265686697;6299.307076221612;4833.709977401367;4914.0908931847725;4917.139500587383;4952.504749525091;5009.5491405773655;1581.6362236685397;1583.2875206157046;1591.9543386747973;1614.4510866305513;1620.9189540522927;730.4229658569776;740.5667684404683;754.9207333230041;762.2377622377622;779.2285637219112;5438.483344082306;5532.585056120726;5653.406392328746;5869.06095024794;5972.074328479092;637.1621317966859;642.133120287608;664.4983037806522;670.47367816264;676.82064252973;4062.207869465485;4074.3684728867074;4090.468239128954;4177.853775117917;4288.148381326383;13390.26353550564;15140.394384224728;15172;15173.924130379499;15249.695006099815;14926.925365373103;14950.401983920521;14968.550943471713;15030.098194108388;15062.096274223582;8613.22480976715;8761.167689069656;8795.736127916172;9226.86159707605;9515.952420237993;7518.887216691644;7634.923650763643;7652.7704168875025;7750.341220996278;7888.329491993245;13780.379882905092;14597.416103355747;14866.851331486547;15003.399864005318;15261.923690381476;15011.973383593511;15051.322690479174;15347.923260383626;15727.213639318217;15777.68444631124;9047;9391.20174785151;9400.858987115336;9823.705288841345;10273;11849.703757406134;11917.642470725892;12014.519419223483;12057.216280941711;12109.031277497956;9431.717048488556;9570.234381249622;9770.706878793648;9772.120509153925;10097.848532272168;9207.953960230156;9497.097775711296;9582.808343832945;9594.712158635251;9973.401595904268;7812.335951444191;8002.83994320122;8005;8008.199180081945;8012.038555373392;6008.519318454601;6016.338202797776;6185.134081228542;6245.375462453719;6360.363963603602;6045.063015232646;6239.313675495601;6276.686165691788;6386.265579458422;6577.934220657732 02:47:12 INFO - PID 3563 | |4;prototype.html;415.9729617574859;420.06954595570807;437.7242337327483;443.1756932106281;451.8170141092859;6070.9628097315235;6108.236470441195;6137.693115344237;6153.876922461548;6167.198264225655;5710.571707121972;5930.670610454371;5946.940530594693;5954.196183515224;5975;4766.094442055998;4786.353842231289;4806.351142595758;4813.56677898989;4835.492273311304;4735.3133795599615;4749.572538471537;4755.667103302771;4772.904541909177;4781.115493633672;4563.703359281636;4716.669833111683;4747.335373047776;4754.66717329787;4772.73749943753;4778.689385189969;4779.163646361872;4791.880202994936;4793.161196790547;4798;4201.907504048939;4257.233697934371;4264.530901600821;4288.871333859989;4288.957110428887;5763.481286684177;5805.158252053471;5827.650340979555;5854.180414741897;5864.941350586482;5412.646838290428;5451.836444906659;5452.146270268088;5463.945360546383;5471.781128754845;6249.781257656005;6269.7178626961895;6271.3728627136925;6278.6860656966965;6316.463100636452;4628.537146285378;4630;4636.53634636537;4641.976790116061;4681.414823147106;6636.137302150738;6715.395614394728;6720.899186512206;6731.394174524316;6745.29174436682;4766.4995175506765;4773.737444440589;4782.95217047832;4788.880277993078;4794.496577859344;4834.6374021947795;4841.540053694894;4848.151573474698;4848.539388758062;4856.247281671346;5470.5350045245805;5479.369872464717;5493.368262649767;5496.587755918322;5498.560115190775;6377.457916077093;6384.361563843671;6404.743810247631;6408.775692850728;6417.935820641734;1552.7049860526463;1650.9009459432473;1663.4843198608228;1670.6742185273997;1677.5302915183768;979.8285300072458;1099.7360633447915;1131.3551275772895;1137.7724455109012;1165.318288801044;5515.806946756925;5540.196671482693;5565.972170139124;5566.888662226733;5574.219609254707;6483.3516648335735;6537.1174891389055;6606.636634985026;6626.599321552919;6639.502037347218;5610.87782443513;5650.3502097258515;5674.886502269931;5681.857953551194;5685.488306052475;3459.2357897471966;3500.3524347995703;3502.7022703070015;3502.9299414011575;3513.191965847818;6120.510359171256;6335.732853429333;6358.809235722843;6376.39424254695;6379.744810207632;6649.63427011519;6651.401373876374;6671.366220209073;6680.365365290289;6700.765473208415;6263.937360626426;6292.433680968643;6322.968385158137;6328.810135695937;6329.588576742589;6523.543351965317;6548.738050477928;6563.442107420923;6564.5076619254705;6581.3418658133805;6473.514486413632;6516.934830651633;6518.674066296571;6520.576162549419;6535.869282614416;6307.24313082433;6359.7456101755415;6375.6174629522375;6419.133416988647;6422.325655806073;4729.55069268419;4764.523547645208;4769.35613692161;4776.331313616027;4790.976045119752;6523.3476652336285;6544.509161812788;6551.181102362205;6604.282886449461;6610.570312929644;6316.463100636497;6347.619142851444;6382.393672601095;6383.648899310582;6393.2647745508;6331.303556608861;6363.3636636336;6363.5227357947415;6368.42684158428;6412.97392417211;5913.46778789911;6320.936790632035;6321.051842223703;6326.557141000086;6364.363563643598;6369.554131210771;6420.165378500952;6434.64609446485;6455.838604034937;6480.319566445644;6150.569460137747;6220;6231.781887633911;6234.501239900887;6247 02:47:12 INFO - PID 3563 | |5;yui.html;783.4320117914509;787.4055088408251;818.6316157729024;844.2739244249946;857.2798848966867;16894.155292235384;17277.222524986373;17300.91349543254;17342.30630774769;17456;13657.658558536017;14049.719005619907;14107.858921410783;16448.917755411236;17057.914710426463;982.7739619887412;999.9850152095629;1006.6828948881116;1007.2747621712356;1008.4352762453013;996.9501524923761;1003;1003.9849402258972;1004.2116938203511;1005.632943975451;1055.3562326980536;1057.5241141486324;1059.9205059620522;1060.289605964002;1060.973475663107;973.5278389980854;1013.3210748798323;1046.0271947089204;1053.6944286157004;1057.4501259345175;755.5051441305953;757.5454727163713;759.6999185321822;760.8630446519625;761.9352355049828;16373.017618942782;16725.6654866902;16793.83206167935;16820.411285605067;16847.494575162764;18579.349722759773;18778.436646900616;18965.24139034437;19112;19199.808001920082;13751.243681597509;13992.860071399258;14051.297435128203;14078.577642670736;14129.152250864878;3412.8293585320635;3442.4147894857933;3443.3974054540354;3448.0173150651945;3449.137715571107;82006;85054;85829.57085214596;85912;90870;14835.10989340643;14846.851531484546;14860.108393496208;14974.700505990037;15180.924095379452;24734.763261836837;25241.116560920647;25602.103926362488;25615;26165.73834261671;7673.693052277958;7703.6918523259565;7707.152213256537;7721.575313357819;7760.611969401621;3759.022654109951;3804.505414296124;3805.5433347997864;3839.232153569297;3864.130570621644;4430.446194225722;4434.84478043267;4445.911081778347;4480.439945006874;4487.349334346502;803.6303300481727;828.2173346187794;837.2046555771919;840.878072679458;849.8569424124543;646.405307117453;663.1213641924373;687.226869771507;696.6656005117572;703.3248081841388;10783;11755.88244117548;12327.445264963098;12850;13007.219566825832;667.5961043568668;705.9188193357727;721.2210812322679;725.9854802903913;732.6300218389679;4977.726225057657;5170.508801663836;5176.120059589879;5278.287431196739;5329.573634109262;76996.61501692567;80649.59675201586;81244.18755812367;82989;83079.5846020766;68752.6562367185;69310;70545;71543.6422817893;71983.6400818003;61302;61372.69313653492;64009;64770.352296476434;65741.34258657448;10223.846642300521;10493.685189444328;10555.52500137511;10833.882465704011;10982.341059536453;27627.171184864485;28933;29073.85463072671;29248.122556323346;29883.25291867634;36248.275034498634;36910.63089369072;37290.067748305424;37590.624093759805;37977.24045519129;13681.452741890213;14330.211838348574;14454.783178252124;14495.347709353315;14585.197814120325;15765.842341576437;16158.757618635495;16178.595535111717;16762.664746704755;16846.915765421094;14250.429982800571;14647.26763661834;14684.706305874037;14776.33506492232;14799.260036997892;14179;14657.193854338113;14806.77789833175;14830.925845370704;14982.850171498145;14264.714705706036;14352.856471435152;14679.633009174857;14812.62968425798;14824.62938426548;9609.51952402391;9717.465539395402;9985;9991.500424978867;10374.066334029974;10739.946300268448;10799.40603266828;11097.278676885977;11210.943945280222;11367.090632749525 02:47:12 INFO - PID 3563 | __end_tp_report 02:47:12 INFO - PID 3563 | __start_cc_report 02:47:12 INFO - PID 3563 | _x_x_mozilla_cycle_collect,385 02:47:12 INFO - PID 3563 | __end_cc_report 02:47:12 INFO - PID 3563 | __startTimestamp1497174432769__endTimestamp 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | ------- Summary: start ------- 02:47:12 INFO - PID 3563 | Number of tests: 6 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | [#0] dojo.html Cycles:165 Average:5773.79 Median:6022.04 stddev:652.44 (10.8%) stddev-sans-first:615.92 02:47:12 INFO - PID 3563 | Values: 2958.4 3012.0 3046.2 3049.7 3062.8 5748.3 5762.8 5800.8 5848.6 5864.8 5755.7 5792.8 5815.4 5829.5 5844.0 5287.4 5301.2 5339.7 5351.6 5380.9 5402.0 5440.0 5444.7 5462.0 5479.9 5373.1 5384.6 5425.8 5428.0 5435.5 5307.9 5316.6 5399.3 5429.4 5457.5 5120.9 5187.3 5269.8 5274.5 5282.8 5713.0 5727.0 5769.6 5781.4 5795.5 6153.4 6217.9 6222.3 6228.7 6239.9 6266.1 6268.2 6271.7 6275.2 6288.3 5657.2 5716.9 5807.4 5817.7 5859.0 6273.5 6336.6 6388.0 6440.5 6452.6 6113.2 6122.5 6129.7 6131.0 6136.2 6173.5 6216.4 6222.3 6223.8 6261.7 6103.6 6172.2 6173.7 6175.1 6184.4 6145.3 6189.4 6200.7 6212.9 6217.7 5179.3 5179.6 5201.8 5205.2 5227.5 4384.8 4408.8 4460.2 4482.4 4517.3 5473.2 5487.0 5490.9 5492.4 5497.2 6130.6 6211.3 6254.3 6300.2 6319.3 5486.6 5490.2 5503.3 5540.8 5551.5 5582.9 5586.8 5593.6 5607.9 5640.3 6126.8 6143.8 6144.9 6149.1 6153.8 6271.9 6289.1 6300.1 6307.3 6330.1 5977.0 6060.3 6100.3 6113.1 6129.5 6113.5 6156.2 6187.1 6196.8 6199.7 6313.1 6350.3 6362.4 6367.4 6369.6 6130.6 6151.8 6166.5 6170.6 6171.0 6125.4 6150.4 6154.7 6159.5 6161.6 5909.5 5920.2 5995.9 6020.8 6043.1 6101.5 6135.1 6159.5 6164.6 6204.8 5981.7 6018.8 6022.0 6034.8 6072.1 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | [#1] ext.html Cycles:180 Average:33431.78 Median:31259.37 stddev:47365.42 (151.5%) stddev-sans-first:47434.58 02:47:12 INFO - PID 3563 | Values: 714.3 751.6 766.7 784.4 789.7 36106.5 36976.3 37019.3 37020.3 37161.8 33410.0 33544.0 33559.2 33576.5 33580.0 6545.3 6595.5 6598.2 6649.5 6659.3 6404.6 6498.3 6498.8 6505.1 6511.8 6471.6 6485.9 6489.2 6493.4 6510.8 6422.4 6458.7 6466.2 6487.7 6490.8 5998.0 6048.5 6048.9 6051.2 6939.4 34531.0 34851.5 34906.5 35045.0 35050.5 3283.5 3331.6 3331.9 3335.8 3348.9 27270.6 27276.6 27310.7 27343.6 27442.2 3054.1 3064.6 3077.6 3094.8 3095.2 166203.0 167356.0 168178.0 168278.0 168536.0 44397.1 44688.3 44694.8 44753.6 44822.3 46013.8 46054.3 46064.5 46150.5 46177.5 14365.2 14399.7 14521.0 14531.2 14561.0 11612.5 11692.6 11757.2 11761.8 11769.8 13118.1 13228.8 13247.6 13458.7 13512.7 5486.7 5527.4 5556.6 5589.2 5649.4 985.2 993.8 1007.2 1026.9 1031.4 21450.1 22015.9 22206.3 22934.4 27441.6 1087.2 1096.8 1097.5 1104.2 1107.5 12277.7 12431.9 12461.6 12576.7 12590.2 206958.0 208209.0 208364.0 208853.0 209976.0 34225.3 35491.5 35514.5 46792.5 47362.0 1268.2 1427.7 1434.6 1446.4 1449.9 23167.4 24617.6 25120.0 25227.7 25420.7 34324.8 34657.8 34702.7 34706.5 34733.1 169811.0 169975.0 170313.0 170586.0 170596.0 31037.0 31201.0 31218.5 31300.2 31301.4 37566.8 37567.4 38270.8 39379.2 39500.0 27358.0 28486.7 28564.3 29066.6 29784.1 27956.3 28088.0 29007.3 29410.3 29518.4 32114.5 32282.5 32378.8 32569.7 32609.5 26663.0 27641.4 28489.7 28503.3 30106.2 21140.9 23407.9 23555.6 23569.8 23598.5 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | [#2] jquery.html Cycles:180 Average:28106.87 Median:2252.98 stddev:66297.36 (2942.7%) stddev-sans-first:66450.87 02:47:12 INFO - PID 3563 | Values: 469.2 487.2 490.5 500.3 509.4 19530.4 19733.7 20286.4 20358.4 20441.4 18020.5 21013.1 22268.9 22371.6 22408.0 5720.4 5778.8 5795.2 5829.6 5855.9 5785.6 5809.6 5866.6 5874.7 5895.4 5661.7 5876.9 5888.4 5939.0 5966.0 5891.5 5918.9 5937.6 5940.1 5947.3 5461.6 5461.6 5479.8 5482.1 5488.3 24526.8 24871.4 24903.6 24906.0 24969.5 1908.0 1914.9 1941.9 1946.6 1954.8 15661.4 16319.5 16327.6 16360.5 16374.3 2183.3 2212.3 2250.6 2255.4 2256.8 93956.0 99917.0 99924.5 100009.0 115278.0 12254.2 12419.6 12444.5 12458.5 13132.0 18663.9 18708.4 18791.2 18822.2 18859.4 8456.7 8882.6 8892.8 8962.8 9107.0 8260.2 8427.5 8462.2 8488.4 8558.9 7672.3 7787.8 7872.8 7979.7 7995.4 2352.8 2363.6 2406.5 2407.5 2465.9 957.6 962.7 966.5 1003.9 1006.9 17750.6 17792.2 17906.2 18152.6 18503.4 966.0 980.7 1002.9 1010.5 1019.6 9854.0 9961.9 9981.6 10013.0 10184.3 380649.0 396531.0 396751.0 399796.0 403144.0 93176.0 94297.5 94451.0 94594.5 94626.0 983.7 1024.1 1026.3 1124.8 1147.0 14995.6 18290.3 18539.2 18731.7 18944.7 43964.6 45253.8 46035.3 47371.3 47960.5 57130.0 57373.4 58112.0 58200.4 58207.0 10782.8 10973.3 11021.2 11063.8 11080.6 15216.2 16840.6 16887.8 17086.6 17454.3 13501.7 14006.6 14337.6 14406.1 14468.0 11934.5 12119.3 12505.9 12853.6 12990.2 13566.4 14186.0 14198.1 14235.2 14270.0 10834.7 10847.9 10863.6 10878.6 10879.9 12673.5 13553.6 13749.7 13808.2 13823.4 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | [#3] mootools.html Cycles:180 Average:7427.57 Median:2489.35 stddev:4909.55 (197.2%) stddev-sans-first:4900.90 02:47:12 INFO - PID 3563 | Values: 1183.1 1186.2 1203.7 1204.7 1214.1 11758.8 12285.3 12304.1 12368.8 12374.3 10270.4 10562.0 10635.5 11698.0 12101.1 2456.7 2482.8 2482.9 2485.5 2493.2 2414.0 2446.2 2448.8 2475.5 2478.1 2419.6 2428.8 2431.5 2432.1 2434.8 2093.3 2133.0 2137.3 2140.8 2142.0 2315.2 2327.8 2334.6 2347.4 2353.6 11713.8 11867.7 11980.4 12004.3 12045.6 6410.0 6638.4 6639.4 6640.2 6640.4 3833.2 4007.6 4094.4 4163.5 4178.9 1263.8 1285.8 1306.2 1341.6 1381.5 18072.6 18132.6 18173.9 18195.5 18286.4 5552.2 5670.9 5696.9 5826.9 5847.4 14748.6 14756.2 14800.6 14815.0 14821.9 6625.1 6659.1 6673.7 6701.0 6708.1 6100.9 6133.8 6217.0 6274.7 6299.3 4833.7 4914.1 4917.1 4952.5 5009.5 1581.6 1583.3 1592.0 1614.5 1620.9 730.4 740.6 754.9 762.2 779.2 5438.5 5532.6 5653.4 5869.1 5972.1 637.2 642.1 664.5 670.5 676.8 4062.2 4074.4 4090.5 4177.9 4288.1 13390.3 15140.4 15172.0 15173.9 15249.7 14926.9 14950.4 14968.6 15030.1 15062.1 8613.2 8761.2 8795.7 9226.9 9516.0 7518.9 7634.9 7652.8 7750.3 7888.3 13780.4 14597.4 14866.9 15003.4 15261.9 15012.0 15051.3 15347.9 15727.2 15777.7 9047.0 9391.2 9400.9 9823.7 10273.0 11849.7 11917.6 12014.5 12057.2 12109.0 9431.7 9570.2 9770.7 9772.1 10097.8 9208.0 9497.1 9582.8 9594.7 9973.4 7812.3 8002.8 8005.0 8008.2 8012.0 6008.5 6016.3 6185.1 6245.4 6360.4 6045.1 6239.3 6276.7 6386.3 6577.9 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | [#4] prototype.html Cycles:180 Average:5331.62 Median:5922.07 stddev:1529.84 (25.8%) stddev-sans-first:1488.98 02:47:12 INFO - PID 3563 | Values: 416.0 420.1 437.7 443.2 451.8 6071.0 6108.2 6137.7 6153.9 6167.2 5710.6 5930.7 5946.9 5954.2 5975.0 4766.1 4786.4 4806.4 4813.6 4835.5 4735.3 4749.6 4755.7 4772.9 4781.1 4563.7 4716.7 4747.3 4754.7 4772.7 4778.7 4779.2 4791.9 4793.2 4798.0 4201.9 4257.2 4264.5 4288.9 4289.0 5763.5 5805.2 5827.7 5854.2 5864.9 5412.6 5451.8 5452.1 5463.9 5471.8 6249.8 6269.7 6271.4 6278.7 6316.5 4628.5 4630.0 4636.5 4642.0 4681.4 6636.1 6715.4 6720.9 6731.4 6745.3 4766.5 4773.7 4783.0 4788.9 4794.5 4834.6 4841.5 4848.2 4848.5 4856.2 5470.5 5479.4 5493.4 5496.6 5498.6 6377.5 6384.4 6404.7 6408.8 6417.9 1552.7 1650.9 1663.5 1670.7 1677.5 979.8 1099.7 1131.4 1137.8 1165.3 5515.8 5540.2 5566.0 5566.9 5574.2 6483.4 6537.1 6606.6 6626.6 6639.5 5610.9 5650.4 5674.9 5681.9 5685.5 3459.2 3500.4 3502.7 3502.9 3513.2 6120.5 6335.7 6358.8 6376.4 6379.7 6649.6 6651.4 6671.4 6680.4 6700.8 6263.9 6292.4 6323.0 6328.8 6329.6 6523.5 6548.7 6563.4 6564.5 6581.3 6473.5 6516.9 6518.7 6520.6 6535.9 6307.2 6359.7 6375.6 6419.1 6422.3 4729.6 4764.5 4769.4 4776.3 4791.0 6523.3 6544.5 6551.2 6604.3 6610.6 6316.5 6347.6 6382.4 6383.6 6393.3 6331.3 6363.4 6363.5 6368.4 6413.0 5913.5 6320.9 6321.1 6326.6 6364.4 6369.6 6420.2 6434.6 6455.8 6480.3 6150.6 6220.0 6231.8 6234.5 6247.0 02:47:12 INFO - PID 3563 | 02:47:12 INFO - PID 3563 | [#5] yui.html Cycles:180 Average:17781.13 Median:25890.37 stddev:22271.08 (86.0%) stddev-sans-first:22296.98 02:47:12 INFO - PID 3563 | Values: 783.4 787.4 818.6 844.3 857.3 16894.2 17277.2 17300.9 17342.3 17456.0 13657.7 14049.7 14107.9 16448.9 17057.9 982.8 1000.0 1006.7 1007.3 1008.4 997.0 1003.0 1004.0 1004.2 1005.6 1055.4 1057.5 1059.9 1060.3 1061.0 973.5 1013.3 1046.0 1053.7 1057.5 755.5 757.5 759.7 760.9 761.9 16373.0 16725.7 16793.8 16820.4 16847.5 18579.3 18778.4 18965.2 19112.0 19199.8 13751.2 13992.9 14051.3 14078.6 14129.2 3412.8 3442.4 3443.4 3448.0 3449.1 82006.0 85054.0 85829.6 85912.0 90870.0 14835.1 14846.9 14860.1 14974.7 15180.9 24734.8 25241.1 25602.1 25615.0 26165.7 7673.7 7703.7 7707.2 7721.6 7760.6 3759.0 3804.5 3805.5 3839.2 3864.1 4430.4 4434.8 4445.9 4480.4 4487.3 803.6 828.2 837.2 840.9 849.9 646.4 663.1 687.2 696.7 703.3 10783.0 11755.9 12327.4 12850.0 13007.2 667.6 705.9 721.2 726.0 732.6 4977.7 5170.5 5176.1 5278.3 5329.6 76996.6 80649.6 81244.2 82989.0 83079.6 68752.7 69310.0 70545.0 71543.6 71983.6 61302.0 61372.7 64009.0 64770.4 65741.3 10223.8 10493.7 10555.5 10833.9 10982.3 27627.2 28933.0 29073.9 29248.1 29883.3 36248.3 36910.6 37290.1 37590.6 37977.2 13681.5 14330.2 14454.8 14495.3 14585.2 15765.8 16158.8 16178.6 16762.7 16846.9 14250.4 14647.3 14684.7 14776.3 14799.3 14179.0 14657.2 14806.8 14830.9 14982.9 14264.7 14352.9 14679.6 14812.6 14824.6 9609.5 9717.5 9985.0 9991.5 10374.1 10739.9 10799.4 11097.3 11210.9 11367.1 02:47:12 INFO - PID 3563 | -------- Summary: end -------- 02:47:12 INFO - PID 3563 | 02:47:13 INFO - TEST-INFO | 3563: exit 0 02:47:13 INFO - TEST-OK | dromaeo_css | took 1144103ms 02:47:13 INFO - TEST-START | kraken 02:47:13 INFO - operating with platform_type : linux_ 02:47:13 INFO - Initialising browser for kraken test... 02:47:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34802/getInfo.html -profile /tmp/tmpYi6sx7/profile 02:47:13 INFO - TEST-INFO | started process 3988 (/builds/slave/test/build/application/firefox/firefox http://localhost:34802/getInfo.html) 02:47:48 INFO - TEST-INFO | 3988: killed by SIGTERM 02:47:48 INFO - Browser initialized. 02:47:48 INFO - Running cycle 1/1 for kraken test... 02:47:48 INFO - TEST-INFO | started process 4219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYi6sx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:00 INFO - PID 4219 | RSS: Main: 188837888 02:48:00 INFO - PID 4219 | 02:48:03 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34802/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:04 INFO - PID 4219 | RSS: Main: 191586304 02:48:04 INFO - PID 4219 | 02:48:06 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34802/tests/kraken/driver.html?testName=audio-dft) 02:48:07 INFO - PID 4219 | RSS: Main: 192266240 02:48:07 INFO - PID 4219 | 02:48:10 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34802/tests/kraken/driver.html?testName=audio-fft) 02:48:11 INFO - PID 4219 | RSS: Main: 188620800 02:48:11 INFO - PID 4219 | 02:48:13 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34802/tests/kraken/driver.html?testName=audio-oscillator) 02:48:13 INFO - PID 4219 | RSS: Main: 189440000 02:48:13 INFO - PID 4219 | 02:48:16 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:16 INFO - PID 4219 | RSS: Main: 189370368 02:48:16 INFO - PID 4219 | 02:48:19 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34802/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:20 INFO - PID 4219 | RSS: Main: 190349312 02:48:20 INFO - PID 4219 | 02:48:23 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34802/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:24 INFO - PID 4219 | RSS: Main: 191983616 02:48:24 INFO - PID 4219 | 02:48:27 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34802/tests/kraken/driver.html?testName=json-parse-financial) 02:48:28 INFO - PID 4219 | RSS: Main: 190787584 02:48:28 INFO - PID 4219 | 02:48:29 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:30 INFO - PID 4219 | RSS: Main: 190795776 02:48:30 INFO - PID 4219 | 02:48:32 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:32 INFO - PID 4219 | RSS: Main: 190132224 02:48:32 INFO - PID 4219 | 02:48:34 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:35 INFO - PID 4219 | RSS: Main: 190181376 02:48:35 INFO - PID 4219 | 02:48:38 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:38 INFO - PID 4219 | RSS: Main: 190545920 02:48:38 INFO - PID 4219 | 02:48:41 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:42 INFO - PID 4219 | RSS: Main: 190238720 02:48:42 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | Cycle 1(1): loaded http://localhost:34802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34802/tests/kraken/driver.html?testName=ai-astar) 02:48:44 INFO - PID 4219 | RSS: Main: 191655936 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | __start_tp_report 02:48:44 INFO - PID 4219 | _x_x_mozilla_page_load 02:48:44 INFO - PID 4219 | _x_x_mozilla_page_load_details 02:48:44 INFO - PID 4219 | |i|pagename|runs| 02:48:44 INFO - PID 4219 | |0;ai-astar;103;110;111;113;114;111;111;113;112;112 02:48:44 INFO - PID 4219 | |1;audio-beat-detection;153;123;148;166;124;148;156;123;173;122 02:48:44 INFO - PID 4219 | |2;audio-dft;166;164;164;162;166;168;175;165;165;164 02:48:44 INFO - PID 4219 | |3;audio-fft;75;77;75;161;76;77;75;75;107;78 02:48:44 INFO - PID 4219 | |4;audio-oscillator;83;83;130;83;83;84;128;83;84;136 02:48:44 INFO - PID 4219 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;114;114;115 02:48:44 INFO - PID 4219 | |6;imaging-darkroom;150;154;151;151;150;151;149;151;151;150 02:48:44 INFO - PID 4219 | |7;imaging-desaturate;95;96;99;94;94;94;94;96;95;94 02:48:44 INFO - PID 4219 | |8;json-parse-financial;54;52;52;52;59;54;55;56;52;56 02:48:44 INFO - PID 4219 | |9;json-stringify-tinderbox;55;57;57;57;64;60;56;56;56;56 02:48:44 INFO - PID 4219 | |10;stanford-crypto-aes;87;79;79;82;80;78;80;78;80;78 02:48:44 INFO - PID 4219 | |11;stanford-crypto-ccm;130;128;130;138;129;130;131;145;133;158 02:48:44 INFO - PID 4219 | |12;stanford-crypto-pbkdf2;184;182;186;191;188;191;181;191;189;186 02:48:44 INFO - PID 4219 | |13;stanford-crypto-sha256-iterative;70;76;74;82;70;71;72;73;82;74 02:48:44 INFO - PID 4219 | __end_tp_report 02:48:44 INFO - PID 4219 | __start_cc_report 02:48:44 INFO - PID 4219 | _x_x_mozilla_cycle_collect,1004 02:48:44 INFO - PID 4219 | __end_cc_report 02:48:44 INFO - PID 4219 | __startTimestamp1497174524670__endTimestamp 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | ------- Summary: start ------- 02:48:44 INFO - PID 4219 | Number of tests: 14 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.06 (2.7%) stddev-sans-first:1.27 02:48:44 INFO - PID 4219 | Values: 103.0 110.0 111.0 113.0 114.0 111.0 111.0 113.0 112.0 112.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.50 stddev:19.28 (12.8%) stddev-sans-first:20.15 02:48:44 INFO - PID 4219 | Values: 153.0 123.0 148.0 166.0 124.0 148.0 156.0 123.0 173.0 122.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:3.57 (2.2%) stddev-sans-first:3.79 02:48:44 INFO - PID 4219 | Values: 166.0 164.0 164.0 162.0 166.0 168.0 175.0 165.0 165.0 164.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#3] audio-fft Cycles:10 Average:87.60 Median:75.50 stddev:27.59 (36.5%) stddev-sans-first:28.88 02:48:44 INFO - PID 4219 | Values: 75.0 77.0 75.0 161.0 76.0 77.0 75.0 75.0 107.0 78.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:83.00 stddev:23.30 (28.1%) stddev-sans-first:24.09 02:48:44 INFO - PID 4219 | Values: 83.0 83.0 130.0 83.0 83.0 84.0 128.0 83.0 84.0 136.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 02:48:44 INFO - PID 4219 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.32 (0.9%) stddev-sans-first:1.36 02:48:44 INFO - PID 4219 | Values: 150.0 154.0 151.0 151.0 150.0 151.0 149.0 151.0 151.0 150.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.60 (1.7%) stddev-sans-first:1.69 02:48:44 INFO - PID 4219 | Values: 95.0 96.0 99.0 94.0 94.0 94.0 94.0 96.0 95.0 94.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:2.35 (4.3%) stddev-sans-first:2.49 02:48:44 INFO - PID 4219 | Values: 54.0 52.0 52.0 52.0 59.0 54.0 55.0 56.0 52.0 56.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:57.00 stddev:2.67 (4.7%) stddev-sans-first:2.69 02:48:44 INFO - PID 4219 | Values: 55.0 57.0 57.0 57.0 64.0 60.0 56.0 56.0 56.0 56.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.73 (3.4%) stddev-sans-first:1.32 02:48:44 INFO - PID 4219 | Values: 87.0 79.0 79.0 82.0 80.0 78.0 80.0 78.0 80.0 78.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:132.00 stddev:9.53 (7.2%) stddev-sans-first:9.92 02:48:44 INFO - PID 4219 | Values: 130.0 128.0 130.0 138.0 129.0 130.0 131.0 145.0 133.0 158.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:188.50 stddev:3.73 (2.0%) stddev-sans-first:3.80 02:48:44 INFO - PID 4219 | Values: 184.0 182.0 186.0 191.0 188.0 191.0 181.0 191.0 189.0 186.0 02:48:44 INFO - PID 4219 | 02:48:44 INFO - PID 4219 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:74.00 stddev:4.43 (6.0%) stddev-sans-first:4.40 02:48:44 INFO - PID 4219 | Values: 70.0 76.0 74.0 82.0 70.0 71.0 72.0 73.0 82.0 74.0 02:48:44 INFO - PID 4219 | -------- Summary: end -------- 02:48:44 INFO - PID 4219 | 02:48:45 INFO - TEST-INFO | 4219: exit 0 02:48:45 INFO - TEST-OK | kraken | took 92169ms 02:48:45 INFO - SUITE-END | took 1236s 02:48:46 INFO - Completed test suite (00:20:36) 02:48:46 INFO - javascript benchmark 02:48:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7537.383821254203, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2958.3639517503734, 3012.0361484325017, 3046.223213080664, 3049.679783622721, 3062.816231026139, 5748.338941021784, 5762.798302059424, 5800.7679692812235, 5848.590598658096, 5864.824055278343, 5755.712214389285, 5792.82621521355, 5815.447532484418, 5829.504492118175, 5844.0, 5287.444818294081, 5301.151815709478, 5339.733013349336, 5351.57187425005, 5380.865478363033, 5402.027635025694, 5440.047991601474, 5444.727763611823, 5462.0441422751055, 5479.863003424906, 5373.086575282211, 5384.596155288349, 5425.782968681248, 5427.972860135714, 5435.456454354572, 5307.893842123136, 5316.574674026068, 5399.325084364455, 5429.40276569579, 5457.481539253765, 5120.948790512084, 5187.325647665817, 5269.762860671279, 5274.525292723635, 5282.788688452457, 5713.0, 5726.971365143189, 5769.567282453832, 5781.421857814227, 5795.478406943395, 6153.415425534612, 6217.937820621781, 6222.253329600477, 6228.657423841687, 6239.906401403982, 6266.122742816009, 6268.153799237136, 6271.749130034793, 6275.152854364648, 6288.339724328971, 5657.151427285858, 5716.942830571724, 5807.390224026501, 5817.650940943557, 5859.033259512218, 6273.498120150468, 6336.58812177207, 6388.041793730885, 6440.4847612190915, 6452.612843229421, 6113.205283313141, 6122.479589234876, 6129.724162412702, 6131.040261761288, 6136.171616831671, 6173.536984726074, 6216.44052035319, 6222.253329600477, 6223.844403889849, 6261.686915654199, 6103.633781973096, 6172.166757487771, 6173.722182501798, 6175.073738939195, 6184.381561843779, 6145.310039739018, 6189.35011823752, 6200.689965501707, 6212.9068063979075, 6217.689115544295, 5179.300794392784, 5179.585633149339, 5201.791928322825, 5205.245239440335, 5227.477252274742, 4384.824607015684, 4408.757518336458, 4460.197164510354, 4482.439695038121, 4517.34498497716, 5473.17902314648, 5487.0, 5490.945090549123, 5492.395836457987, 5497.175423686479, 6130.642739936431, 6211.3167551569295, 6254.343293954069, 6300.180976473029, 6319.304876463585, 5486.643368181056, 5490.176473529003, 5503.3120859892515, 5540.833774986757, 5551.500364967173, 5582.944170558242, 5586.804461843816, 5593.636413633101, 5607.887842243133, 5640.266765320482, 6126.816195514052, 6143.846403839851, 6144.8771024579255, 6149.13912052313, 6153.84615384619, 6271.874562508816, 6289.088082228142, 6300.117983482224, 6307.30619631831, 6330.050492426173, 5976.970115149396, 6060.303065147565, 6100.2984656763265, 6113.083037544404, 6129.509639228761, 6113.480354169767, 6156.230471191101, 6187.102870083902, 6196.81409557714, 6199.721012554356, 6313.147725057059, 6350.333215012542, 6362.395572420613, 6367.363263673596, 6369.649669268049, 6130.601510901777, 6151.784687535915, 6166.537509686881, 6170.598911070766, 6171.0, 6125.448709616156, 6150.446459818638, 6154.723037463235, 6159.476444502088, 6161.599496032743, 5909.52723782105, 5920.200772895604, 5995.91006134917, 6020.819375418744, 6043.063325184604, 6101.481374083252, 6135.141080248858, 6159.538034647329, 6164.568480206342, 6204.751809927552, 5981.700914954322, 6018.789342372996, 6022.036474164112, 6034.788782392595, 6072.119542666377], "value": 5726.875667433431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.2785786355782, 751.6091632351181, 766.7393086350642, 784.3725019984015, 789.6920201121562, 36106.45840312394, 36976.26047479052, 37019.25961480776, 37020.259594808085, 37161.814190929006, 33410.0, 33544.0, 33559.161020974425, 33576.49635255467, 33580.0, 6545.312742162064, 6595.53831231814, 6598.208215014205, 6649.501287403464, 6659.33406659335, 6404.583702059374, 6498.252700939405, 6498.772542960997, 6505.056766768839, 6511.804645860608, 6471.579347342407, 6485.935140648604, 6489.156409666761, 6493.383128602775, 6510.804675859732, 6422.357764223563, 6458.741650334005, 6466.191726034246, 6487.708053137573, 6490.772822951221, 5998.040313549811, 6048.455638992467, 6048.939510604881, 6051.213342265477, 6939.444844412435, 34531.0, 34851.477227841606, 34906.47640285398, 35045.0, 35050.47424288612, 3283.4582293921476, 3331.583552055993, 3331.850066747002, 3335.7998520088872, 3348.882789102394, 27270.5909411359, 27276.590851137247, 27310.726892731018, 27343.589846152325, 27442.17673469799, 3054.083774867531, 3064.6169228846393, 3077.584526088994, 3094.845257737104, 3095.241665791873, 166203.0, 167356.0, 168178.0, 168278.0, 168535.99999999878, 44397.11205775866, 44688.3296750549, 44694.776526117814, 44753.55246447494, 44822.32766508505, 46013.76993115013, 46054.309185362246, 46064.53935460669, 46150.5384946153, 46177.538224617994, 14365.20991345486, 14399.712005759826, 14521.0, 14531.200783956983, 14561.0, 11612.477438515287, 11692.649220523397, 11757.235779674294, 11761.823572646417, 11769.764604708029, 13118.147320424141, 13228.801567976489, 13247.602571922858, 13458.663533411547, 13512.662183445296, 5486.670799751948, 5527.364353099365, 5556.638818476786, 5589.189567512688, 5649.378568357477, 985.2216748768536, 993.8211121997965, 1007.1690855044618, 1026.8973102689672, 1031.3863251365426, 21450.141994320365, 22015.889920550293, 22206.333809985405, 22934.42663933415, 27441.588376173975, 1087.2009073331096, 1096.780643871229, 1097.5445190246119, 1104.2380757277454, 1107.4628805029554, 12277.69305767345, 12431.875681243071, 12461.626151215478, 12576.685582860502, 12590.24458532491, 206958.0, 208209.0, 208364.0, 208853.0, 209976.0, 34225.31549369048, 35491.4676279856, 35514.46728299077, 46792.53207467882, 47362.0, 1268.245393990574, 1427.6930459950952, 1434.5624584501618, 1446.3997441061842, 1449.9057561258485, 23167.420814479774, 24617.630735538623, 25120.0, 25227.74772252254, 25420.74579254184, 34324.828375857964, 34657.826710866284, 34702.65297346994, 34706.47940280847, 34733.1316717074, 169811.0, 169975.0, 170313.0, 170586.0, 170596.0, 31037.0, 31201.0, 31218.531722023734, 31300.217494561908, 31301.373972519967, 37566.812165938994, 37567.43648845324, 38270.80864595659, 39379.21241575095, 39500.0, 27358.0, 28486.715132849236, 28564.285892852844, 29066.564001540417, 29784.10647680573, 27956.30109247285, 28088.0, 29007.274818129714, 29410.264743381587, 29518.409631807674, 32114.51828222532, 32282.515762264055, 32378.838105809322, 32569.674303256663, 32609.510857337635, 26663.0, 27641.447171056065, 28489.715102848706, 28503.28741781472, 30106.24734381658, 21140.894295528426, 23407.882960585768, 23555.646665300377, 23569.764302356758, 23598.528029439658], "value": 15357.779322756936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.19298806053575, 487.1941691980709, 490.54341309205864, 500.3495455907321, 509.36838320482565, 19530.414087577377, 19733.703994440093, 20286.391408257758, 20358.389248322535, 20441.386758397235, 18020.54948626285, 21013.054412551435, 22268.8886555567, 22371.552568948653, 22407.99164037618, 5720.427957204288, 5778.768849246025, 5795.1886735857015, 5829.5919285650025, 5855.8536036599, 5785.566082543826, 5809.564282678795, 5866.6480011199255, 5874.73563689635, 5895.380984996578, 5661.688607126627, 5876.853078673024, 5888.440598143169, 5938.970305148489, 5966.045432730764, 5891.499222566087, 5918.911216331759, 5937.6140550864275, 5940.138679891413, 5947.256592925884, 5461.563074954034, 5461.590380721462, 5479.835604931858, 5482.068048431736, 5488.286522752057, 24526.754732452624, 24871.378215544755, 24903.62644560333, 24906.0, 24969.50060998788, 1907.9713804292946, 1914.8946807925558, 1941.883486990785, 1946.6009468059015, 1954.784973652897, 15661.373545058184, 16319.510414687578, 16327.591810204722, 16360.509184724477, 16374.345026198938, 2183.290430610058, 2212.2920665387082, 2250.561140577588, 2255.391044418014, 2256.8420210585264, 93956.0, 99917.0, 99924.50037749765, 100009.0, 115278.0, 12254.20347677398, 12419.627411177678, 12444.502219911283, 12458.501659933683, 13132.0, 18663.88016719001, 18708.438746837615, 18791.15439805212, 18822.247110115717, 18859.434216973514, 8456.746297611082, 8882.600282987281, 8892.822143557092, 8962.775930601656, 9107.0, 8260.215279548433, 8427.536485493356, 8462.238398544161, 8488.363372747068, 8558.871616925751, 7672.309492145734, 7787.844243115106, 7872.763817085496, 7979.720709775246, 7995.440319177602, 2352.752960939111, 2363.5981883079917, 2406.5307265083493, 2407.4944261704886, 2465.8898516083914, 957.5834511987308, 962.6775030364767, 966.4877614864133, 1003.934744241622, 1006.8892421833592, 17750.644987100186, 17792.199351029234, 17906.194221260073, 18152.63694726098, 18503.35238266654, 965.99034009659, 980.6910823090703, 1002.8595996560488, 1010.540204207084, 1019.5717798524637, 9854.0, 9961.900380996098, 9981.550830212658, 10013.0, 10184.287099902936, 380649.0, 396531.0, 396751.0, 399796.0, 403144.0, 93176.0, 94297.52851235837, 94451.0, 94594.52702736443, 94626.0, 983.7343917142332, 1024.0834453164375, 1026.2508368890751, 1124.7852319494925, 1146.954121835134, 14995.625109371917, 18290.26838926428, 18539.165737541574, 18731.719024214373, 18944.715829262295, 43964.560354396046, 45253.77373113245, 46035.3094703573, 47371.28943065926, 47960.520394797, 57130.0, 57373.426265738475, 58112.0, 58200.4179958195, 58207.0, 10782.784344313226, 10973.341599504056, 11021.228514003942, 11063.778724425627, 11080.61217857371, 15216.239188040332, 16840.57898552546, 16887.831121688625, 17086.572835679206, 17454.30182792674, 13501.72996540044, 14006.649833754238, 14337.64155896111, 14406.135631861702, 14468.0, 11934.462949167135, 12119.272843629411, 12505.874941250835, 12853.614391567893, 12990.155639883378, 13566.38951247216, 14186.0, 14198.148111113367, 14235.217063061631, 14270.0, 10834.67495975122, 10847.91520847909, 10863.565457381615, 10878.564857405932, 10879.891201087888, 12673.493060277486, 13553.59339219825, 13749.656258593615, 13808.17150970945, 13823.447062117804], "value": 10159.788731934803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.1244878789696, 1186.1519013905056, 1203.6629743671772, 1204.7229137298416, 1214.1136970011892, 11758.764824703512, 12285.324307163102, 12304.138710290283, 12368.752624947496, 12374.257544547334, 10270.435126068063, 10562.0, 10635.468226588679, 11698.0, 12101.092418068658, 2456.6806315179, 2482.7889629381525, 2482.8510289382602, 2485.478049609584, 2493.2146373892165, 2413.987930060347, 2446.2416650838295, 2448.8285819992607, 2475.4553998120473, 2478.0583378316214, 2419.637054441839, 2428.7571242875747, 2431.465077682907, 2432.136591510015, 2434.7686969737847, 2093.340597711716, 2132.989335053315, 2137.3053757528864, 2140.818030467412, 2142.046789178816, 2315.235972129193, 2327.8254130940245, 2334.6498025296173, 2347.424880904189, 2353.623420252751, 11713.824292635532, 11867.703307417298, 11980.400979950968, 12004.339761313124, 12045.63863084109, 6410.0, 6638.435732962704, 6639.43564796988, 6640.236372817139, 6640.369164929324, 3833.21419109082, 4007.6393124618926, 4094.447249621293, 4163.521195062546, 4178.937315940263, 1263.7535680542298, 1285.7814171590758, 1306.1575283941804, 1341.590814801485, 1381.5095641047485, 18072.638547229115, 18132.63734725298, 18173.909130454394, 18195.45413637593, 18286.35997740086, 5552.167174923713, 5670.914936275959, 5696.943030569641, 5826.912596311059, 5847.44449277318, 14748.63128421798, 14756.188409637358, 14800.629984250265, 14815.0, 14821.92589037048, 6625.105610742585, 6659.101021362151, 6673.699683514254, 6701.0, 6708.127943367331, 6100.877982440326, 6133.815985520441, 6217.0, 6274.686265686697, 6299.307076221612, 4833.709977401367, 4914.0908931847725, 4917.139500587383, 4952.504749525091, 5009.5491405773655, 1581.6362236685397, 1583.2875206157046, 1591.9543386747973, 1614.4510866305513, 1620.9189540522927, 730.4229658569776, 740.5667684404683, 754.9207333230041, 762.2377622377622, 779.2285637219112, 5438.483344082306, 5532.585056120726, 5653.406392328746, 5869.06095024794, 5972.074328479092, 637.1621317966859, 642.133120287608, 664.4983037806522, 670.47367816264, 676.82064252973, 4062.207869465485, 4074.3684728867074, 4090.468239128954, 4177.853775117917, 4288.148381326383, 13390.26353550564, 15140.394384224728, 15172.0, 15173.924130379499, 15249.695006099815, 14926.925365373103, 14950.401983920521, 14968.550943471713, 15030.098194108388, 15062.096274223582, 8613.22480976715, 8761.167689069656, 8795.736127916172, 9226.86159707605, 9515.952420237993, 7518.887216691644, 7634.923650763643, 7652.7704168875025, 7750.341220996278, 7888.329491993245, 13780.379882905092, 14597.416103355747, 14866.851331486547, 15003.399864005318, 15261.923690381476, 15011.973383593511, 15051.322690479174, 15347.923260383626, 15727.213639318217, 15777.68444631124, 9047.0, 9391.20174785151, 9400.858987115336, 9823.705288841345, 10273.0, 11849.703757406134, 11917.642470725892, 12014.519419223483, 12057.216280941711, 12109.031277497956, 9431.717048488556, 9570.234381249622, 9770.706878793648, 9772.120509153925, 10097.848532272168, 9207.953960230156, 9497.097775711296, 9582.808343832945, 9594.712158635251, 9973.401595904268, 7812.335951444191, 8002.83994320122, 8005.0, 8008.199180081945, 8012.038555373392, 6008.519318454601, 6016.338202797776, 6185.134081228542, 6245.375462453719, 6360.363963603602, 6045.063015232646, 6239.313675495601, 6276.686165691788, 6386.265579458422, 6577.934220657732], "value": 5456.193057268739, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.9729617574859, 420.06954595570807, 437.7242337327483, 443.1756932106281, 451.8170141092859, 6070.9628097315235, 6108.236470441195, 6137.693115344237, 6153.876922461548, 6167.198264225655, 5710.571707121972, 5930.670610454371, 5946.940530594693, 5954.196183515224, 5975.0, 4766.094442055998, 4786.353842231289, 4806.351142595758, 4813.56677898989, 4835.492273311304, 4735.3133795599615, 4749.572538471537, 4755.667103302771, 4772.904541909177, 4781.115493633672, 4563.703359281636, 4716.669833111683, 4747.335373047776, 4754.66717329787, 4772.73749943753, 4778.689385189969, 4779.163646361872, 4791.880202994936, 4793.161196790547, 4798.0, 4201.907504048939, 4257.233697934371, 4264.530901600821, 4288.871333859989, 4288.957110428887, 5763.481286684177, 5805.158252053471, 5827.650340979555, 5854.180414741897, 5864.941350586482, 5412.646838290428, 5451.836444906659, 5452.146270268088, 5463.945360546383, 5471.781128754845, 6249.781257656005, 6269.7178626961895, 6271.3728627136925, 6278.6860656966965, 6316.463100636452, 4628.537146285378, 4630.0, 4636.53634636537, 4641.976790116061, 4681.414823147106, 6636.137302150738, 6715.395614394728, 6720.899186512206, 6731.394174524316, 6745.29174436682, 4766.4995175506765, 4773.737444440589, 4782.95217047832, 4788.880277993078, 4794.496577859344, 4834.6374021947795, 4841.540053694894, 4848.151573474698, 4848.539388758062, 4856.247281671346, 5470.5350045245805, 5479.369872464717, 5493.368262649767, 5496.587755918322, 5498.560115190775, 6377.457916077093, 6384.361563843671, 6404.743810247631, 6408.775692850728, 6417.935820641734, 1552.7049860526463, 1650.9009459432473, 1663.4843198608228, 1670.6742185273997, 1677.5302915183768, 979.8285300072458, 1099.7360633447915, 1131.3551275772895, 1137.7724455109012, 1165.318288801044, 5515.806946756925, 5540.196671482693, 5565.972170139124, 5566.888662226733, 5574.219609254707, 6483.3516648335735, 6537.1174891389055, 6606.636634985026, 6626.599321552919, 6639.502037347218, 5610.87782443513, 5650.3502097258515, 5674.886502269931, 5681.857953551194, 5685.488306052475, 3459.2357897471966, 3500.3524347995703, 3502.7022703070015, 3502.9299414011575, 3513.191965847818, 6120.510359171256, 6335.732853429333, 6358.809235722843, 6376.39424254695, 6379.744810207632, 6649.63427011519, 6651.401373876374, 6671.366220209073, 6680.365365290289, 6700.765473208415, 6263.937360626426, 6292.433680968643, 6322.968385158137, 6328.810135695937, 6329.588576742589, 6523.543351965317, 6548.738050477928, 6563.442107420923, 6564.5076619254705, 6581.3418658133805, 6473.514486413632, 6516.934830651633, 6518.674066296571, 6520.576162549419, 6535.869282614416, 6307.24313082433, 6359.7456101755415, 6375.6174629522375, 6419.133416988647, 6422.325655806073, 4729.55069268419, 4764.523547645208, 4769.35613692161, 4776.331313616027, 4790.976045119752, 6523.3476652336285, 6544.509161812788, 6551.181102362205, 6604.282886449461, 6610.570312929644, 6316.463100636497, 6347.619142851444, 6382.393672601095, 6383.648899310582, 6393.2647745508, 6331.303556608861, 6363.3636636336, 6363.5227357947415, 6368.42684158428, 6412.97392417211, 5913.46778789911, 6320.936790632035, 6321.051842223703, 6326.557141000086, 6364.363563643598, 6369.554131210771, 6420.165378500952, 6434.64609446485, 6455.838604034937, 6480.319566445644, 6150.569460137747, 6220.0, 6231.781887633911, 6234.501239900887, 6247.0], "value": 4860.097819117751, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.4320117914509, 787.4055088408251, 818.6316157729024, 844.2739244249946, 857.2798848966867, 16894.155292235384, 17277.222524986373, 17300.91349543254, 17342.30630774769, 17456.0, 13657.658558536017, 14049.719005619907, 14107.858921410783, 16448.917755411236, 17057.914710426463, 982.7739619887412, 999.9850152095629, 1006.6828948881116, 1007.2747621712356, 1008.4352762453013, 996.9501524923761, 1003.0, 1003.9849402258972, 1004.2116938203511, 1005.632943975451, 1055.3562326980536, 1057.5241141486324, 1059.9205059620522, 1060.289605964002, 1060.973475663107, 973.5278389980854, 1013.3210748798323, 1046.0271947089204, 1053.6944286157004, 1057.4501259345175, 755.5051441305953, 757.5454727163713, 759.6999185321822, 760.8630446519625, 761.9352355049828, 16373.017618942782, 16725.6654866902, 16793.83206167935, 16820.411285605067, 16847.494575162764, 18579.349722759773, 18778.436646900616, 18965.24139034437, 19112.0, 19199.808001920082, 13751.243681597509, 13992.860071399258, 14051.297435128203, 14078.577642670736, 14129.152250864878, 3412.8293585320635, 3442.4147894857933, 3443.3974054540354, 3448.0173150651945, 3449.137715571107, 82006.0, 85054.0, 85829.57085214596, 85912.0, 90870.0, 14835.10989340643, 14846.851531484546, 14860.108393496208, 14974.700505990037, 15180.924095379452, 24734.763261836837, 25241.116560920647, 25602.103926362488, 25615.0, 26165.73834261671, 7673.693052277958, 7703.6918523259565, 7707.152213256537, 7721.575313357819, 7760.611969401621, 3759.022654109951, 3804.505414296124, 3805.5433347997864, 3839.232153569297, 3864.130570621644, 4430.446194225722, 4434.84478043267, 4445.911081778347, 4480.439945006874, 4487.349334346502, 803.6303300481727, 828.2173346187794, 837.2046555771919, 840.878072679458, 849.8569424124543, 646.405307117453, 663.1213641924373, 687.226869771507, 696.6656005117572, 703.3248081841388, 10783.0, 11755.88244117548, 12327.445264963098, 12850.0, 13007.219566825832, 667.5961043568668, 705.9188193357727, 721.2210812322679, 725.9854802903913, 732.6300218389679, 4977.726225057657, 5170.508801663836, 5176.120059589879, 5278.287431196739, 5329.573634109262, 76996.61501692567, 80649.59675201586, 81244.18755812367, 82989.0, 83079.5846020766, 68752.6562367185, 69310.0, 70545.0, 71543.6422817893, 71983.6400818003, 61302.0, 61372.69313653492, 64009.0, 64770.352296476434, 65741.34258657448, 10223.846642300521, 10493.685189444328, 10555.52500137511, 10833.882465704011, 10982.341059536453, 27627.171184864485, 28933.0, 29073.85463072671, 29248.122556323346, 29883.25291867634, 36248.275034498634, 36910.63089369072, 37290.067748305424, 37590.624093759805, 37977.24045519129, 13681.452741890213, 14330.211838348574, 14454.783178252124, 14495.347709353315, 14585.197814120325, 15765.842341576437, 16158.757618635495, 16178.595535111717, 16762.664746704755, 16846.915765421094, 14250.429982800571, 14647.26763661834, 14684.706305874037, 14776.33506492232, 14799.260036997892, 14179.0, 14657.193854338113, 14806.77789833175, 14830.925845370704, 14982.850171498145, 14264.714705706036, 14352.856471435152, 14679.633009174857, 14812.62968425798, 14824.62938426548, 9609.51952402391, 9717.465539395402, 9985.0, 9991.500424978867, 10374.066334029974, 10739.946300268448, 10799.40603266828, 11097.278676885977, 11210.943945280222, 11367.090632749525], "value": 7738.057861270819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 113.0, 114.0, 111.0, 111.0, 113.0, 112.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 148.0, 166.0, 124.0, 148.0, 156.0, 123.0, 173.0, 122.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 162.0, 166.0, 168.0, 175.0, 165.0, 165.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 161.0, 76.0, 77.0, 75.0, 75.0, 107.0, 78.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 130.0, 83.0, 83.0, 84.0, 128.0, 83.0, 84.0, 136.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 151.0, 151.0, 150.0, 151.0, 149.0, 151.0, 151.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 99.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 59.0, 54.0, 55.0, 56.0, 52.0, 56.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 57.0, 64.0, 60.0, 56.0, 56.0, 56.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 79.0, 82.0, 80.0, 78.0, 80.0, 78.0, 80.0, 78.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 130.0, 138.0, 129.0, 130.0, 131.0, 145.0, 133.0, 158.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 186.0, 191.0, 188.0, 191.0, 181.0, 191.0, 189.0, 186.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 74.0, 82.0, 70.0, 71.0, 72.0, 73.0, 82.0, 74.0], "value": 74.4, "unit": "score"}]}]} 02:48:46 INFO - Return code: 0 02:48:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:46 INFO - # TBPL SUCCESS # 02:48:46 INFO - Running post-action listener: _resource_record_post_action 02:48:46 INFO - [mozharness: 2017-06-11 09:48:46.548487Z] Finished run-tests step (success) 02:48:46 INFO - Running post-run listener: _resource_record_post_run 02:48:46 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 8728576; Write bytes: 444768256; Read time: 2188; Write time: 356232 02:48:46 INFO - TinderboxPrint: CPU usage
12.6% 02:48:46 INFO - TinderboxPrint: I/O read bytes / time
8,728,576 / 2,188 02:48:46 INFO - TinderboxPrint: I/O write bytes / time
444,768,256 / 356,232 02:48:46 INFO - TinderboxPrint: CPU idle
8,748.8 (87.3%) 02:48:46 INFO - TinderboxPrint: CPU user
1,212.1 (12.1%) 02:48:46 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:46 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 8192; Write bytes: 227905536; Read time: 248; Write time: 233472 02:48:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:48:46 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 6356992; Write bytes: 180969472; Read time: 1368; Write time: 54972 02:48:47 INFO - Running post-run listener: _upload_blobber_files 02:48:47 INFO - Blob upload gear active. 02:48:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48: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 02:48: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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:48: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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:48:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:50 INFO - (blobuploader) - INFO - Done attempting. 02:48:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:48:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:48:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:51 INFO - (blobuploader) - INFO - Done attempting. 02:48:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:48:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:52 INFO - (blobuploader) - INFO - Done attempting. 02:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:53 INFO - (blobuploader) - INFO - Done attempting. 02:48:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:53 INFO - Return code: 0 02:48:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1c82b3bfdca47a32793fe5a87857e462746513eb92887c0bcc223e26c2c8790e421c4ce98244a98bafbff16b034f2aeb6ac43c06804b4496b01c4f234696c5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f634b6dd9986517c162eb0bf833975f198709fdfcc8584a2b0c097a3f808225672a4a4bcbe62ca362b9e57d6c0515f029a33e710ed9ee28ca4b7c03f0963b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737a6ad0a4bce02db5cd44f07d960edd21ded55d6bf3a845c4b12c687b98b52f3263bdd602460eb59583863b17f43d7d74e47e7f3850d7095c961e0b1c8d7c2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8057cf14c3cc6f5d0ffce1966b353d8ea3a128dea69c8b49f5960a25d14f00681c06edceb291364ee8866e4f8524452706aab542b1e186ab065718804557b97"} 02:48:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:53 INFO - Contents: 02:48:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1c82b3bfdca47a32793fe5a87857e462746513eb92887c0bcc223e26c2c8790e421c4ce98244a98bafbff16b034f2aeb6ac43c06804b4496b01c4f234696c5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f634b6dd9986517c162eb0bf833975f198709fdfcc8584a2b0c097a3f808225672a4a4bcbe62ca362b9e57d6c0515f029a33e710ed9ee28ca4b7c03f0963b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737a6ad0a4bce02db5cd44f07d960edd21ded55d6bf3a845c4b12c687b98b52f3263bdd602460eb59583863b17f43d7d74e47e7f3850d7095c961e0b1c8d7c2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8057cf14c3cc6f5d0ffce1966b353d8ea3a128dea69c8b49f5960a25d14f00681c06edceb291364ee8866e4f8524452706aab542b1e186ab065718804557b97"} 02:48:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:53 INFO - Copying logs to upload dir... 02:48:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.634337 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-11 02:48:53.509813) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-11 02:48:53.514375) ========= 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=03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1c82b3bfdca47a32793fe5a87857e462746513eb92887c0bcc223e26c2c8790e421c4ce98244a98bafbff16b034f2aeb6ac43c06804b4496b01c4f234696c5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f634b6dd9986517c162eb0bf833975f198709fdfcc8584a2b0c097a3f808225672a4a4bcbe62ca362b9e57d6c0515f029a33e710ed9ee28ca4b7c03f0963b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737a6ad0a4bce02db5cd44f07d960edd21ded55d6bf3a845c4b12c687b98b52f3263bdd602460eb59583863b17f43d7d74e47e7f3850d7095c961e0b1c8d7c2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8057cf14c3cc6f5d0ffce1966b353d8ea3a128dea69c8b49f5960a25d14f00681c06edceb291364ee8866e4f8524452706aab542b1e186ab065718804557b97"} build_url:https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/ZYKORsNyQEaGRSFd3Hpk5g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1c82b3bfdca47a32793fe5a87857e462746513eb92887c0bcc223e26c2c8790e421c4ce98244a98bafbff16b034f2aeb6ac43c06804b4496b01c4f234696c5c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06f634b6dd9986517c162eb0bf833975f198709fdfcc8584a2b0c097a3f808225672a4a4bcbe62ca362b9e57d6c0515f029a33e710ed9ee28ca4b7c03f0963b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/737a6ad0a4bce02db5cd44f07d960edd21ded55d6bf3a845c4b12c687b98b52f3263bdd602460eb59583863b17f43d7d74e47e7f3850d7095c961e0b1c8d7c2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8057cf14c3cc6f5d0ffce1966b353d8ea3a128dea69c8b49f5960a25d14f00681c06edceb291364ee8866e4f8524452706aab542b1e186ab065718804557b97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-11 02:48:53.541217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:48:53.541559) ========= 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=03627c79f6bb3d1578c4a402000001ba-1497163584.920725-1308643739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:48:53.624731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-11 02:48:53.628058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-11 02:48:53.628338) ========= ========= Total master_lag: 0.19 =========