builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1496159247.19 results: success (0) revision: 268cfff98df1cc643df7f79dab467043fd1837f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.190966) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.191410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.191682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.208171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.208481) ========= 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=1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 08:47:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 111M=0s 2017-05-30 08:47:28 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088688 ========= master_lag: 0.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.803626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.803927) ========= 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=1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.849323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:27.849635) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 268cfff98df1cc643df7f79dab467043fd1837f1 --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 268cfff98df1cc643df7f79dab467043fd1837f1 --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=1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 08:47:29,449 truncating revision to first 12 chars 2017-05-30 08:47:29,449 Setting DEBUG logging. 2017-05-30 08:47:29,449 attempt 1/10 2017-05-30 08:47:29,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/268cfff98df1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 08:47:29,778 unpacking tar archive at: mozilla-central-268cfff98df1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:28.458411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:28.458742) ========= script_repo_revision: 268cfff98df1cc643df7f79dab467043fd1837f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:28.459140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:28.459406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 08:47:28.477092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-30 08:47:28.477458) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:30 INFO - MultiFileLogger online at 20170530 08:47:30 in /builds/slave/test 08:47:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:47:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:30 INFO - {'append_to_log': False, 08:47:30 INFO - 'base_work_dir': '/builds/slave/test', 08:47:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:47:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:30 INFO - 'branch': 'Firefox-Non-PGO', 08:47:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:30 INFO - 'config_files': ('talos/linux_config.py',), 08:47:30 INFO - 'default_actions': ('clobber', 08:47:30 INFO - 'read-buildbot-config', 08:47:30 INFO - 'download-and-extract', 08:47:30 INFO - 'populate-webroot', 08:47:30 INFO - 'create-virtualenv', 08:47:30 INFO - 'install', 08:47:30 INFO - 'setup-mitmproxy', 08:47:30 INFO - 'run-tests'), 08:47:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:30 INFO - 'download_minidump_stackwalk': True, 08:47:30 INFO - 'download_symbols': 'ondemand', 08:47:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:30 INFO - 'gecko_profile': False, 08:47:30 INFO - 'gecko_profile_interval': 0, 08:47:30 INFO - 'installer_path': 'installer.exe', 08:47:30 INFO - 'log_level': 'info', 08:47:30 INFO - 'log_name': 'talos', 08:47:30 INFO - 'log_to_console': True, 08:47:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:30 INFO - 'opt_config_files': (), 08:47:30 INFO - 'pip_index': False, 08:47:30 INFO - 'suite': 'dromaeojs-e10s', 08:47:30 INFO - 'system_bits': '32', 08:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:30 INFO - 'title': 'talos-linux64-ix-079', 08:47:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:30 INFO - 'use_talos_json': True, 08:47:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:30 INFO - 'work_dir': 'build'} 08:47:30 INFO - [mozharness: 2017-05-30 15:47:30.177193Z] Running clobber step. 08:47:30 INFO - Running pre-action listener: _resource_record_pre_action 08:47:30 INFO - Running main action method: clobber 08:47:30 INFO - rmtree: /builds/slave/test/build 08:47:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:31 INFO - Running post-action listener: _resource_record_post_action 08:47:31 INFO - [mozharness: 2017-05-30 15:47:31.105458Z] Finished clobber step (success) 08:47:31 INFO - [mozharness: 2017-05-30 15:47:31.105559Z] Running read-buildbot-config step. 08:47:31 INFO - Running pre-action listener: _resource_record_pre_action 08:47:31 INFO - Running main action method: read_buildbot_config 08:47:31 INFO - Using buildbot properties: 08:47:31 INFO - { 08:47:31 INFO - "project": "", 08:47:31 INFO - "product": "firefox", 08:47:31 INFO - "who": "ffxbld@noreply.mozilla.org", 08:47:31 INFO - "installer_path": "public/build/target.tar.bz2", 08:47:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:47:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:47:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:47:31 INFO - "stage_platform": "linux64", 08:47:31 INFO - "basedir": "/builds/slave/test", 08:47:31 INFO - "buildnumber": 912, 08:47:31 INFO - "platform": "ubuntu64_hw", 08:47:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:47:31 INFO - "slavebuilddir": "test", 08:47:31 INFO - "taskId": "aEPHGIQWR9qDH7lp1d4CGg", 08:47:31 INFO - "branch": "mozilla-central", 08:47:31 INFO - "script_repo_revision": "production", 08:47:31 INFO - "revision": "268cfff98df1cc643df7f79dab467043fd1837f1", 08:47:31 INFO - "slavename": "talos-linux64-ix-079", 08:47:31 INFO - "repo_path": "mozilla-central" 08:47:31 INFO - } 08:47:31 INFO - Finding installer, test and symbols from parent task. 08:47:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aEPHGIQWR9qDH7lp1d4CGg'}, attempt #1 08:47:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aEPHGIQWR9qDH7lp1d4CGg'}, attempt #1 08:47:32 INFO - Task dependencies: QIapUNOFQBWTgPkMtPOhsQ 08:47:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ'}, attempt #1 08:47:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2 08:47:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/test_packages.json 08:47:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.crashreporter-symbols.zip 08:47:32 INFO - Running post-action listener: _resource_record_post_action 08:47:32 INFO - [mozharness: 2017-05-30 15:47:32.456180Z] Finished read-buildbot-config step (success) 08:47:32 INFO - [mozharness: 2017-05-30 15:47:32.456401Z] Running download-and-extract step. 08:47:32 INFO - Running pre-action listener: _resource_record_pre_action 08:47:32 INFO - Running main action method: download_and_extract 08:47:32 INFO - mkdir: /builds/slave/test/build/tests 08:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:32 INFO - trying https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.test_packages.json 08:47:32 INFO - Downloading https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:47:33 INFO - Downloaded 986 bytes. 08:47:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:47:33 INFO - Using the following test package requirements: 08:47:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:47:33 INFO - u'common': [u'target.common.tests.zip'], 08:47:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:47:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:47:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:47:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:47:33 INFO - u'mozbase': [u'target.common.tests.zip'], 08:47:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:47:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:47:33 INFO - u'web-platform': [u'target.common.tests.zip', 08:47:33 INFO - u'target.web-platform.tests.zip'], 08:47:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:47:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:47:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.common.tests.zip 08:47:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:47:33 INFO - Fetch https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.common.tests.zip into memory 08:47:34 INFO - Content-Length response header: 63528782 08:47:34 INFO - Bytes received: 63528782 08:47:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:47:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.common.tests.zip 08:47:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:47:45 INFO - Fetch https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.common.tests.zip into memory 08:47:46 INFO - Content-Length response header: 63528782 08:47:46 INFO - Bytes received: 63528782 08:47:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.talos.tests.zip 08:47:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.talos.tests.zip into memory 08:47:59 INFO - Content-Length response header: 14447425 08:47:59 INFO - Bytes received: 14447425 08:48: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')]} 08:48:00 INFO - trying https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2 08:48:00 INFO - Downloading https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:48:02 INFO - Downloaded 54193025 bytes. 08:48:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2 08:48:02 INFO - mkdir: /builds/slave/test/properties 08:48:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:02 INFO - Contents: 08:48:02 INFO - build_url:https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2 08:48:02 INFO - Running post-action listener: _resource_record_post_action 08:48:02 INFO - Running post-action listener: set_extra_try_arguments 08:48:02 INFO - [mozharness: 2017-05-30 15:48:02.355771Z] Finished download-and-extract step (success) 08:48:02 INFO - [mozharness: 2017-05-30 15:48:02.355867Z] Running populate-webroot step. 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: populate_webroot 08:48:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:02 INFO - '--tppagecycles', 08:48:02 INFO - '7'], 08:48:02 INFO - 'tests': ['tsvgm']}}, 08:48:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['damp', 'tps']}, 08:48:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'tests': ['damp', 'tps']}, 08:48:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['dromaeo_dom']}, 08:48:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:48:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:48:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:48:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['a11yr', 08:48:02 INFO - 'ts_paint', 08:48:02 INFO - 'tpaint', 08:48:02 INFO - 'sessionrestore', 08:48:02 INFO - 'sessionrestore_no_auto_restore', 08:48:02 INFO - 'tabpaint']}, 08:48:02 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:02 INFO - 'ts_paint', 08:48:02 INFO - 'tpaint', 08:48:02 INFO - 'sessionrestore', 08:48:02 INFO - 'sessionrestore_no_auto_restore', 08:48:02 INFO - 'tabpaint']}, 08:48:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:02 INFO - 'ts_paint', 08:48:02 INFO - 'tpaint', 08:48:02 INFO - 'sessionrestore', 08:48:02 INFO - 'sessionrestore_no_auto_restore', 08:48:02 INFO - 'tabpaint']}, 08:48:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:02 INFO - 'ts_paint', 08:48:02 INFO - 'tpaint', 08:48:02 INFO - 'sessionrestore', 08:48:02 INFO - 'sessionrestore_no_auto_restore', 08:48:02 INFO - 'tabpaint']}, 08:48:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['a11yr', 08:48:02 INFO - 'ts_paint', 08:48:02 INFO - 'tpaint', 08:48:02 INFO - 'sessionrestore', 08:48:02 INFO - 'sessionrestore_no_auto_restore', 08:48:02 INFO - 'tabpaint']}, 08:48:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['a11yr', 08:48:02 INFO - 'ts_paint', 08:48:02 INFO - 'tpaint', 08:48:02 INFO - 'sessionrestore', 08:48:02 INFO - 'sessionrestore_no_auto_restore', 08:48:02 INFO - 'tabpaint']}, 08:48:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:48:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:48:02 INFO - 'bloom_basic_ref']}, 08:48:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:48:02 INFO - 'talos_options': ['--mitmproxy', 08:48:02 INFO - 'mitmproxy-recording-1.mp', 08:48:02 INFO - '--firstNonBlankPaint'], 08:48:02 INFO - 'tests': ['Quantum_1']}, 08:48:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['tsvgx', 08:48:02 INFO - 'tsvgr_opacity', 08:48:02 INFO - 'tart', 08:48:02 INFO - 'tscrollx', 08:48:02 INFO - 'cart', 08:48:02 INFO - 'tsvg_static']}, 08:48:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:02 INFO - 'tsvgr_opacity', 08:48:02 INFO - 'tart', 08:48:02 INFO - 'tscrollx', 08:48:02 INFO - 'cart', 08:48:02 INFO - 'tsvg_static']}, 08:48:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'talos_options': ['--disable-e10s'], 08:48:02 INFO - 'tests': ['tp5o']}, 08:48:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:48:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'talos_options': ['--disable-e10s', 08:48:02 INFO - '--xperf_path', 08:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:02 INFO - 'tests': ['tp5n']}, 08:48:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:48:02 INFO - 'talos_options': ['--xperf_path', 08:48:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:02 INFO - 'tests': ['tp5n']}}, 08:48:02 INFO - 'talos.zip': {'path': '', 08:48:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:02 INFO - Running post-action listener: _resource_record_post_action 08:48:02 INFO - [mozharness: 2017-05-30 15:48:02.370100Z] Finished populate-webroot step (success) 08:48:02 INFO - [mozharness: 2017-05-30 15:48:02.370194Z] Running create-virtualenv step. 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: create_virtualenv 08:48:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:48:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:02 INFO - Using real prefix '/usr' 08:48:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:02 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:04 INFO - Installing pip.................done. 08:48:04 INFO - Return code: 0 08:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:05 INFO - Reading from file tmpfile_stdout 08:48:05 INFO - Output received: 08:48:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:48:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:05 INFO - Using env: {'DISPLAY': ':0', 08:48:05 INFO - 'HOME': '/home/cltbld', 08:48:05 INFO - 'LANG': 'en_US.UTF-8', 08:48:05 INFO - 'LANGUAGE': 'en_US:en', 08:48:05 INFO - 'LOGNAME': 'cltbld', 08:48:05 INFO - 'MAIL': '/var/mail/cltbld', 08:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:05 INFO - 'MOZ_NO_REMOTE': '1', 08:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:05 INFO - 'NO_EM_RESTART': '1', 08:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:05 INFO - 'PWD': '/builds/slave/test', 08:48:05 INFO - 'SHELL': '/bin/bash', 08:48:05 INFO - 'SHLVL': '1', 08:48:05 INFO - 'TERM': 'linux', 08:48:05 INFO - 'TMOUT': '86400', 08:48:05 INFO - 'USER': 'cltbld', 08:48:05 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:05 INFO - '_': '/tools/buildbot/bin/python'} 08:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:48:05 INFO - Cleaning up... 08:48:05 INFO - Return code: 0 08:48:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:05 INFO - Using env: {'DISPLAY': ':0', 08:48:05 INFO - 'HOME': '/home/cltbld', 08:48:05 INFO - 'LANG': 'en_US.UTF-8', 08:48:05 INFO - 'LANGUAGE': 'en_US:en', 08:48:05 INFO - 'LOGNAME': 'cltbld', 08:48:05 INFO - 'MAIL': '/var/mail/cltbld', 08:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:05 INFO - 'MOZ_NO_REMOTE': '1', 08:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:05 INFO - 'NO_EM_RESTART': '1', 08:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:05 INFO - 'PWD': '/builds/slave/test', 08:48:05 INFO - 'SHELL': '/bin/bash', 08:48:05 INFO - 'SHLVL': '1', 08:48:05 INFO - 'TERM': 'linux', 08:48:05 INFO - 'TMOUT': '86400', 08:48:05 INFO - 'USER': 'cltbld', 08:48:05 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:05 INFO - '_': '/tools/buildbot/bin/python'} 08:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:05 INFO - Downloading/unpacking psutil>=3.1.1 08:48:05 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 08:48:05 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 08:48:05 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 08:48:05 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 08:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:06 INFO - Installing collected packages: psutil 08:48:06 INFO - Running setup.py install for psutil 08:48:06 INFO - building 'psutil._psutil_linux' extension 08:48:06 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 08:48:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:48:07 INFO - building 'psutil._psutil_posix' extension 08:48:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:48:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:48:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:07 INFO - Successfully installed psutil 08:48:07 INFO - Cleaning up... 08:48:07 INFO - Return code: 0 08:48:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:48:07 INFO - Using env: {'DISPLAY': ':0', 08:48:07 INFO - 'HOME': '/home/cltbld', 08:48:07 INFO - 'LANG': 'en_US.UTF-8', 08:48:07 INFO - 'LANGUAGE': 'en_US:en', 08:48:07 INFO - 'LOGNAME': 'cltbld', 08:48:07 INFO - 'MAIL': '/var/mail/cltbld', 08:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:07 INFO - 'MOZ_NO_REMOTE': '1', 08:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:07 INFO - 'NO_EM_RESTART': '1', 08:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:07 INFO - 'PWD': '/builds/slave/test', 08:48:07 INFO - 'SHELL': '/bin/bash', 08:48:07 INFO - 'SHLVL': '1', 08:48:07 INFO - 'TERM': 'linux', 08:48:07 INFO - 'TMOUT': '86400', 08:48:07 INFO - 'USER': 'cltbld', 08:48:07 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:07 INFO - '_': '/tools/buildbot/bin/python'} 08:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:08 INFO - Installing collected packages: mozsystemmonitor 08:48:08 INFO - Running setup.py install for mozsystemmonitor 08:48:08 INFO - Successfully installed mozsystemmonitor 08:48:08 INFO - Cleaning up... 08:48:08 INFO - Return code: 0 08:48:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48: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')]} 08:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:08 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 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:08 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 08:48:08 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 08:48:08 INFO - Using env: {'DISPLAY': ':0', 08:48:08 INFO - 'HOME': '/home/cltbld', 08:48:08 INFO - 'LANG': 'en_US.UTF-8', 08:48:08 INFO - 'LANGUAGE': 'en_US:en', 08:48:08 INFO - 'LOGNAME': 'cltbld', 08:48:08 INFO - 'MAIL': '/var/mail/cltbld', 08:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:08 INFO - 'MOZ_NO_REMOTE': '1', 08:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:08 INFO - 'NO_EM_RESTART': '1', 08:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:08 INFO - 'PWD': '/builds/slave/test', 08:48:08 INFO - 'SHELL': '/bin/bash', 08:48:08 INFO - 'SHLVL': '1', 08:48:08 INFO - 'TERM': 'linux', 08:48:08 INFO - 'TMOUT': '86400', 08:48:08 INFO - 'USER': 'cltbld', 08:48:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:08 INFO - '_': '/tools/buildbot/bin/python'} 08:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:08 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 08:48:08 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 08:48:08 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 08:48:08 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 08:48:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:10 INFO - warning: no files found matching '*.txt' 08:48:10 INFO - no previously-included directories found matching 'build' 08:48:10 INFO - no previously-included directories found matching 'dist' 08:48:10 INFO - no previously-included directories found matching '.git*' 08:48:10 INFO - Installing collected packages: jsonschema, functools32 08:48:10 INFO - Running setup.py install for functools32 08:48:10 INFO - warning: no files found matching '*.txt' 08:48:10 INFO - no previously-included directories found matching 'build' 08:48:10 INFO - no previously-included directories found matching 'dist' 08:48:10 INFO - no previously-included directories found matching '.git*' 08:48:10 INFO - Successfully installed jsonschema functools32 08:48:10 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:48:10 INFO - Using env: {'DISPLAY': ':0', 08:48:10 INFO - 'HOME': '/home/cltbld', 08:48:10 INFO - 'LANG': 'en_US.UTF-8', 08:48:10 INFO - 'LANGUAGE': 'en_US:en', 08:48:10 INFO - 'LOGNAME': 'cltbld', 08:48:10 INFO - 'MAIL': '/var/mail/cltbld', 08:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:10 INFO - 'MOZ_NO_REMOTE': '1', 08:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:10 INFO - 'NO_EM_RESTART': '1', 08:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:10 INFO - 'PWD': '/builds/slave/test', 08:48:10 INFO - 'SHELL': '/bin/bash', 08:48:10 INFO - 'SHLVL': '1', 08:48:10 INFO - 'TERM': 'linux', 08:48:10 INFO - 'TMOUT': '86400', 08:48:10 INFO - 'USER': 'cltbld', 08:48:10 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:10 INFO - '_': '/tools/buildbot/bin/python'} 08:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:10 INFO - Cleaning up... 08:48:10 INFO - Return code: 0 08:48:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:48:10 INFO - Using env: {'DISPLAY': ':0', 08:48:10 INFO - 'HOME': '/home/cltbld', 08:48:10 INFO - 'LANG': 'en_US.UTF-8', 08:48:10 INFO - 'LANGUAGE': 'en_US:en', 08:48:10 INFO - 'LOGNAME': 'cltbld', 08:48:10 INFO - 'MAIL': '/var/mail/cltbld', 08:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:10 INFO - 'MOZ_NO_REMOTE': '1', 08:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:10 INFO - 'NO_EM_RESTART': '1', 08:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:10 INFO - 'PWD': '/builds/slave/test', 08:48:10 INFO - 'SHELL': '/bin/bash', 08:48:10 INFO - 'SHLVL': '1', 08:48:10 INFO - 'TERM': 'linux', 08:48:10 INFO - 'TMOUT': '86400', 08:48:10 INFO - 'USER': 'cltbld', 08:48:10 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:10 INFO - '_': '/tools/buildbot/bin/python'} 08:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:12 INFO - Downloading docopt-0.6.1.tar.gz 08:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:12 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:12 INFO - Running setup.py install for blobuploader 08:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:12 INFO - Running setup.py install for requests 08:48:13 INFO - Running setup.py install for docopt 08:48:13 INFO - Successfully installed blobuploader requests docopt 08:48:13 INFO - Cleaning up... 08:48:13 INFO - Return code: 0 08:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:13 INFO - Using env: {'DISPLAY': ':0', 08:48:13 INFO - 'HOME': '/home/cltbld', 08:48:13 INFO - 'LANG': 'en_US.UTF-8', 08:48:13 INFO - 'LANGUAGE': 'en_US:en', 08:48:13 INFO - 'LOGNAME': 'cltbld', 08:48:13 INFO - 'MAIL': '/var/mail/cltbld', 08:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:13 INFO - 'MOZ_NO_REMOTE': '1', 08:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:13 INFO - 'NO_EM_RESTART': '1', 08:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:13 INFO - 'PWD': '/builds/slave/test', 08:48:13 INFO - 'SHELL': '/bin/bash', 08:48:13 INFO - 'SHLVL': '1', 08:48:13 INFO - 'TERM': 'linux', 08:48:13 INFO - 'TMOUT': '86400', 08:48:13 INFO - 'USER': 'cltbld', 08:48:13 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:13 INFO - '_': '/tools/buildbot/bin/python'} 08:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:13 INFO - Running setup.py (path:/tmp/pip-aZVpIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:13 INFO - Running setup.py (path:/tmp/pip-NypO7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:13 INFO - Running setup.py (path:/tmp/pip-nHanDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:13 INFO - Running setup.py (path:/tmp/pip-F2i03H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:13 INFO - Running setup.py (path:/tmp/pip-NUuiyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:13 INFO - Running setup.py (path:/tmp/pip-9Irmcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:13 INFO - Running setup.py (path:/tmp/pip-OE9F3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:13 INFO - Running setup.py (path:/tmp/pip-KKZbRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:13 INFO - Running setup.py (path:/tmp/pip-TDPWzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:14 INFO - Running setup.py (path:/tmp/pip-GCk_J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:14 INFO - Running setup.py (path:/tmp/pip-TOx74V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:14 INFO - Running setup.py (path:/tmp/pip-CT9wgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:14 INFO - Running setup.py (path:/tmp/pip-_iJojj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:14 INFO - Running setup.py (path:/tmp/pip-myIga7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:14 INFO - Running setup.py (path:/tmp/pip-4bxUa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:14 INFO - Running setup.py (path:/tmp/pip-PQF2To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:14 INFO - Running setup.py (path:/tmp/pip-72bCxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:14 INFO - Running setup.py install for manifestparser 08:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:14 INFO - Running setup.py install for mozcrash 08:48:14 INFO - Running setup.py install for mozdebug 08:48:14 INFO - Running setup.py install for mozdevice 08:48:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozfile 08:48:15 INFO - Running setup.py install for mozhttpd 08:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozinfo 08:48:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozInstall 08:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozleak 08:48:15 INFO - Running setup.py install for mozlog 08:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for moznetwork 08:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozprocess 08:48:15 INFO - Running setup.py install for mozprofile 08:48:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:15 INFO - Running setup.py install for mozrunner 08:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Running setup.py install for mozscreenshot 08:48:16 INFO - Running setup.py install for moztest 08:48:16 INFO - Running setup.py install for mozversion 08:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:16 INFO - Cleaning up... 08:48:16 INFO - Return code: 0 08:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:16 INFO - Using env: {'DISPLAY': ':0', 08:48:16 INFO - 'HOME': '/home/cltbld', 08:48:16 INFO - 'LANG': 'en_US.UTF-8', 08:48:16 INFO - 'LANGUAGE': 'en_US:en', 08:48:16 INFO - 'LOGNAME': 'cltbld', 08:48:16 INFO - 'MAIL': '/var/mail/cltbld', 08:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:16 INFO - 'MOZ_NO_REMOTE': '1', 08:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:16 INFO - 'NO_EM_RESTART': '1', 08:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:16 INFO - 'PWD': '/builds/slave/test', 08:48:16 INFO - 'SHELL': '/bin/bash', 08:48:16 INFO - 'SHLVL': '1', 08:48:16 INFO - 'TERM': 'linux', 08:48:16 INFO - 'TMOUT': '86400', 08:48:16 INFO - 'USER': 'cltbld', 08:48:16 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:16 INFO - '_': '/tools/buildbot/bin/python'} 08:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:16 INFO - Running setup.py (path:/tmp/pip-mCjFif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:16 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)) 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:16 INFO - Running setup.py (path:/tmp/pip-2v2kaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:16 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)) 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:16 INFO - Running setup.py (path:/tmp/pip-NgVeGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:16 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)) 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:16 INFO - Running setup.py (path:/tmp/pip-sAdbeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:16 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)) 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:16 INFO - Running setup.py (path:/tmp/pip-5RI7VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:16 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)) 08:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:16 INFO - Running setup.py (path:/tmp/pip-dnlwBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Running setup.py (path:/tmp/pip-kFkjS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Running setup.py (path:/tmp/pip-N6VNr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:17 INFO - Running setup.py (path:/tmp/pip-qAFX4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:17 INFO - Running setup.py (path:/tmp/pip-S0UKAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:17 INFO - Running setup.py (path:/tmp/pip-aRhx_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:17 INFO - Running setup.py (path:/tmp/pip-u4noJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:17 INFO - Running setup.py (path:/tmp/pip-9DRsYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:17 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)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:17 INFO - Running setup.py (path:/tmp/pip-f6i1lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:17 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)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:17 INFO - Running setup.py (path:/tmp/pip-SpjL9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:17 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)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:17 INFO - Running setup.py (path:/tmp/pip-JVqcg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:17 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)) 08:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:17 INFO - Running setup.py (path:/tmp/pip-iYuLyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:17 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)) 08:48:17 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)) 08:48:17 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)) 08:48:17 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)) 08:48:17 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)) 08:48:17 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)) 08:48:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:18 INFO - Downloading blessings-1.6.tar.gz 08:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:18 INFO - Installing collected packages: blessings 08:48:18 INFO - Running setup.py install for blessings 08:48:19 INFO - Successfully installed blessings 08:48:19 INFO - Cleaning up... 08:48:19 INFO - Return code: 0 08:48:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:19 INFO - Reading from file tmpfile_stdout 08:48:19 INFO - Current package versions: 08:48:19 INFO - argparse == 1.2.1 08:48:19 INFO - blessings == 1.6 08:48:19 INFO - blobuploader == 1.2.4 08:48:19 INFO - docopt == 0.6.1 08:48:19 INFO - functools32 == 3.2.3-2 08:48:19 INFO - jsonschema == 2.5.1 08:48:19 INFO - manifestparser == 1.1 08:48:19 INFO - mozInstall == 1.12 08:48:19 INFO - mozcrash == 1.0 08:48:19 INFO - mozdebug == 0.1 08:48:19 INFO - mozdevice == 0.51 08:48:19 INFO - mozfile == 1.2 08:48:19 INFO - mozhttpd == 0.7 08:48:19 INFO - mozinfo == 0.9 08:48:19 INFO - mozleak == 0.1 08:48:19 INFO - mozlog == 3.4 08:48:19 INFO - moznetwork == 0.27 08:48:19 INFO - mozprocess == 0.25 08:48:19 INFO - mozprofile == 0.28 08:48:19 INFO - mozrunner == 6.13 08:48:19 INFO - mozscreenshot == 0.1 08:48:19 INFO - mozsystemmonitor == 0.3 08:48:19 INFO - moztest == 0.8 08:48:19 INFO - mozversion == 1.4 08:48:19 INFO - psutil == 3.1.1 08:48:19 INFO - requests == 1.2.3 08:48:19 INFO - wsgiref == 0.1.2 08:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:19 INFO - Using env: {'DISPLAY': ':0', 08:48:19 INFO - 'HOME': '/home/cltbld', 08:48:19 INFO - 'LANG': 'en_US.UTF-8', 08:48:19 INFO - 'LANGUAGE': 'en_US:en', 08:48:19 INFO - 'LOGNAME': 'cltbld', 08:48:19 INFO - 'MAIL': '/var/mail/cltbld', 08:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:19 INFO - 'MOZ_NO_REMOTE': '1', 08:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:19 INFO - 'NO_EM_RESTART': '1', 08:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:19 INFO - 'PWD': '/builds/slave/test', 08:48:19 INFO - 'SHELL': '/bin/bash', 08:48:19 INFO - 'SHLVL': '1', 08:48:19 INFO - 'TERM': 'linux', 08:48:19 INFO - 'TMOUT': '86400', 08:48:19 INFO - 'USER': 'cltbld', 08:48:19 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:19 INFO - '_': '/tools/buildbot/bin/python'} 08:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 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)) 08:48:19 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:20 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:48:20 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)) 08:48:20 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)) 08:48:20 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)) 08:48:20 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)) 08:48:20 INFO - Installing collected packages: marionette-driver 08:48:20 INFO - Running setup.py install for marionette-driver 08:48:20 INFO - Successfully installed marionette-driver 08:48:20 INFO - Cleaning up... 08:48:20 INFO - Return code: 0 08:48:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e893b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2063a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2206ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, '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': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', '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 08:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:20 INFO - Using env: {'DISPLAY': ':0', 08:48:20 INFO - 'HOME': '/home/cltbld', 08:48:20 INFO - 'LANG': 'en_US.UTF-8', 08:48:20 INFO - 'LANGUAGE': 'en_US:en', 08:48:20 INFO - 'LOGNAME': 'cltbld', 08:48:20 INFO - 'MAIL': '/var/mail/cltbld', 08:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:20 INFO - 'MOZ_NO_REMOTE': '1', 08:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:20 INFO - 'NO_EM_RESTART': '1', 08:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:20 INFO - 'PWD': '/builds/slave/test', 08:48:20 INFO - 'SHELL': '/bin/bash', 08:48:20 INFO - 'SHLVL': '1', 08:48:20 INFO - 'TERM': 'linux', 08:48:20 INFO - 'TMOUT': '86400', 08:48:20 INFO - 'USER': 'cltbld', 08:48:20 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:20 INFO - '_': '/tools/buildbot/bin/python'} 08:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:21 INFO - Cleaning up... 08:48:21 INFO - Return code: 0 08:48:21 INFO - Running post-action listener: _resource_record_post_action 08:48:21 INFO - Running post-action listener: _start_resource_monitoring 08:48:21 INFO - Starting resource monitoring. 08:48:21 INFO - [mozharness: 2017-05-30 15:48:21.115928Z] Finished create-virtualenv step (success) 08:48:21 INFO - [mozharness: 2017-05-30 15:48:21.116411Z] Running install step. 08:48:21 INFO - Running pre-action listener: _resource_record_pre_action 08:48:21 INFO - Running main action method: install 08:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:21 INFO - Reading from file tmpfile_stdout 08:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:21 INFO - Reading from file tmpfile_stdout 08:48:21 INFO - Output received: 08:48:21 INFO - Usage: mozinstall [options] installer 08:48:21 INFO - Options: 08:48:21 INFO - -h, --help show this help message and exit 08:48:21 INFO - -d DEST, --destination=DEST 08:48:21 INFO - Directory to install application into. [default: 08:48:21 INFO - "/builds/slave/test"] 08:48:21 INFO - --app=APP Application being installed. [default: firefox] 08:48:21 INFO - mkdir: /builds/slave/test/build/application 08:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:48:37 INFO - Reading from file tmpfile_stdout 08:48:37 INFO - Output received: 08:48:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:37 INFO - Running post-action listener: _resource_record_post_action 08:48:37 INFO - [mozharness: 2017-05-30 15:48:37.129595Z] Finished install step (success) 08:48:37 INFO - [mozharness: 2017-05-30 15:48:37.129884Z] Running setup-mitmproxy step. 08:48:37 INFO - Running pre-action listener: _resource_record_pre_action 08:48:37 INFO - Running main action method: setup_mitmproxy 08:48:37 INFO - Skipping: mitmproxy is not required 08:48:37 INFO - Running post-action listener: _resource_record_post_action 08:48:37 INFO - [mozharness: 2017-05-30 15:48:37.131006Z] Finished setup-mitmproxy step (success) 08:48:37 INFO - [mozharness: 2017-05-30 15:48:37.131268Z] Running run-tests step. 08:48:37 INFO - Running pre-action listener: _resource_record_pre_action 08:48:37 INFO - Running main action method: run_tests 08:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:37 INFO - Python 2.7.3 08:48:37 INFO - Return code: 0 08:48:37 INFO - grabbing minidump binary from tooltool 08:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:37 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 0x2203e40>, '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 0x2204fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2205440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:37 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 08:48:37 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 08:48:37 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 08:48:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:37 INFO - Return code: 0 08:48:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:37 INFO - ENV: RUST_BACKTRACE is now 1 08:48:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 08:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 08:48:37 INFO - Using env: {'DISPLAY': ':0', 08:48:37 INFO - 'HOME': '/home/cltbld', 08:48:37 INFO - 'LANG': 'en_US.UTF-8', 08:48:37 INFO - 'LANGUAGE': 'en_US:en', 08:48:37 INFO - 'LOGNAME': 'cltbld', 08:48:37 INFO - 'MAIL': '/var/mail/cltbld', 08:48:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:37 INFO - 'MOZ_NO_REMOTE': '1', 08:48:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:37 INFO - 'NO_EM_RESTART': '1', 08:48:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:37 INFO - 'PWD': '/builds/slave/test', 08:48:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:37 INFO - 'RUST_BACKTRACE': '1', 08:48:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:48:37 INFO - 'SHELL': '/bin/bash', 08:48:37 INFO - 'SHLVL': '1', 08:48:37 INFO - 'TERM': 'linux', 08:48:37 INFO - 'TMOUT': '86400', 08:48:37 INFO - 'USER': 'cltbld', 08:48:37 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505', 08:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:37 INFO - '_': '/tools/buildbot/bin/python'} 08:48:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 08:48:37 INFO - mozversion application_buildid: 20170530151654 08:48:37 INFO - mozversion application_changeset: 268cfff98df1cc643df7f79dab467043fd1837f1 08:48:37 INFO - mozversion application_display_name: Nightly 08:48:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:37 INFO - mozversion application_name: Firefox 08:48:37 INFO - mozversion application_remotingname: firefox 08:48:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:48:37 INFO - mozversion application_vendor: Mozilla 08:48:37 INFO - mozversion application_version: 55.0a1 08:48:37 INFO - mozversion platform_buildid: 20170530151654 08:48:37 INFO - mozversion platform_changeset: 268cfff98df1cc643df7f79dab467043fd1837f1 08:48:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:48:37 INFO - mozversion platform_version: 55.0a1 08:48:37 INFO - using testdate: 1496159317 08:48:37 INFO - actual date: 1496159317 08:48:37 INFO - starting webserver on 'localhost:36341' 08:48:37 INFO - SUITE-START | Running 2 tests 08:48:37 INFO - TEST-START | dromaeo_css 08:48:37 INFO - operating with platform_type : linux_ 08:48:37 INFO - Initialising browser for dromaeo_css test... 08:48:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36341/getInfo.html -profile /tmp/tmpxYilu9/profile 08:48:37 INFO - TEST-INFO | started process 5943 (/builds/slave/test/build/application/firefox/firefox http://localhost:36341/getInfo.html) 08:49:12 INFO - TEST-INFO | 5943: killed by SIGTERM 08:49:12 INFO - Browser initialized. 08:49:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:12 INFO - TEST-INFO | started process 6139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxYilu9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:24 INFO - PID 6139 | RSS: Main: 182267904 08:49:24 INFO - PID 6139 | 08:52:28 INFO - PID 6139 | Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36341/tests/dromaeo/cssquery-ext.html) 08:52:30 INFO - PID 6139 | RSS: Main: 179503104 08:52:30 INFO - PID 6139 | 08:55:32 INFO - PID 6139 | Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-ext.html (next: http://localhost:36341/tests/dromaeo/cssquery-jquery.html) 08:55:33 INFO - PID 6139 | RSS: Main: 182702080 08:55:33 INFO - PID 6139 | 08:58:34 INFO - PID 6139 | Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36341/tests/dromaeo/cssquery-mootools.html) 08:58:35 INFO - PID 6139 | RSS: Main: 180113408 08:58:35 INFO - PID 6139 | 09:01:37 INFO - PID 6139 | Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36341/tests/dromaeo/cssquery-prototype.html) 09:01:37 INFO - PID 6139 | RSS: Main: 184233984 09:01:37 INFO - PID 6139 | 09:04:40 INFO - PID 6139 | Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36341/tests/dromaeo/cssquery-yui.html) 09:04:41 INFO - PID 6139 | RSS: Main: 182697984 09:04:41 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-yui.html (next: http://localhost:36341/tests/dromaeo/cssquery-dojo.html) 09:07:43 INFO - PID 6139 | RSS: Main: 181239808 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | __start_tp_report 09:07:43 INFO - PID 6139 | _x_x_mozilla_page_load 09:07:43 INFO - PID 6139 | _x_x_mozilla_page_load_details 09:07:43 INFO - PID 6139 | |i|pagename|runs| 09:07:43 INFO - PID 6139 | |0;dojo.html;2722.19695189919;2725.0598543502483;2739.233014755869;2752.898840463815;2772.237634650472;5114.795408183678;5224.111900976834;5227.921581176281;5244.947550524494;5271.288376069229;5245.580353571715;5250.527452529272;5265.921011184826;5332.866678333044;5350.224217488462;4402.185595664796;4616.146012987608;4683.180443422396;4713.811447542094;4716.811327546894;4698.436187657486;4748.928766068511;4767.04659068186;4774.236122220445;4808.519148085198;4609.285560738057;4624.537546245382;4656.4645065817185;4694.155052090622;4699.060187962387;4700.647451441156;4725.834595789165;4730;4760.5001474844985;4775.116603428342;4660.5339466053465;4682.461516925529;4700.4594471635855;4701.388819453483;4723.338732577442;5148.3564554430695;5227.372715274153;5272.841814745564;5275.419703832614;5315.255864179018;5603.80386686464;5691.7723291068305;5694.6867922264255;5695.658260504383;5703.74333155009;5752.913706294409;5754.6547207167705;5757.222774925373;5759.222504961818;5789.189513468118;5335.839924802262;5341.359036915595;5345.786168553214;5346.572274218053;5352.812651557177;5716.857078573069;5799.18811366409;5815.82552523425;5848.2689663792025;5875.872199779686;5556.416576259516;5577.1355439906065;5589.496945274945;5600.243967064394;5620.185073164368;5517.724113794375;5670.5463562914865;5677.971610141923;5687.744051517609;5694.259746232963;5508.586855985817;5612.943870561242;5652.604317697804;5655.773769049274;5656.575756818255;5599.1041433370465;5621;5659.858503537363;5661.66030038199;5694.829155125353;4703.717776933395;4708.976455117771;4713.505081966413;4740.502247264057;4742.668013239109;4039.4546736190237;4047.817848196838;4053.777042262645;4058.5738497457933;4095.9180816383505;4637.744924029211;4674.275487299474;4717.481077081518;4767.809287628456;4779.904401911942;5715.228444160069;5742.454466825645;5761.279840019997;5764.971175144097;5765.077587585966;4729.290606409066;4733.573978341897;4734.4081989751285;4736.786844592001;4771.71369717818;4837.95162048382;4983.700977941335;4990.426100998432;5002.624803139779;5031.295618613397;5226.63413561047;5254.97372513135;5282.762275697526;5286.471352864683;5307.575393968396;5518.475744804237;5604.971975140098;5611.971940140274;5740.483356497935;5766.855828604318;5224.791008359775;5232.869178270574;5260.079486089995;5338.919916201183;5352.384475785178;5573.470520300565;5579.60942734021;5580.916286255629;5587.860303492445;5637.098064309691;5680.801171958961;5681.17622944679;5693.259876216065;5696.601237913306;5699.059655156852;5424.376196737426;5494.972525137348;5501.504864562208;5504;5506.614536982533;5578.944210557843;5585.2180694701965;5585.776568937197;5591.720413979204;5612.803551875665;5452.890942181213;5491.36849262324;5501.174823776466;5509.118541033416;5509.862253443696;5458.426865179258;5513.476219759116;5618.634788738719;5624.409437009219;5679.829605111853;5364.168553874156;5381.48875856793;5445.7549410277425;5460.590455715757;5466.617336786387 09:07:43 INFO - PID 6139 | |1;ext.html;647.6599785112816;697.7871749116518;711.6157275071461;1106.4301884529464;1116.129419053139;33466.33067338652;34140;34220;34238.828805856;34311.656883431155;35133.12167195815;35342.64657353426;35441.291174176564;35625.10937226571;35686.8215658922;6752.088468056823;6915.481338899577;7015.684294206761;7162.964185179067;7168.713251469961;6923.376896079352;7029.4376449883885;7031.6484175791265;7032.156141263055;7034;6936.306369363074;6949.687264073129;6974.930250697479;7010.053642758214;7044.929550704479;6920.134983127109;6954.895676564855;6968.198657154441;6993.82515437113;7005.964970175142;6756.729730810811;6770.898436523406;6803.2856550062525;6813.3527314905;6825.35159159879;31770.04689859308;31816.681833181836;31901;31952.201194970312;31987.840060799546;3090.18110200797;3138.1213260286927;3138.995521433142;3139.9372012559847;3143.387039527293;24939;24991.375215619573;25031.62452563195;25033.12384066549;25034.123805666713;3030.8181509109304;3053.6335639723375;3055.3736484020724;3058.9541156882665;3096.0711786464194;138050;138768;138914;143649;146685.53314466827;38800.417993730116;39020.804895975336;39026;39075.60924390776;39116.804415977735;40326.79836600857;40371.394429083586;40391.596084039375;40416.79791601023;44445.77777111094;12418.379081045912;12451.626451206479;12479.56321528742;12496.437660305126;12532.498700052078;9754.073363030642;9755.414675119515;9767;9770.120689138012;9774.5601447935;12779.680507987374;12812.359382030862;12846.164999275017;12915.870841291468;12980.221186728826;5327.227552004938;5367.677939323653;5372.462753724674;5469.1249400096585;5475.808346707846;869.2741560796806;908.8954770201511;911.382296423853;921.9723408297762;941.5292353823088;20466.795332046786;21301;21451.570968580854;21554.24560140419;21955.780442195693;991.6033586565287;995.6316163019729;1019.6635110413546;1021.9284650074424;1029.1663752360612;11127.387993660426;11229.21395502307;11459.369734664673;11506.424678766029;11539.134564907665;171212;172442;173102;173352;174098;40267;40475.59524404777;40488.59511404907;40511.1897762049;40514.79742601268;1221.4991853340266;1252.542821870029;1259.6661884600587;1265.3167289663663;1265.4495294547085;19809.801901981373;19959.700604490652;20712;21531.677024844328;21631;30217.69782302237;36807.44788828116;37375;37400.62599373971;37564.24871502609;160426;161778;162106;162410;162524.18737906707;29180.854095729384;29847.850760746056;30537.389252215275;30773.538396923617;31179.844100780258;35381.46927796137;35410;35492.29015419729;36001.459978099825;36341.27317453689;26827.329316766456;27330.453390932467;27996.760259179624;28398;28683.13950581486;27256.182314530597;27477.17568472949;27549.862250688617;27588.724112758617;29044.12867613975;30171.396572067995;30949;31035.84482077575;31130.53304200484;31187.688123118478;26010.479790403708;26718;26759.30322645109;27162.185134445997;27340.453190935674;20546;22585;22901.88549057244;22938;22965.770342296364 09:07:43 INFO - PID 6139 | |2;jquery.html;385.72613444454436;397.90450291929943;400.0937875711514;403.7880112940706;419.84885441241147;12722;12937.870621293785;17553.297868085276;18266.543336416595;18302.54243643908;14471;18618.813811861877;18658.533536661555;18779.906100469478;19402;5177.974110129444;5321.042212401766;5327.893442131155;5332.546733527654;5348.064088784467;5274.973625131869;5295.7881684732565;5353.571714262869;5387.488188622075;5399.1091469907415;5359.035373632744;5363.115086010804;5371.731413429333;5378.46215378461;5383.784648614051;5221.2951251580935;5228.607854410934;5250.238715386286;5323.653962492445;5346.984073026113;4673.649476289258;4701.882452938669;4729.219678753002;4730.881727956794;4733.24268117103;22169.334919952427;22208.777912220994;22763.54472910549;22891.42771430711;22895.31314060581;1625.9674806503922;1637.2386840119282;1663.7920259967505;1665.300573759024;1667.908265045422;14529.128252304896;14792.852071479256;14942.925285373612;15005.624859378602;15312.617184570476;1985.354759703088;2010.7788143304224;2046.0894901768718;2051.548659294953;2054.969175462369;87837;90300.09699902983;90816;91616;97508;10393.792124157475;10530.10494107994;10734.838977415346;10778.784424311627;10838.783224335626;14524.782128268085;14531.92734036323;14532.782008269673;14542.85457145415;14547.3453694584;7373.77878663641;7627.571401263653;7634.580098094658;7763.456558040883;7834.138244793068;7160.355567998905;7170.282971702893;7172.138172877793;7396.778096657109;7398.815029624195;6869.278725733826;6870.797610418157;6913.92078673585;6948.5483443576;7078.858422831515;1965.2237366240256;1986.6721990871345;1995.9301424450075;2011.0548042420332;2041.6325061488778;823.7816978500703;852.5694524265331;874.711345256064;888.5912480259153;890.9777255568663;17614.647707045788;17778.5555361117;18069.096545172688;18078.63842723138;18382.264709411742;864.3387808326635;888.8000199955088;891.9286457083417;895.4806212396925;912.8448163812168;9484.910595089847;9638.325317227867;9913.603455861685;9957.452340121217;10031.147352474976;360002;363135;365165;392335;400891;74842;78715;78734.60632696915;79236.20763792288;82463;1038.963636272742;1051.7686109055996;1097.846301517788;1103.2112039891515;1104.5140138339104;15138.545843624708;18502.629947400706;19087.713684294467;19115.330963416214;19440;39340.60659393369;39429;39775.60224397719;40236.1952760949;40411.7979410101;46718.53281467278;46755.29867052065;47299.29051064168;47372.2894156581;48844.511554885416;7853.764387068397;7863.606819658879;7908.604569771604;7970.880436793337;8022.358211343195;12207.75584488323;12360.814587781011;12387.504499819906;12604.87395126037;12686.873131268569;9750;10313.381197128196;10362.481875906024;10479.318844275098;11028.834567481334;9415.199708024895;9777.120059194707;9965.202783777135;10143.442110683687;10203.795924081625;10088.293819432569;10535.367877927349;10717.249792514449;11172.888271117185;11599.014083802635;7826.178251283533;7829.099653539688;7997.8400431992195;8350.916490835014;8490.490570565786;11276.605318813803;11383.658490245305;11481.712957176138;11826.704332391415;11898.464569094585 09:07:43 INFO - PID 6139 | |3;mootools.html;1269.89205917497;1323.4706117552978;1330.1819381080638;1331.3809078778372;1355.5052405871854;9792.559334829932;10050.698479045623;10228.641997530089;10241.795164096722;10289;9654;9767.2186225102;9772.120509154174;9815;9826.508674566261;2040.7142999980015;2077.5740973100555;2079.906404211814;2080.490279881431;2080.500679836836;1969.4780883065998;2020.1313435222849;2023.8178563929243;2026.63520566298;2027.2499175305084;1967.4687834284734;1996.291316582614;2002.4192984034612;2009.25657506722;2017.6469117904383;1937.9903100484548;1948.9902550487227;1952.3362056900721;1956.5108722819296;1961.117497126299;1636.443609172887;1699.745038244261;1867.6544839204792;1889.6409682160345;1900.6483800496815;9772.90227097727;10035.899641003643;10036.247281453847;10037.799244015152;10051.849222261671;5081.390233172006;5290.523852853224;5291.682499050069;5292.655977361459;5296.046711591912;2951.144168191222;3071.800332978349;3118.7193152616373;3123.063081075691;3131.906042818719;1000.2947921715173;1003.5584342889106;1023.0945613132432;1037.2324479884905;1047.2983101322131;14688;14777.704445911022;14811.111333320036;14853;14865.580916389183;4480.820767169277;4492.73043617384;4582.518835522289;4625.7455839929125;4626.514216007338;10998.835017474745;10999.065079468175;11011.559537618567;11025.724356891142;11026.834597481044;5140.640155189101;5322.707251101227;5339.81310654133;5344.518993290545;5351.224072509543;4890.682105663121;4955.4796746341835;4957.454679985199;4965.503449655005;4998.350214472095;3682;3722.3113723961155;3770.9057273567832;3811.6950643948417;3847.0574709196426;1019.658414431159;1024.0783295034528;1030.3251370352432;1036.6164519127972;1039.0233180810164;711.3420086420041;728.3335747790712;735.1398863329916;742.8699977503916;748.8914107454389;5275.551578115903;5312.707801070901;5383.380911195184;5456.372517160498;5466.699331536804;494.1081348166522;517.4980269138929;517.5833454069435;517.8265281130788;517.9119549676564;3484.285721427101;3531.805750683686;3628.310620982005;3839.9232015359535;3902.473166122537;11895;12550.87449125497;13093.541726039542;13101.475940962255;13106.868931310755;11492.54029838797;12060.517579296906;12647.810282845765;12649.241045537297;12667.11330206895;7227.566346019151;7263.818404539928;7358.1538123116525;7403.259674032553;7419.035525381666;5655.377908429987;5669.376368599368;5679.432056794452;5743.6840973745175;5854.502367298827;11203.887961120285;11523.308601483937;11531.1351648625;11678.357690326773;11716.589919352782;11841.28952262867;11895.226810257305;12017;12070.732573080051;12077.69805754828;7436.702531898663;7551.546907185587;7551.811204719926;7565.470417070752;7570.356519695888;8964.820703585761;9147.176754092163;9148.222401095982;9206.815863682823;9248;7948.40386970991;7999.240072193133;8042.115367309474;8109.878351824846;8206.179382061746;7545.471816972759;7548.962255188689;7583.9620801895635;7719.459637825523;7803.570803605856;7060.71757129709;7062.858742825218;7140.250273721393;7148;7150.141982962078;4902.485239049848;4969.527894849984;4969.900601988013;5110.207917772751;5175.560077393464;5001.199808030843;5006.4743201963265;5134.383873935151;5175.715335656424;5218.217267409919 09:07:43 INFO - PID 6139 | |4;prototype.html;324.56174447078945;339.57383483727926;344.1963016356807;348.74367340005074;348.7576134586462;5321.52106310432;5465.562754979602;5506.834794956153;5518.751656175472;5573.665580065199;5275.419703832576;5345.930813837238;5353.544948679357;5364;5369.550221440209;4048.6153815387565;4048.817803198848;4049.1699201663587;4051.979740101295;4056.4320995060716;3888.9222215555674;4053.655439287664;4064.3700226464944;4067.28822456069;4078.4290199371962;4031.5565287818317;4035.57626449223;4036.475258216428;4037.2732908076537;4051.331530297512;4004.2592120457516;4008.9599104009026;4013.678905687538;4017.4777278953693;4017.879463616096;3498.912527186815;3506.5090887275546;3514.7012503937194;3519.0674471265133;3520.419130843408;5234.659747116425;5268.420473747885;5291.3121294231505;5309.840704778863;5325.733713314357;4706.270528068155;4717.787699553528;4718.8584342469785;4720.716756994591;4726.692764970266;5553.694881702797;5664.535926871783;5676.801311954062;5677.517411020068;5705.229793977802;3890.3077161434867;3915.706322025831;3916.725829191958;3922.627350401707;3927.6661483773914;5658.292713410824;5871.706414679249;5965.612235204698;6003.849903752441;6004.96997515014;3848.942265866014;3923.6664883485223;3927.2930872443235;3929.7642141471033;3941.7043721720984;3988.3219852625125;3998.4402183694306;4000.2799496090984;4002.939221106409;4003.399490076512;4543.931841022388;4662.883427914329;4671.579557839811;4672.462666793294;4673.929891051637;5674.687892165971;5677.914831277534;5687.516561092353;5703.486686198262;5726.828195154152;1374.7387996280675;1375.7523645743663;1376.8210132682686;1381.3921874375242;1392.6448755567264;865.2731705367521;902.3548163063441;909.2680392284143;910.4082346474844;912.1516989199976;4849.733264670477;4857.684250523705;4873.9025219496125;4881.096997055556;4893.119238537098;5850.385709500441;5857.414258574108;5861.970690146607;5897.528197744256;5905.173275741399;4775.21209000518;4792.233242681224;4809.302651115569;4830.8309209178215;4838.225883858566;3083.429565530384;3101.6122984626923;3103.239706271978;3104.7516198704047;3112.37752449511;5481.369642491165;5483.532410415329;5485.698286594195;5498.835034948958;5506.972465137648;5871.3541510433815;6010.579259451883;6028.3971602839365;6066.1204125402455;6081;5472.288602481652;5475.370332411823;5492.450754924475;5494.36814766307;5496.5053145216325;5703.5722320826935;5758.870151354321;5800.59395842287;5881.529477641864;5903.350631430453;5739.2252045973255;5764.481196692318;5767.567432442667;5791.189233507396;5798.10129429939;5220.791168353223;5245.449227831023;5372.824006277464;5430.67415955044;5433.918491222714;3870.109874728772;3907.2185562886966;3909.8045097745567;3911.2959667260166;3931.545328228574;5873.530117590668;5893.528517718658;5919.881602367843;5922.564912350912;5946.256717910262;5563.276774019351;5688.7440065198;5707.946248756895;5738.916748246872;5773.653580785166;5708.172315014217;5719.199312096227;5760.810891861066;5769.855753606025;5781.768729250783;5556.527695145958;5643.407442218508;5664.660120392789;5669.590424069836;5673.319201695823;5692.893629357164;5768.53851691872;5779.2775903012125;5789.623674461147;5790.884182316414;5573.052581061148;5605.383407825055;5614.382417934105;5615.213870058276;5624.156376543551 09:07:43 INFO - PID 6139 | |5;yui.html;668.9799306020819;689.5242282824848;691.3432239372594;733.6331834082958;750.6359415683389;12006.399680015986;12395.318257495834;13062.412191451383;13624.795628065574;13643.795343069862;14662.63343416415;15188.544343669708;15268.84731152688;15313.387464501406;15345.69308613827;878.8505953987806;893.0266010049045;898.3127907151035;898.9865152022725;900.9729708108767;831.7213733399318;909.5588639509832;913.8492148795441;916.6562539047857;918.8805455290803;957.9760505987372;970.3013830042394;970.6360114956891;970.6554173268494;971.6939164163266;966.2173639352147;966.6809952715587;967.3470407474962;968.2254196642658;970.5001924009141;719.5287086957999;720;720.0711082703307;721.4444877444339;721.4841388407314;14146.85853141476;14337.56987290383;14455.494057708034;14472.71054578913;14549.199794011325;15939.760903586455;16209.189540522926;16287.104209268486;16363.509094727176;16368.918155409267;12469.937650311691;12591.622251332476;12899.871001289961;12993.220406775623;13010.479580816756;3031.8787248510034;3032.4996375598;3036.3775426037832;3037.665856755755;3040.665526792051;72173;72487;74053.62973185099;74307.88538171985;74425.62787186084;12084.335361555199;12564.560240391726;12626.053046021585;12871.163374380636;12871.356432178354;23205.187818426275;24056;24166.39584010414;24432.267031989068;24501.01995920179;6208.037754148114;6213.720382582795;6214.316425193225;6234.719437625317;6280.434760871543;2962.481565725989;3098.8760449581764;3141.0890841655664;3161.668024857403;3173.174974506645;3503.3518799021754;4322.070754787673;4521.638268938477;4525.683202175882;4535.070310586322;754.4153281207108;766.3332900376597;780.282140430805;782.2451334462271;783.4829012851491;566.2610293566935;578.7655999320282;593.5489028338494;597.748945442915;607.0742118269586;10005;10549.789004219872;10606.363618182933;10669.679909602724;10758.246922715334;562.7720773086907;572.0389745228057;573.8307199376194;578.5718568259458;591.7307625030601;4424.469063712375;5080.110980578384;5327.760250788646;5556.861078473071;5694.686792226385;86494;89515;90383.54808225916;90844.09155908489;91144;72869.63565182246;75986.62006689931;76260.23739762642;76813;77285.61357193178;64914;65297.347026529125;67343.66328168327;67743.3225667737;68078.3192168072;10228.721409823773;11017.724556885822;11063.72340691489;11110.666679999613;11127.054200393057;26973.595396069468;27014.1895743128;27362.72637273602;28235;28453.288667783472;49751.502484974684;49971.000579988926;50783;52270.477295228084;52965;14140.222287774272;14157.787633185304;14566.41734330615;14567.92716036413;14699.92650036743;15263.465778698137;15398.076115432661;15600;15644.452444164855;15880.682386352439;13073.084884058024;13818.792718109034;13966.092204006707;14016.29918504091;14241.430342786587;13835.446582137005;13972.720545589234;14685.48600798967;14771.03988240761;14973.251337433303;12651.810222846849;12722.809157862825;12754.681132971378;14928.10431374121;15517.612059698598;9311.627534898798;9560.61757529691;9694.17599504022;9872.11150996385;9890.109890109925;11794.882051179722;12223.633291001284;12248.693782655504;12396.318202498589;12551.184173029089 09:07:43 INFO - PID 6139 | __end_tp_report 09:07:43 INFO - PID 6139 | __start_cc_report 09:07:43 INFO - PID 6139 | _x_x_mozilla_cycle_collect,402 09:07:43 INFO - PID 6139 | __end_cc_report 09:07:43 INFO - PID 6139 | __startTimestamp1496160463329__endTimestamp 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | ------- Summary: start ------- 09:07:43 INFO - PID 6139 | Number of tests: 6 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | [#0] dojo.html Cycles:165 Average:5184.33 Median:5350.22 stddev:617.84 (11.5%) stddev-sans-first:588.77 09:07:43 INFO - PID 6139 | Values: 2722.2 2725.1 2739.2 2752.9 2772.2 5114.8 5224.1 5227.9 5244.9 5271.3 5245.6 5250.5 5265.9 5332.9 5350.2 4402.2 4616.1 4683.2 4713.8 4716.8 4698.4 4748.9 4767.0 4774.2 4808.5 4609.3 4624.5 4656.5 4694.2 4699.1 4700.6 4725.8 4730.0 4760.5 4775.1 4660.5 4682.5 4700.5 4701.4 4723.3 5148.4 5227.4 5272.8 5275.4 5315.3 5603.8 5691.8 5694.7 5695.7 5703.7 5752.9 5754.7 5757.2 5759.2 5789.2 5335.8 5341.4 5345.8 5346.6 5352.8 5716.9 5799.2 5815.8 5848.3 5875.9 5556.4 5577.1 5589.5 5600.2 5620.2 5517.7 5670.5 5678.0 5687.7 5694.3 5508.6 5612.9 5652.6 5655.8 5656.6 5599.1 5621.0 5659.9 5661.7 5694.8 4703.7 4709.0 4713.5 4740.5 4742.7 4039.5 4047.8 4053.8 4058.6 4095.9 4637.7 4674.3 4717.5 4767.8 4779.9 5715.2 5742.5 5761.3 5765.0 5765.1 4729.3 4733.6 4734.4 4736.8 4771.7 4838.0 4983.7 4990.4 5002.6 5031.3 5226.6 5255.0 5282.8 5286.5 5307.6 5518.5 5605.0 5612.0 5740.5 5766.9 5224.8 5232.9 5260.1 5338.9 5352.4 5573.5 5579.6 5580.9 5587.9 5637.1 5680.8 5681.2 5693.3 5696.6 5699.1 5424.4 5495.0 5501.5 5504.0 5506.6 5578.9 5585.2 5585.8 5591.7 5612.8 5452.9 5491.4 5501.2 5509.1 5509.9 5458.4 5513.5 5618.6 5624.4 5679.8 5364.2 5381.5 5445.8 5460.6 5466.6 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | [#1] ext.html Cycles:180 Average:30542.05 Median:31183.77 stddev:41040.44 (131.6%) stddev-sans-first:41094.18 09:07:43 INFO - PID 6139 | Values: 647.7 697.8 711.6 1106.4 1116.1 33466.3 34140.0 34220.0 34238.8 34311.7 35133.1 35342.6 35441.3 35625.1 35686.8 6752.1 6915.5 7015.7 7163.0 7168.7 6923.4 7029.4 7031.6 7032.2 7034.0 6936.3 6949.7 6974.9 7010.1 7044.9 6920.1 6954.9 6968.2 6993.8 7006.0 6756.7 6770.9 6803.3 6813.4 6825.4 31770.0 31816.7 31901.0 31952.2 31987.8 3090.2 3138.1 3139.0 3139.9 3143.4 24939.0 24991.4 25031.6 25033.1 25034.1 3030.8 3053.6 3055.4 3059.0 3096.1 138050.0 138768.0 138914.0 143649.0 146685.5 38800.4 39020.8 39026.0 39075.6 39116.8 40326.8 40371.4 40391.6 40416.8 44445.8 12418.4 12451.6 12479.6 12496.4 12532.5 9754.1 9755.4 9767.0 9770.1 9774.6 12779.7 12812.4 12846.2 12915.9 12980.2 5327.2 5367.7 5372.5 5469.1 5475.8 869.3 908.9 911.4 922.0 941.5 20466.8 21301.0 21451.6 21554.2 21955.8 991.6 995.6 1019.7 1021.9 1029.2 11127.4 11229.2 11459.4 11506.4 11539.1 171212.0 172442.0 173102.0 173352.0 174098.0 40267.0 40475.6 40488.6 40511.2 40514.8 1221.5 1252.5 1259.7 1265.3 1265.4 19809.8 19959.7 20712.0 21531.7 21631.0 30217.7 36807.4 37375.0 37400.6 37564.2 160426.0 161778.0 162106.0 162410.0 162524.2 29180.9 29847.9 30537.4 30773.5 31179.8 35381.5 35410.0 35492.3 36001.5 36341.3 26827.3 27330.5 27996.8 28398.0 28683.1 27256.2 27477.2 27549.9 27588.7 29044.1 30171.4 30949.0 31035.8 31130.5 31187.7 26010.5 26718.0 26759.3 27162.2 27340.5 20546.0 22585.0 22901.9 22938.0 22965.8 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | [#2] jquery.html Cycles:180 Average:25126.65 Median:20087.85 stddev:62772.56 (312.5%) stddev-sans-first:62921.17 09:07:43 INFO - PID 6139 | Values: 385.7 397.9 400.1 403.8 419.8 12722.0 12937.9 17553.3 18266.5 18302.5 14471.0 18618.8 18658.5 18779.9 19402.0 5178.0 5321.0 5327.9 5332.5 5348.1 5275.0 5295.8 5353.6 5387.5 5399.1 5359.0 5363.1 5371.7 5378.5 5383.8 5221.3 5228.6 5250.2 5323.7 5347.0 4673.6 4701.9 4729.2 4730.9 4733.2 22169.3 22208.8 22763.5 22891.4 22895.3 1626.0 1637.2 1663.8 1665.3 1667.9 14529.1 14792.9 14942.9 15005.6 15312.6 1985.4 2010.8 2046.1 2051.5 2055.0 87837.0 90300.1 90816.0 91616.0 97508.0 10393.8 10530.1 10734.8 10778.8 10838.8 14524.8 14531.9 14532.8 14542.9 14547.3 7373.8 7627.6 7634.6 7763.5 7834.1 7160.4 7170.3 7172.1 7396.8 7398.8 6869.3 6870.8 6913.9 6948.5 7078.9 1965.2 1986.7 1995.9 2011.1 2041.6 823.8 852.6 874.7 888.6 891.0 17614.6 17778.6 18069.1 18078.6 18382.3 864.3 888.8 891.9 895.5 912.8 9484.9 9638.3 9913.6 9957.5 10031.1 360002.0 363135.0 365165.0 392335.0 400891.0 74842.0 78715.0 78734.6 79236.2 82463.0 1039.0 1051.8 1097.8 1103.2 1104.5 15138.5 18502.6 19087.7 19115.3 19440.0 39340.6 39429.0 39775.6 40236.2 40411.8 46718.5 46755.3 47299.3 47372.3 48844.5 7853.8 7863.6 7908.6 7970.9 8022.4 12207.8 12360.8 12387.5 12604.9 12686.9 9750.0 10313.4 10362.5 10479.3 11028.8 9415.2 9777.1 9965.2 10143.4 10203.8 10088.3 10535.4 10717.2 11172.9 11599.0 7826.2 7829.1 7997.8 8350.9 8490.5 11276.6 11383.7 11481.7 11826.7 11898.5 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | [#3] mootools.html Cycles:180 Average:6037.56 Median:3843.49 stddev:3955.03 (102.9%) stddev-sans-first:3949.91 09:07:43 INFO - PID 6139 | Values: 1269.9 1323.5 1330.2 1331.4 1355.5 9792.6 10050.7 10228.6 10241.8 10289.0 9654.0 9767.2 9772.1 9815.0 9826.5 2040.7 2077.6 2079.9 2080.5 2080.5 1969.5 2020.1 2023.8 2026.6 2027.2 1967.5 1996.3 2002.4 2009.3 2017.6 1938.0 1949.0 1952.3 1956.5 1961.1 1636.4 1699.7 1867.7 1889.6 1900.6 9772.9 10035.9 10036.2 10037.8 10051.8 5081.4 5290.5 5291.7 5292.7 5296.0 2951.1 3071.8 3118.7 3123.1 3131.9 1000.3 1003.6 1023.1 1037.2 1047.3 14688.0 14777.7 14811.1 14853.0 14865.6 4480.8 4492.7 4582.5 4625.7 4626.5 10998.8 10999.1 11011.6 11025.7 11026.8 5140.6 5322.7 5339.8 5344.5 5351.2 4890.7 4955.5 4957.5 4965.5 4998.4 3682.0 3722.3 3770.9 3811.7 3847.1 1019.7 1024.1 1030.3 1036.6 1039.0 711.3 728.3 735.1 742.9 748.9 5275.6 5312.7 5383.4 5456.4 5466.7 494.1 517.5 517.6 517.8 517.9 3484.3 3531.8 3628.3 3839.9 3902.5 11895.0 12550.9 13093.5 13101.5 13106.9 11492.5 12060.5 12647.8 12649.2 12667.1 7227.6 7263.8 7358.2 7403.3 7419.0 5655.4 5669.4 5679.4 5743.7 5854.5 11203.9 11523.3 11531.1 11678.4 11716.6 11841.3 11895.2 12017.0 12070.7 12077.7 7436.7 7551.5 7551.8 7565.5 7570.4 8964.8 9147.2 9148.2 9206.8 9248.0 7948.4 7999.2 8042.1 8109.9 8206.2 7545.5 7549.0 7584.0 7719.5 7803.6 7060.7 7062.9 7140.3 7148.0 7150.1 4902.5 4969.5 4969.9 5110.2 5175.6 5001.2 5006.5 5134.4 5175.7 5218.2 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | [#4] prototype.html Cycles:180 Average:4656.97 Median:5358.77 stddev:1406.75 (26.3%) stddev-sans-first:1372.60 09:07:43 INFO - PID 6139 | Values: 324.6 339.6 344.2 348.7 348.8 5321.5 5465.6 5506.8 5518.8 5573.7 5275.4 5345.9 5353.5 5364.0 5369.6 4048.6 4048.8 4049.2 4052.0 4056.4 3888.9 4053.7 4064.4 4067.3 4078.4 4031.6 4035.6 4036.5 4037.3 4051.3 4004.3 4009.0 4013.7 4017.5 4017.9 3498.9 3506.5 3514.7 3519.1 3520.4 5234.7 5268.4 5291.3 5309.8 5325.7 4706.3 4717.8 4718.9 4720.7 4726.7 5553.7 5664.5 5676.8 5677.5 5705.2 3890.3 3915.7 3916.7 3922.6 3927.7 5658.3 5871.7 5965.6 6003.8 6005.0 3848.9 3923.7 3927.3 3929.8 3941.7 3988.3 3998.4 4000.3 4002.9 4003.4 4543.9 4662.9 4671.6 4672.5 4673.9 5674.7 5677.9 5687.5 5703.5 5726.8 1374.7 1375.8 1376.8 1381.4 1392.6 865.3 902.4 909.3 910.4 912.2 4849.7 4857.7 4873.9 4881.1 4893.1 5850.4 5857.4 5862.0 5897.5 5905.2 4775.2 4792.2 4809.3 4830.8 4838.2 3083.4 3101.6 3103.2 3104.8 3112.4 5481.4 5483.5 5485.7 5498.8 5507.0 5871.4 6010.6 6028.4 6066.1 6081.0 5472.3 5475.4 5492.5 5494.4 5496.5 5703.6 5758.9 5800.6 5881.5 5903.4 5739.2 5764.5 5767.6 5791.2 5798.1 5220.8 5245.4 5372.8 5430.7 5433.9 3870.1 3907.2 3909.8 3911.3 3931.5 5873.5 5893.5 5919.9 5922.6 5946.3 5563.3 5688.7 5707.9 5738.9 5773.7 5708.2 5719.2 5760.8 5769.9 5781.8 5556.5 5643.4 5664.7 5669.6 5673.3 5692.9 5768.5 5779.3 5789.6 5790.9 5573.1 5605.4 5614.4 5615.2 5624.2 09:07:43 INFO - PID 6139 | 09:07:43 INFO - PID 6139 | [#5] yui.html Cycles:180 Average:17691.88 Median:3912.71 stddev:23130.63 (591.2%) stddev-sans-first:23160.20 09:07:43 INFO - PID 6139 | Values: 669.0 689.5 691.3 733.6 750.6 12006.4 12395.3 13062.4 13624.8 13643.8 14662.6 15188.5 15268.8 15313.4 15345.7 878.9 893.0 898.3 899.0 901.0 831.7 909.6 913.8 916.7 918.9 958.0 970.3 970.6 970.7 971.7 966.2 966.7 967.3 968.2 970.5 719.5 720.0 720.1 721.4 721.5 14146.9 14337.6 14455.5 14472.7 14549.2 15939.8 16209.2 16287.1 16363.5 16368.9 12469.9 12591.6 12899.9 12993.2 13010.5 3031.9 3032.5 3036.4 3037.7 3040.7 72173.0 72487.0 74053.6 74307.9 74425.6 12084.3 12564.6 12626.1 12871.2 12871.4 23205.2 24056.0 24166.4 24432.3 24501.0 6208.0 6213.7 6214.3 6234.7 6280.4 2962.5 3098.9 3141.1 3161.7 3173.2 3503.4 4322.1 4521.6 4525.7 4535.1 754.4 766.3 780.3 782.2 783.5 566.3 578.8 593.5 597.7 607.1 10005.0 10549.8 10606.4 10669.7 10758.2 562.8 572.0 573.8 578.6 591.7 4424.5 5080.1 5327.8 5556.9 5694.7 86494.0 89515.0 90383.5 90844.1 91144.0 72869.6 75986.6 76260.2 76813.0 77285.6 64914.0 65297.3 67343.7 67743.3 68078.3 10228.7 11017.7 11063.7 11110.7 11127.1 26973.6 27014.2 27362.7 28235.0 28453.3 49751.5 49971.0 50783.0 52270.5 52965.0 14140.2 14157.8 14566.4 14567.9 14699.9 15263.5 15398.1 15600.0 15644.5 15880.7 13073.1 13818.8 13966.1 14016.3 14241.4 13835.4 13972.7 14685.5 14771.0 14973.3 12651.8 12722.8 12754.7 14928.1 15517.6 9311.6 9560.6 9694.2 9872.1 9890.1 11794.9 12223.6 12248.7 12396.3 12551.2 09:07:43 INFO - PID 6139 | -------- Summary: end -------- 09:07:43 INFO - PID 6139 | 09:07:44 INFO - TEST-INFO | 6139: exit 0 09:07:44 INFO - TEST-OK | dromaeo_css | took 1146872ms 09:07:44 INFO - TEST-START | kraken 09:07:44 INFO - operating with platform_type : linux_ 09:07:44 INFO - Initialising browser for kraken test... 09:07:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36341/getInfo.html -profile /tmp/tmpXtuTBF/profile 09:07:44 INFO - TEST-INFO | started process 6539 (/builds/slave/test/build/application/firefox/firefox http://localhost:36341/getInfo.html) 09:08:19 INFO - TEST-INFO | 6539: killed by SIGTERM 09:08:19 INFO - Browser initialized. 09:08:19 INFO - Running cycle 1/1 for kraken test... 09:08:19 INFO - TEST-INFO | started process 6737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXtuTBF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:31 INFO - PID 6737 | RSS: Main: 182534144 09:08:31 INFO - PID 6737 | 09:08:34 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:35 INFO - PID 6737 | RSS: Main: 185552896 09:08:35 INFO - PID 6737 | 09:08:38 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-dft) 09:08:38 INFO - PID 6737 | RSS: Main: 184721408 09:08:38 INFO - PID 6737 | 09:08:41 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-fft) 09:08:42 INFO - PID 6737 | RSS: Main: 180985856 09:08:42 INFO - PID 6737 | 09:08:44 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-oscillator) 09:08:44 INFO - PID 6737 | RSS: Main: 181534720 09:08:44 INFO - PID 6737 | 09:08:47 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:47 INFO - PID 6737 | RSS: Main: 181587968 09:08:47 INFO - PID 6737 | 09:08:50 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36341/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:51 INFO - PID 6737 | RSS: Main: 182607872 09:08:51 INFO - PID 6737 | 09:08:54 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36341/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:55 INFO - PID 6737 | RSS: Main: 181788672 09:08:55 INFO - PID 6737 | 09:08:58 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36341/tests/kraken/driver.html?testName=json-parse-financial) 09:08:59 INFO - PID 6737 | RSS: Main: 182476800 09:08:59 INFO - PID 6737 | 09:09:00 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:01 INFO - PID 6737 | RSS: Main: 182448128 09:09:01 INFO - PID 6737 | 09:09:03 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:03 INFO - PID 6737 | RSS: Main: 182202368 09:09:03 INFO - PID 6737 | 09:09:06 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:06 INFO - PID 6737 | RSS: Main: 182071296 09:09:06 INFO - PID 6737 | 09:09:09 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:10 INFO - PID 6737 | RSS: Main: 182673408 09:09:10 INFO - PID 6737 | 09:09:13 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:14 INFO - PID 6737 | RSS: Main: 182366208 09:09:14 INFO - PID 6737 | 09:09:15 INFO - PID 6737 | Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36341/tests/kraken/driver.html?testName=ai-astar) 09:09:16 INFO - PID 6737 | RSS: Main: 183758848 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | __start_tp_report 09:09:16 INFO - PID 6737 | _x_x_mozilla_page_load 09:09:16 INFO - PID 6737 | _x_x_mozilla_page_load_details 09:09:16 INFO - PID 6737 | |i|pagename|runs| 09:09:16 INFO - PID 6737 | |0;ai-astar;104;111;111;111;111;113;112;112;111;115 09:09:16 INFO - PID 6737 | |1;audio-beat-detection;165;123;126;171;133;129;126;129;149;125 09:09:16 INFO - PID 6737 | |2;audio-dft;166;164;164;165;167;169;169;165;164;166 09:09:16 INFO - PID 6737 | |3;audio-fft;74;76;74;106;76;74;74;74;96;76 09:09:16 INFO - PID 6737 | |4;audio-oscillator;85;83;98;84;84;84;97;83;85;107 09:09:16 INFO - PID 6737 | |5;imaging-gaussian-blur;114;116;113;115;113;114;113;115;114;115 09:09:16 INFO - PID 6737 | |6;imaging-darkroom;151;151;151;151;150;150;150;151;151;151 09:09:16 INFO - PID 6737 | |7;imaging-desaturate;94;95;94;95;95;95;94;95;95;95 09:09:16 INFO - PID 6737 | |8;json-parse-financial;57;57;55;54;56;56;56;56;56;58 09:09:16 INFO - PID 6737 | |9;json-stringify-tinderbox;56;57;55;57;57;56;56;57;57;57 09:09:16 INFO - PID 6737 | |10;stanford-crypto-aes;89;88;86;87;87;95;86;89;132;86 09:09:16 INFO - PID 6737 | |11;stanford-crypto-ccm;146;136;140;137;136;141;131;135;147;139 09:09:16 INFO - PID 6737 | |12;stanford-crypto-pbkdf2;182;193;200;195;194;193;184;198;199;185 09:09:16 INFO - PID 6737 | |13;stanford-crypto-sha256-iterative;73;76;74;75;75;77;75;72;86;69 09:09:16 INFO - PID 6737 | __end_tp_report 09:09:16 INFO - PID 6737 | __start_cc_report 09:09:16 INFO - PID 6737 | _x_x_mozilla_cycle_collect,1022 09:09:16 INFO - PID 6737 | __end_cc_report 09:09:16 INFO - PID 6737 | __startTimestamp1496160556062__endTimestamp 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | ------- Summary: start ------- 09:09:16 INFO - PID 6737 | Number of tests: 14 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:2.81 (2.5%) stddev-sans-first:1.36 09:09:16 INFO - PID 6737 | Values: 104.0 111.0 111.0 111.0 111.0 113.0 112.0 112.0 111.0 115.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:131.00 stddev:17.66 (13.5%) stddev-sans-first:15.70 09:09:16 INFO - PID 6737 | Values: 165.0 123.0 126.0 171.0 133.0 129.0 126.0 129.0 149.0 125.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 09:09:16 INFO - PID 6737 | Values: 166.0 164.0 164.0 165.0 167.0 169.0 169.0 165.0 164.0 166.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.00 stddev:11.35 (15.1%) stddev-sans-first:11.83 09:09:16 INFO - PID 6737 | Values: 74.0 76.0 74.0 106.0 76.0 74.0 74.0 74.0 96.0 76.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:84.50 stddev:8.49 (10.0%) stddev-sans-first:8.88 09:09:16 INFO - PID 6737 | Values: 85.0 83.0 98.0 84.0 84.0 84.0 97.0 83.0 85.0 107.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:1.03 (0.9%) stddev-sans-first:1.09 09:09:16 INFO - PID 6737 | Values: 114.0 116.0 113.0 115.0 113.0 114.0 113.0 115.0 114.0 115.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:09:16 INFO - PID 6737 | Values: 151.0 151.0 151.0 151.0 150.0 150.0 150.0 151.0 151.0 151.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:09:16 INFO - PID 6737 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.10 (2.0%) stddev-sans-first:1.12 09:09:16 INFO - PID 6737 | Values: 57.0 57.0 55.0 54.0 56.0 56.0 56.0 56.0 56.0 58.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:57.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 09:09:16 INFO - PID 6737 | Values: 56.0 57.0 55.0 57.0 57.0 56.0 56.0 57.0 57.0 57.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:87.50 stddev:14.14 (16.2%) stddev-sans-first:14.94 09:09:16 INFO - PID 6737 | Values: 89.0 88.0 86.0 87.0 87.0 95.0 86.0 89.0 132.0 86.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:139.50 stddev:4.94 (3.5%) stddev-sans-first:4.50 09:09:16 INFO - PID 6737 | Values: 146.0 136.0 140.0 137.0 136.0 141.0 131.0 135.0 147.0 139.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:194.50 stddev:6.46 (3.3%) stddev-sans-first:5.68 09:09:16 INFO - PID 6737 | Values: 182.0 193.0 200.0 195.0 194.0 193.0 184.0 198.0 199.0 185.0 09:09:16 INFO - PID 6737 | 09:09:16 INFO - PID 6737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.00 stddev:4.42 (5.9%) stddev-sans-first:4.61 09:09:16 INFO - PID 6737 | Values: 73.0 76.0 74.0 75.0 75.0 77.0 75.0 72.0 86.0 69.0 09:09:16 INFO - PID 6737 | -------- Summary: end -------- 09:09:16 INFO - PID 6737 | 09:09:17 INFO - TEST-INFO | 6737: exit 0 09:09:17 INFO - TEST-OK | kraken | took 93049ms 09:09:17 INFO - SUITE-END | took 1239s 09:09:17 INFO - Completed test suite (00:20:40) 09:09:17 INFO - javascript benchmark 09:09:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6691.577713057093, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.19695189919, 2725.0598543502483, 2739.233014755869, 2752.898840463815, 2772.237634650472, 5114.795408183678, 5224.111900976834, 5227.921581176281, 5244.947550524494, 5271.288376069229, 5245.580353571715, 5250.527452529272, 5265.921011184826, 5332.866678333044, 5350.224217488462, 4402.185595664796, 4616.146012987608, 4683.180443422396, 4713.811447542094, 4716.811327546894, 4698.436187657486, 4748.928766068511, 4767.04659068186, 4774.236122220445, 4808.519148085198, 4609.285560738057, 4624.537546245382, 4656.4645065817185, 4694.155052090622, 4699.060187962387, 4700.647451441156, 4725.834595789165, 4730.0, 4760.5001474844985, 4775.116603428342, 4660.5339466053465, 4682.461516925529, 4700.4594471635855, 4701.388819453483, 4723.338732577442, 5148.3564554430695, 5227.372715274153, 5272.841814745564, 5275.419703832614, 5315.255864179018, 5603.80386686464, 5691.7723291068305, 5694.6867922264255, 5695.658260504383, 5703.74333155009, 5752.913706294409, 5754.6547207167705, 5757.222774925373, 5759.222504961818, 5789.189513468118, 5335.839924802262, 5341.359036915595, 5345.786168553214, 5346.572274218053, 5352.812651557177, 5716.857078573069, 5799.18811366409, 5815.82552523425, 5848.2689663792025, 5875.872199779686, 5556.416576259516, 5577.1355439906065, 5589.496945274945, 5600.243967064394, 5620.185073164368, 5517.724113794375, 5670.5463562914865, 5677.971610141923, 5687.744051517609, 5694.259746232963, 5508.586855985817, 5612.943870561242, 5652.604317697804, 5655.773769049274, 5656.575756818255, 5599.1041433370465, 5621.0, 5659.858503537363, 5661.66030038199, 5694.829155125353, 4703.717776933395, 4708.976455117771, 4713.505081966413, 4740.502247264057, 4742.668013239109, 4039.4546736190237, 4047.817848196838, 4053.777042262645, 4058.5738497457933, 4095.9180816383505, 4637.744924029211, 4674.275487299474, 4717.481077081518, 4767.809287628456, 4779.904401911942, 5715.228444160069, 5742.454466825645, 5761.279840019997, 5764.971175144097, 5765.077587585966, 4729.290606409066, 4733.573978341897, 4734.4081989751285, 4736.786844592001, 4771.71369717818, 4837.95162048382, 4983.700977941335, 4990.426100998432, 5002.624803139779, 5031.295618613397, 5226.63413561047, 5254.97372513135, 5282.762275697526, 5286.471352864683, 5307.575393968396, 5518.475744804237, 5604.971975140098, 5611.971940140274, 5740.483356497935, 5766.855828604318, 5224.791008359775, 5232.869178270574, 5260.079486089995, 5338.919916201183, 5352.384475785178, 5573.470520300565, 5579.60942734021, 5580.916286255629, 5587.860303492445, 5637.098064309691, 5680.801171958961, 5681.17622944679, 5693.259876216065, 5696.601237913306, 5699.059655156852, 5424.376196737426, 5494.972525137348, 5501.504864562208, 5504.0, 5506.614536982533, 5578.944210557843, 5585.2180694701965, 5585.776568937197, 5591.720413979204, 5612.803551875665, 5452.890942181213, 5491.36849262324, 5501.174823776466, 5509.118541033416, 5509.862253443696, 5458.426865179258, 5513.476219759116, 5618.634788738719, 5624.409437009219, 5679.829605111853, 5364.168553874156, 5381.48875856793, 5445.7549410277425, 5460.590455715757, 5466.617336786387], "value": 5139.091228724626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.6599785112816, 697.7871749116518, 711.6157275071461, 1106.4301884529464, 1116.129419053139, 33466.33067338652, 34140.0, 34220.0, 34238.828805856, 34311.656883431155, 35133.12167195815, 35342.64657353426, 35441.291174176564, 35625.10937226571, 35686.8215658922, 6752.088468056823, 6915.481338899577, 7015.684294206761, 7162.964185179067, 7168.713251469961, 6923.376896079352, 7029.4376449883885, 7031.6484175791265, 7032.156141263055, 7034.0, 6936.306369363074, 6949.687264073129, 6974.930250697479, 7010.053642758214, 7044.929550704479, 6920.134983127109, 6954.895676564855, 6968.198657154441, 6993.82515437113, 7005.964970175142, 6756.729730810811, 6770.898436523406, 6803.2856550062525, 6813.3527314905, 6825.35159159879, 31770.04689859308, 31816.681833181836, 31901.0, 31952.201194970312, 31987.840060799546, 3090.18110200797, 3138.1213260286927, 3138.995521433142, 3139.9372012559847, 3143.387039527293, 24939.0, 24991.375215619573, 25031.62452563195, 25033.12384066549, 25034.123805666713, 3030.8181509109304, 3053.6335639723375, 3055.3736484020724, 3058.9541156882665, 3096.0711786464194, 138050.0, 138768.0, 138914.0, 143649.0, 146685.53314466827, 38800.417993730116, 39020.804895975336, 39026.0, 39075.60924390776, 39116.804415977735, 40326.79836600857, 40371.394429083586, 40391.596084039375, 40416.79791601023, 44445.77777111094, 12418.379081045912, 12451.626451206479, 12479.56321528742, 12496.437660305126, 12532.498700052078, 9754.073363030642, 9755.414675119515, 9767.0, 9770.120689138012, 9774.5601447935, 12779.680507987374, 12812.359382030862, 12846.164999275017, 12915.870841291468, 12980.221186728826, 5327.227552004938, 5367.677939323653, 5372.462753724674, 5469.1249400096585, 5475.808346707846, 869.2741560796806, 908.8954770201511, 911.382296423853, 921.9723408297762, 941.5292353823088, 20466.795332046786, 21301.0, 21451.570968580854, 21554.24560140419, 21955.780442195693, 991.6033586565287, 995.6316163019729, 1019.6635110413546, 1021.9284650074424, 1029.1663752360612, 11127.387993660426, 11229.21395502307, 11459.369734664673, 11506.424678766029, 11539.134564907665, 171212.0, 172442.0, 173102.0, 173352.0, 174098.0, 40267.0, 40475.59524404777, 40488.59511404907, 40511.1897762049, 40514.79742601268, 1221.4991853340266, 1252.542821870029, 1259.6661884600587, 1265.3167289663663, 1265.4495294547085, 19809.801901981373, 19959.700604490652, 20712.0, 21531.677024844328, 21631.0, 30217.69782302237, 36807.44788828116, 37375.0, 37400.62599373971, 37564.24871502609, 160426.0, 161778.0, 162106.0, 162410.0, 162524.18737906707, 29180.854095729384, 29847.850760746056, 30537.389252215275, 30773.538396923617, 31179.844100780258, 35381.46927796137, 35410.0, 35492.29015419729, 36001.459978099825, 36341.27317453689, 26827.329316766456, 27330.453390932467, 27996.760259179624, 28398.0, 28683.13950581486, 27256.182314530597, 27477.17568472949, 27549.862250688617, 27588.724112758617, 29044.12867613975, 30171.396572067995, 30949.0, 31035.84482077575, 31130.53304200484, 31187.688123118478, 26010.479790403708, 26718.0, 26759.30322645109, 27162.185134445997, 27340.453190935674, 20546.0, 22585.0, 22901.88549057244, 22938.0, 22965.770342296364], "value": 14637.107598623175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.72613444454436, 397.90450291929943, 400.0937875711514, 403.7880112940706, 419.84885441241147, 12722.0, 12937.870621293785, 17553.297868085276, 18266.543336416595, 18302.54243643908, 14471.0, 18618.813811861877, 18658.533536661555, 18779.906100469478, 19402.0, 5177.974110129444, 5321.042212401766, 5327.893442131155, 5332.546733527654, 5348.064088784467, 5274.973625131869, 5295.7881684732565, 5353.571714262869, 5387.488188622075, 5399.1091469907415, 5359.035373632744, 5363.115086010804, 5371.731413429333, 5378.46215378461, 5383.784648614051, 5221.2951251580935, 5228.607854410934, 5250.238715386286, 5323.653962492445, 5346.984073026113, 4673.649476289258, 4701.882452938669, 4729.219678753002, 4730.881727956794, 4733.24268117103, 22169.334919952427, 22208.777912220994, 22763.54472910549, 22891.42771430711, 22895.31314060581, 1625.9674806503922, 1637.2386840119282, 1663.7920259967505, 1665.300573759024, 1667.908265045422, 14529.128252304896, 14792.852071479256, 14942.925285373612, 15005.624859378602, 15312.617184570476, 1985.354759703088, 2010.7788143304224, 2046.0894901768718, 2051.548659294953, 2054.969175462369, 87837.0, 90300.09699902983, 90816.0, 91616.0, 97508.0, 10393.792124157475, 10530.10494107994, 10734.838977415346, 10778.784424311627, 10838.783224335626, 14524.782128268085, 14531.92734036323, 14532.782008269673, 14542.85457145415, 14547.3453694584, 7373.77878663641, 7627.571401263653, 7634.580098094658, 7763.456558040883, 7834.138244793068, 7160.355567998905, 7170.282971702893, 7172.138172877793, 7396.778096657109, 7398.815029624195, 6869.278725733826, 6870.797610418157, 6913.92078673585, 6948.5483443576, 7078.858422831515, 1965.2237366240256, 1986.6721990871345, 1995.9301424450075, 2011.0548042420332, 2041.6325061488778, 823.7816978500703, 852.5694524265331, 874.711345256064, 888.5912480259153, 890.9777255568663, 17614.647707045788, 17778.5555361117, 18069.096545172688, 18078.63842723138, 18382.264709411742, 864.3387808326635, 888.8000199955088, 891.9286457083417, 895.4806212396925, 912.8448163812168, 9484.910595089847, 9638.325317227867, 9913.603455861685, 9957.452340121217, 10031.147352474976, 360002.0, 363135.0, 365165.0, 392335.0, 400891.0, 74842.0, 78715.0, 78734.60632696915, 79236.20763792288, 82463.0, 1038.963636272742, 1051.7686109055996, 1097.846301517788, 1103.2112039891515, 1104.5140138339104, 15138.545843624708, 18502.629947400706, 19087.713684294467, 19115.330963416214, 19440.0, 39340.60659393369, 39429.0, 39775.60224397719, 40236.1952760949, 40411.7979410101, 46718.53281467278, 46755.29867052065, 47299.29051064168, 47372.2894156581, 48844.511554885416, 7853.764387068397, 7863.606819658879, 7908.604569771604, 7970.880436793337, 8022.358211343195, 12207.75584488323, 12360.814587781011, 12387.504499819906, 12604.87395126037, 12686.873131268569, 9750.0, 10313.381197128196, 10362.481875906024, 10479.318844275098, 11028.834567481334, 9415.199708024895, 9777.120059194707, 9965.202783777135, 10143.442110683687, 10203.795924081625, 10088.293819432569, 10535.367877927349, 10717.249792514449, 11172.888271117185, 11599.014083802635, 7826.178251283533, 7829.099653539688, 7997.8400431992195, 8350.916490835014, 8490.490570565786, 11276.605318813803, 11383.658490245305, 11481.712957176138, 11826.704332391415, 11898.464569094585], "value": 8755.507607810223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.89205917497, 1323.4706117552978, 1330.1819381080638, 1331.3809078778372, 1355.5052405871854, 9792.559334829932, 10050.698479045623, 10228.641997530089, 10241.795164096722, 10289.0, 9654.0, 9767.2186225102, 9772.120509154174, 9815.0, 9826.508674566261, 2040.7142999980015, 2077.5740973100555, 2079.906404211814, 2080.490279881431, 2080.500679836836, 1969.4780883065998, 2020.1313435222849, 2023.8178563929243, 2026.63520566298, 2027.2499175305084, 1967.4687834284734, 1996.291316582614, 2002.4192984034612, 2009.25657506722, 2017.6469117904383, 1937.9903100484548, 1948.9902550487227, 1952.3362056900721, 1956.5108722819296, 1961.117497126299, 1636.443609172887, 1699.745038244261, 1867.6544839204792, 1889.6409682160345, 1900.6483800496815, 9772.90227097727, 10035.899641003643, 10036.247281453847, 10037.799244015152, 10051.849222261671, 5081.390233172006, 5290.523852853224, 5291.682499050069, 5292.655977361459, 5296.046711591912, 2951.144168191222, 3071.800332978349, 3118.7193152616373, 3123.063081075691, 3131.906042818719, 1000.2947921715173, 1003.5584342889106, 1023.0945613132432, 1037.2324479884905, 1047.2983101322131, 14688.0, 14777.704445911022, 14811.111333320036, 14853.0, 14865.580916389183, 4480.820767169277, 4492.73043617384, 4582.518835522289, 4625.7455839929125, 4626.514216007338, 10998.835017474745, 10999.065079468175, 11011.559537618567, 11025.724356891142, 11026.834597481044, 5140.640155189101, 5322.707251101227, 5339.81310654133, 5344.518993290545, 5351.224072509543, 4890.682105663121, 4955.4796746341835, 4957.454679985199, 4965.503449655005, 4998.350214472095, 3682.0, 3722.3113723961155, 3770.9057273567832, 3811.6950643948417, 3847.0574709196426, 1019.658414431159, 1024.0783295034528, 1030.3251370352432, 1036.6164519127972, 1039.0233180810164, 711.3420086420041, 728.3335747790712, 735.1398863329916, 742.8699977503916, 748.8914107454389, 5275.551578115903, 5312.707801070901, 5383.380911195184, 5456.372517160498, 5466.699331536804, 494.1081348166522, 517.4980269138929, 517.5833454069435, 517.8265281130788, 517.9119549676564, 3484.285721427101, 3531.805750683686, 3628.310620982005, 3839.9232015359535, 3902.473166122537, 11895.0, 12550.87449125497, 13093.541726039542, 13101.475940962255, 13106.868931310755, 11492.54029838797, 12060.517579296906, 12647.810282845765, 12649.241045537297, 12667.11330206895, 7227.566346019151, 7263.818404539928, 7358.1538123116525, 7403.259674032553, 7419.035525381666, 5655.377908429987, 5669.376368599368, 5679.432056794452, 5743.6840973745175, 5854.502367298827, 11203.887961120285, 11523.308601483937, 11531.1351648625, 11678.357690326773, 11716.589919352782, 11841.28952262867, 11895.226810257305, 12017.0, 12070.732573080051, 12077.69805754828, 7436.702531898663, 7551.546907185587, 7551.811204719926, 7565.470417070752, 7570.356519695888, 8964.820703585761, 9147.176754092163, 9148.222401095982, 9206.815863682823, 9248.0, 7948.40386970991, 7999.240072193133, 8042.115367309474, 8109.878351824846, 8206.179382061746, 7545.471816972759, 7548.962255188689, 7583.9620801895635, 7719.459637825523, 7803.570803605856, 7060.71757129709, 7062.858742825218, 7140.250273721393, 7148.0, 7150.141982962078, 4902.485239049848, 4969.527894849984, 4969.900601988013, 5110.207917772751, 5175.560077393464, 5001.199808030843, 5006.4743201963265, 5134.383873935151, 5175.715335656424, 5218.217267409919], "value": 4467.044374306776, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.56174447078945, 339.57383483727926, 344.1963016356807, 348.74367340005074, 348.7576134586462, 5321.52106310432, 5465.562754979602, 5506.834794956153, 5518.751656175472, 5573.665580065199, 5275.419703832576, 5345.930813837238, 5353.544948679357, 5364.0, 5369.550221440209, 4048.6153815387565, 4048.817803198848, 4049.1699201663587, 4051.979740101295, 4056.4320995060716, 3888.9222215555674, 4053.655439287664, 4064.3700226464944, 4067.28822456069, 4078.4290199371962, 4031.5565287818317, 4035.57626449223, 4036.475258216428, 4037.2732908076537, 4051.331530297512, 4004.2592120457516, 4008.9599104009026, 4013.678905687538, 4017.4777278953693, 4017.879463616096, 3498.912527186815, 3506.5090887275546, 3514.7012503937194, 3519.0674471265133, 3520.419130843408, 5234.659747116425, 5268.420473747885, 5291.3121294231505, 5309.840704778863, 5325.733713314357, 4706.270528068155, 4717.787699553528, 4718.8584342469785, 4720.716756994591, 4726.692764970266, 5553.694881702797, 5664.535926871783, 5676.801311954062, 5677.517411020068, 5705.229793977802, 3890.3077161434867, 3915.706322025831, 3916.725829191958, 3922.627350401707, 3927.6661483773914, 5658.292713410824, 5871.706414679249, 5965.612235204698, 6003.849903752441, 6004.96997515014, 3848.942265866014, 3923.6664883485223, 3927.2930872443235, 3929.7642141471033, 3941.7043721720984, 3988.3219852625125, 3998.4402183694306, 4000.2799496090984, 4002.939221106409, 4003.399490076512, 4543.931841022388, 4662.883427914329, 4671.579557839811, 4672.462666793294, 4673.929891051637, 5674.687892165971, 5677.914831277534, 5687.516561092353, 5703.486686198262, 5726.828195154152, 1374.7387996280675, 1375.7523645743663, 1376.8210132682686, 1381.3921874375242, 1392.6448755567264, 865.2731705367521, 902.3548163063441, 909.2680392284143, 910.4082346474844, 912.1516989199976, 4849.733264670477, 4857.684250523705, 4873.9025219496125, 4881.096997055556, 4893.119238537098, 5850.385709500441, 5857.414258574108, 5861.970690146607, 5897.528197744256, 5905.173275741399, 4775.21209000518, 4792.233242681224, 4809.302651115569, 4830.8309209178215, 4838.225883858566, 3083.429565530384, 3101.6122984626923, 3103.239706271978, 3104.7516198704047, 3112.37752449511, 5481.369642491165, 5483.532410415329, 5485.698286594195, 5498.835034948958, 5506.972465137648, 5871.3541510433815, 6010.579259451883, 6028.3971602839365, 6066.1204125402455, 6081.0, 5472.288602481652, 5475.370332411823, 5492.450754924475, 5494.36814766307, 5496.5053145216325, 5703.5722320826935, 5758.870151354321, 5800.59395842287, 5881.529477641864, 5903.350631430453, 5739.2252045973255, 5764.481196692318, 5767.567432442667, 5791.189233507396, 5798.10129429939, 5220.791168353223, 5245.449227831023, 5372.824006277464, 5430.67415955044, 5433.918491222714, 3870.109874728772, 3907.2185562886966, 3909.8045097745567, 3911.2959667260166, 3931.545328228574, 5873.530117590668, 5893.528517718658, 5919.881602367843, 5922.564912350912, 5946.256717910262, 5563.276774019351, 5688.7440065198, 5707.946248756895, 5738.916748246872, 5773.653580785166, 5708.172315014217, 5719.199312096227, 5760.810891861066, 5769.855753606025, 5781.768729250783, 5556.527695145958, 5643.407442218508, 5664.660120392789, 5669.590424069836, 5673.319201695823, 5692.893629357164, 5768.53851691872, 5779.2775903012125, 5789.623674461147, 5790.884182316414, 5573.052581061148, 5605.383407825055, 5614.382417934105, 5615.213870058276, 5624.156376543551], "value": 4209.7166255342245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.9799306020819, 689.5242282824848, 691.3432239372594, 733.6331834082958, 750.6359415683389, 12006.399680015986, 12395.318257495834, 13062.412191451383, 13624.795628065574, 13643.795343069862, 14662.63343416415, 15188.544343669708, 15268.84731152688, 15313.387464501406, 15345.69308613827, 878.8505953987806, 893.0266010049045, 898.3127907151035, 898.9865152022725, 900.9729708108767, 831.7213733399318, 909.5588639509832, 913.8492148795441, 916.6562539047857, 918.8805455290803, 957.9760505987372, 970.3013830042394, 970.6360114956891, 970.6554173268494, 971.6939164163266, 966.2173639352147, 966.6809952715587, 967.3470407474962, 968.2254196642658, 970.5001924009141, 719.5287086957999, 720.0, 720.0711082703307, 721.4444877444339, 721.4841388407314, 14146.85853141476, 14337.56987290383, 14455.494057708034, 14472.71054578913, 14549.199794011325, 15939.760903586455, 16209.189540522926, 16287.104209268486, 16363.509094727176, 16368.918155409267, 12469.937650311691, 12591.622251332476, 12899.871001289961, 12993.220406775623, 13010.479580816756, 3031.8787248510034, 3032.4996375598, 3036.3775426037832, 3037.665856755755, 3040.665526792051, 72173.0, 72487.0, 74053.62973185099, 74307.88538171985, 74425.62787186084, 12084.335361555199, 12564.560240391726, 12626.053046021585, 12871.163374380636, 12871.356432178354, 23205.187818426275, 24056.0, 24166.39584010414, 24432.267031989068, 24501.01995920179, 6208.037754148114, 6213.720382582795, 6214.316425193225, 6234.719437625317, 6280.434760871543, 2962.481565725989, 3098.8760449581764, 3141.0890841655664, 3161.668024857403, 3173.174974506645, 3503.3518799021754, 4322.070754787673, 4521.638268938477, 4525.683202175882, 4535.070310586322, 754.4153281207108, 766.3332900376597, 780.282140430805, 782.2451334462271, 783.4829012851491, 566.2610293566935, 578.7655999320282, 593.5489028338494, 597.748945442915, 607.0742118269586, 10005.0, 10549.789004219872, 10606.363618182933, 10669.679909602724, 10758.246922715334, 562.7720773086907, 572.0389745228057, 573.8307199376194, 578.5718568259458, 591.7307625030601, 4424.469063712375, 5080.110980578384, 5327.760250788646, 5556.861078473071, 5694.686792226385, 86494.0, 89515.0, 90383.54808225916, 90844.09155908489, 91144.0, 72869.63565182246, 75986.62006689931, 76260.23739762642, 76813.0, 77285.61357193178, 64914.0, 65297.347026529125, 67343.66328168327, 67743.3225667737, 68078.3192168072, 10228.721409823773, 11017.724556885822, 11063.72340691489, 11110.666679999613, 11127.054200393057, 26973.595396069468, 27014.1895743128, 27362.72637273602, 28235.0, 28453.288667783472, 49751.502484974684, 49971.000579988926, 50783.0, 52270.477295228084, 52965.0, 14140.222287774272, 14157.787633185304, 14566.41734330615, 14567.92716036413, 14699.92650036743, 15263.465778698137, 15398.076115432661, 15600.0, 15644.452444164855, 15880.682386352439, 13073.084884058024, 13818.792718109034, 13966.092204006707, 14016.29918504091, 14241.430342786587, 13835.446582137005, 13972.720545589234, 14685.48600798967, 14771.03988240761, 14973.251337433303, 12651.810222846849, 12722.809157862825, 12754.681132971378, 14928.10431374121, 15517.612059698598, 9311.627534898798, 9560.61757529691, 9694.17599504022, 9872.11150996385, 9890.109890109925, 11794.882051179722, 12223.633291001284, 12248.693782655504, 12396.318202498589, 12551.184173029089], "value": 7248.371443260774, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 111.0, 113.0, 112.0, 112.0, 111.0, 115.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 123.0, 126.0, 171.0, 133.0, 129.0, 126.0, 129.0, 149.0, 125.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 165.0, 167.0, 169.0, 169.0, 165.0, 164.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 106.0, 76.0, 74.0, 74.0, 74.0, 96.0, 76.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 98.0, 84.0, 84.0, 84.0, 97.0, 83.0, 85.0, 107.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 115.0, 113.0, 114.0, 113.0, 115.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 54.0, 56.0, 56.0, 56.0, 56.0, 56.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 86.0, 87.0, 87.0, 95.0, 86.0, 89.0, 132.0, 86.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 136.0, 140.0, 137.0, 136.0, 141.0, 131.0, 135.0, 147.0, 139.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 193.0, 200.0, 195.0, 194.0, 193.0, 184.0, 198.0, 199.0, 185.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 75.0, 75.0, 77.0, 75.0, 72.0, 86.0, 69.0], "value": 75.2, "unit": "score"}]}]} 09:09:17 INFO - Return code: 0 09:09:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:17 INFO - # TBPL SUCCESS # 09:09:17 INFO - Running post-action listener: _resource_record_post_action 09:09:17 INFO - [mozharness: 2017-05-30 16:09:17.877145Z] Finished run-tests step (success) 09:09:17 INFO - Running post-run listener: _resource_record_post_run 09:09:17 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8192; Write bytes: 401293312; Read time: 88; Write time: 269192 09:09:17 INFO - TinderboxPrint: CPU usage
12.7% 09:09:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 88 09:09:17 INFO - TinderboxPrint: I/O write bytes / time
401,293,312 / 269,192 09:09:17 INFO - TinderboxPrint: CPU idle
8,754.9 (87.3%) 09:09:17 INFO - TinderboxPrint: CPU user
1,216.8 (12.1%) 09:09:17 INFO - TinderboxPrint: Swap in / out
0 / 0 09:09:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93622272; Read time: 0; Write time: 110244 09:09:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:09:17 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 8192; Write bytes: 307671040; Read time: 88; Write time: 158948 09:09:18 INFO - Running post-run listener: _upload_blobber_files 09:09:18 INFO - Blob upload gear active. 09:09:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:18 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 09:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:09:18 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:19 INFO - (blobuploader) - INFO - Done attempting. 09:09:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:09:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:09:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:20 INFO - (blobuploader) - INFO - Done attempting. 09:09:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:09:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:09:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:21 INFO - (blobuploader) - INFO - Done attempting. 09:09:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:24 INFO - (blobuploader) - INFO - Done attempting. 09:09:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:24 INFO - Return code: 0 09:09:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/536d44d4c7ac8e18e2730560608dbc9232cbeba11e4868a3c7662176caf265bdca202f27c6788bc1bc9e8345d80d1c24f91f86fd8ea236e706b422eacc0d6228", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1020cde0ee7569d6c94a65bcf5ab80b5e651d8e5dcb0ba10c9e4b67bf7ff43de2d5180ec5e7674168436bd73d76b0c82d3a80931b3c35cc59b78d78e0026e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca6c848b9728ee88186701f6d8e704cae26e28791a771bb59c8b7295be5fa0fe42f2d1b6026965fe75452ad1953c3146af13f7a927708987c4b3c796e4d1c0a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/037ad30de19b664583f6353105a0db6982e6358edb663c803264f35ac7e18506c42d623029623792f20918acb4b70652025014070f3b6c498c72244cf3693ab6"} 09:09:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:24 INFO - Contents: 09:09:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/536d44d4c7ac8e18e2730560608dbc9232cbeba11e4868a3c7662176caf265bdca202f27c6788bc1bc9e8345d80d1c24f91f86fd8ea236e706b422eacc0d6228", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1020cde0ee7569d6c94a65bcf5ab80b5e651d8e5dcb0ba10c9e4b67bf7ff43de2d5180ec5e7674168436bd73d76b0c82d3a80931b3c35cc59b78d78e0026e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca6c848b9728ee88186701f6d8e704cae26e28791a771bb59c8b7295be5fa0fe42f2d1b6026965fe75452ad1953c3146af13f7a927708987c4b3c796e4d1c0a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/037ad30de19b664583f6353105a0db6982e6358edb663c803264f35ac7e18506c42d623029623792f20918acb4b70652025014070f3b6c498c72244cf3693ab6"} 09:09:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:24 INFO - Copying logs to upload dir... 09:09:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.938537 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-30 09:09:23.413385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 09:09:23.416526) ========= 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=1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505 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-Non-PGO/sha512/536d44d4c7ac8e18e2730560608dbc9232cbeba11e4868a3c7662176caf265bdca202f27c6788bc1bc9e8345d80d1c24f91f86fd8ea236e706b422eacc0d6228", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1020cde0ee7569d6c94a65bcf5ab80b5e651d8e5dcb0ba10c9e4b67bf7ff43de2d5180ec5e7674168436bd73d76b0c82d3a80931b3c35cc59b78d78e0026e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca6c848b9728ee88186701f6d8e704cae26e28791a771bb59c8b7295be5fa0fe42f2d1b6026965fe75452ad1953c3146af13f7a927708987c4b3c796e4d1c0a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/037ad30de19b664583f6353105a0db6982e6358edb663c803264f35ac7e18506c42d623029623792f20918acb4b70652025014070f3b6c498c72244cf3693ab6"} build_url:https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/QIapUNOFQBWTgPkMtPOhsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/536d44d4c7ac8e18e2730560608dbc9232cbeba11e4868a3c7662176caf265bdca202f27c6788bc1bc9e8345d80d1c24f91f86fd8ea236e706b422eacc0d6228", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d1020cde0ee7569d6c94a65bcf5ab80b5e651d8e5dcb0ba10c9e4b67bf7ff43de2d5180ec5e7674168436bd73d76b0c82d3a80931b3c35cc59b78d78e0026e68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ca6c848b9728ee88186701f6d8e704cae26e28791a771bb59c8b7295be5fa0fe42f2d1b6026965fe75452ad1953c3146af13f7a927708987c4b3c796e4d1c0a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/037ad30de19b664583f6353105a0db6982e6358edb663c803264f35ac7e18506c42d623029623792f20918acb4b70652025014070f3b6c498c72244cf3693ab6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 09:09:23.440621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:09:23.440969) ========= 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=1258088b6da462a47ba2cd90000001a2-1496157846.818584-450258505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:09:23.523870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 09:09:23.524190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 09:09:23.524477) ========= ========= Total master_lag: 0.64 =========