builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1496137435.39 results: success (0) revision: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.386584) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.387148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.387440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.424680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.425111) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 02:43:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-05-30 02:43:56 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.555971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.559331) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020577 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.611337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:55.611693) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 --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 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 --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=9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 02:43:56,205 truncating revision to first 12 chars 2017-05-30 02:43:56,205 Setting DEBUG logging. 2017-05-30 02:43:56,205 attempt 1/10 2017-05-30 02:43:56,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c712d76d598?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 02:43:56,715 unpacking tar archive at: mozilla-central-0c712d76d598/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:56.424157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:56.427510) ========= script_repo_revision: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:56.427883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:56.428148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 02:43:56.436796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-30 02:43:56.437107) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:43:57 INFO - MultiFileLogger online at 20170530 02:43:57 in /builds/slave/test 02:43:57 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 02:43:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:43:57 INFO - {'append_to_log': False, 02:43:57 INFO - 'base_work_dir': '/builds/slave/test', 02:43:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:43:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:43:57 INFO - 'branch': 'Firefox-Non-PGO', 02:43:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:43:57 INFO - 'config_files': ('talos/linux_config.py',), 02:43:57 INFO - 'default_actions': ('clobber', 02:43:57 INFO - 'read-buildbot-config', 02:43:57 INFO - 'download-and-extract', 02:43:57 INFO - 'populate-webroot', 02:43:57 INFO - 'create-virtualenv', 02:43:57 INFO - 'install', 02:43:57 INFO - 'setup-mitmproxy', 02:43:57 INFO - 'run-tests'), 02:43:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:43:57 INFO - 'download_minidump_stackwalk': True, 02:43:57 INFO - 'download_symbols': 'ondemand', 02:43:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:43:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:43:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:43:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:43:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:43:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:43:57 INFO - 'gecko_profile': False, 02:43:57 INFO - 'gecko_profile_interval': 0, 02:43:57 INFO - 'installer_path': 'installer.exe', 02:43:57 INFO - 'log_level': 'info', 02:43:57 INFO - 'log_name': 'talos', 02:43:57 INFO - 'log_to_console': True, 02:43:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:43:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:43:57 INFO - 'opt_config_files': (), 02:43:57 INFO - 'pip_index': False, 02:43:57 INFO - 'suite': 'dromaeojs-e10s', 02:43:57 INFO - 'system_bits': '32', 02:43:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:43:57 INFO - 'title': 'talos-linux64-ix-013', 02:43:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:43:57 INFO - 'use_talos_json': True, 02:43:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:43:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:43:57 INFO - 'work_dir': 'build'} 02:43:57 INFO - [mozharness: 2017-05-30 09:43:57.133686Z] Running clobber step. 02:43:57 INFO - Running pre-action listener: _resource_record_pre_action 02:43:57 INFO - Running main action method: clobber 02:43:57 INFO - rmtree: /builds/slave/test/build 02:43:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:43:58 INFO - Running post-action listener: _resource_record_post_action 02:43:58 INFO - [mozharness: 2017-05-30 09:43:58.682876Z] Finished clobber step (success) 02:43:58 INFO - [mozharness: 2017-05-30 09:43:58.682976Z] Running read-buildbot-config step. 02:43:58 INFO - Running pre-action listener: _resource_record_pre_action 02:43:58 INFO - Running main action method: read_buildbot_config 02:43:58 INFO - Using buildbot properties: 02:43:58 INFO - { 02:43:58 INFO - "project": "", 02:43:58 INFO - "product": "firefox", 02:43:58 INFO - "who": "cbook@mozilla.com", 02:43:58 INFO - "installer_path": "public/build/target.tar.bz2", 02:43:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:43:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:43:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:43:58 INFO - "stage_platform": "linux64", 02:43:58 INFO - "basedir": "/builds/slave/test", 02:43:58 INFO - "buildnumber": 865, 02:43:58 INFO - "platform": "ubuntu64_hw", 02:43:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:43:58 INFO - "slavebuilddir": "test", 02:43:58 INFO - "taskId": "FdJHqxVSTRKKUPtjV9TU_w", 02:43:58 INFO - "branch": "mozilla-central", 02:43:58 INFO - "script_repo_revision": "production", 02:43:58 INFO - "revision": "0c712d76d598ec92a7adaaf7180fd4e559f9abc0", 02:43:58 INFO - "slavename": "talos-linux64-ix-013", 02:43:58 INFO - "repo_path": "mozilla-central" 02:43:58 INFO - } 02:43:58 INFO - Finding installer, test and symbols from parent task. 02:43:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdJHqxVSTRKKUPtjV9TU_w'}, attempt #1 02:43:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdJHqxVSTRKKUPtjV9TU_w'}, attempt #1 02:43:59 INFO - Task dependencies: ADFZpUVvR8-bvoHJrZ3rFg 02:43:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg'}, attempt #1 02:44:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2 02:44:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/test_packages.json 02:44:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.crashreporter-symbols.zip 02:44:00 INFO - Running post-action listener: _resource_record_post_action 02:44:00 INFO - [mozharness: 2017-05-30 09:44:00.019990Z] Finished read-buildbot-config step (success) 02:44:00 INFO - [mozharness: 2017-05-30 09:44:00.020211Z] Running download-and-extract step. 02:44:00 INFO - Running pre-action listener: _resource_record_pre_action 02:44:00 INFO - Running main action method: download_and_extract 02:44:00 INFO - mkdir: /builds/slave/test/build/tests 02:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:00 INFO - trying https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.test_packages.json 02:44:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:44:00 INFO - Downloaded 986 bytes. 02:44:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:44:00 INFO - Using the following test package requirements: 02:44:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:44:00 INFO - u'common': [u'target.common.tests.zip'], 02:44:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:44:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:44:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:44:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:44:00 INFO - u'mozbase': [u'target.common.tests.zip'], 02:44:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:44:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:44:00 INFO - u'web-platform': [u'target.common.tests.zip', 02:44:00 INFO - u'target.web-platform.tests.zip'], 02:44:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:44:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:44:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.common.tests.zip 02:44:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.common.tests.zip into memory 02:44:02 INFO - Content-Length response header: 63528403 02:44:02 INFO - Bytes received: 63528403 02:44:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:44:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.common.tests.zip 02:44:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.common.tests.zip into memory 02:44:14 INFO - Content-Length response header: 63528403 02:44:14 INFO - Bytes received: 63528403 02:44:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.talos.tests.zip 02:44:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:44:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.talos.tests.zip into memory 02:44:27 INFO - Content-Length response header: 14447425 02:44:27 INFO - Bytes received: 14447425 02:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:27 INFO - trying https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2 02:44:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:44:28 INFO - Downloaded 54262065 bytes. 02:44:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2 02:44:28 INFO - mkdir: /builds/slave/test/properties 02:44:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:28 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:28 INFO - Contents: 02:44:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2 02:44:28 INFO - Running post-action listener: _resource_record_post_action 02:44:28 INFO - Running post-action listener: set_extra_try_arguments 02:44:28 INFO - [mozharness: 2017-05-30 09:44:28.440120Z] Finished download-and-extract step (success) 02:44:28 INFO - [mozharness: 2017-05-30 09:44:28.440218Z] Running populate-webroot step. 02:44:28 INFO - Running pre-action listener: _resource_record_pre_action 02:44:28 INFO - Running main action method: populate_webroot 02:44:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:28 INFO - '--tppagecycles', 02:44:28 INFO - '7'], 02:44:28 INFO - 'tests': ['tsvgm']}}, 02:44:28 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['damp', 'tps']}, 02:44:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'tests': ['damp', 'tps']}, 02:44:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['dromaeo_dom']}, 02:44:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:44:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:44:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:44:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['a11yr', 02:44:28 INFO - 'ts_paint', 02:44:28 INFO - 'tpaint', 02:44:28 INFO - 'sessionrestore', 02:44:28 INFO - 'sessionrestore_no_auto_restore', 02:44:28 INFO - 'tabpaint']}, 02:44:28 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:28 INFO - 'ts_paint', 02:44:28 INFO - 'tpaint', 02:44:28 INFO - 'sessionrestore', 02:44:28 INFO - 'sessionrestore_no_auto_restore', 02:44:28 INFO - 'tabpaint']}, 02:44:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:44:28 INFO - 'ts_paint', 02:44:28 INFO - 'tpaint', 02:44:28 INFO - 'sessionrestore', 02:44:28 INFO - 'sessionrestore_no_auto_restore', 02:44:28 INFO - 'tabpaint']}, 02:44:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:44:28 INFO - 'ts_paint', 02:44:28 INFO - 'tpaint', 02:44:28 INFO - 'sessionrestore', 02:44:28 INFO - 'sessionrestore_no_auto_restore', 02:44:28 INFO - 'tabpaint']}, 02:44:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['a11yr', 02:44:28 INFO - 'ts_paint', 02:44:28 INFO - 'tpaint', 02:44:28 INFO - 'sessionrestore', 02:44:28 INFO - 'sessionrestore_no_auto_restore', 02:44:28 INFO - 'tabpaint']}, 02:44:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['a11yr', 02:44:28 INFO - 'ts_paint', 02:44:28 INFO - 'tpaint', 02:44:28 INFO - 'sessionrestore', 02:44:28 INFO - 'sessionrestore_no_auto_restore', 02:44:28 INFO - 'tabpaint']}, 02:44:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:44:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:44:28 INFO - 'bloom_basic_ref']}, 02:44:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:44:28 INFO - 'talos_options': ['--mitmproxy', 02:44:28 INFO - 'mitmproxy-recording-1.mp', 02:44:28 INFO - '--firstNonBlankPaint'], 02:44:28 INFO - 'tests': ['Quantum_1']}, 02:44:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['tsvgx', 02:44:28 INFO - 'tsvgr_opacity', 02:44:28 INFO - 'tart', 02:44:28 INFO - 'tscrollx', 02:44:28 INFO - 'cart', 02:44:28 INFO - 'tsvg_static']}, 02:44:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:28 INFO - 'tsvgr_opacity', 02:44:28 INFO - 'tart', 02:44:28 INFO - 'tscrollx', 02:44:28 INFO - 'cart', 02:44:28 INFO - 'tsvg_static']}, 02:44:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'talos_options': ['--disable-e10s'], 02:44:28 INFO - 'tests': ['tp5o']}, 02:44:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:44:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'talos_options': ['--disable-e10s', 02:44:28 INFO - '--xperf_path', 02:44:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:28 INFO - 'tests': ['tp5n']}, 02:44:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:44:28 INFO - 'talos_options': ['--xperf_path', 02:44:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:28 INFO - 'tests': ['tp5n']}}, 02:44:28 INFO - 'talos.zip': {'path': '', 02:44:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:28 INFO - Running post-action listener: _resource_record_post_action 02:44:28 INFO - [mozharness: 2017-05-30 09:44:28.454588Z] Finished populate-webroot step (success) 02:44:28 INFO - [mozharness: 2017-05-30 09:44:28.454682Z] Running create-virtualenv step. 02:44:28 INFO - Running pre-action listener: _resource_record_pre_action 02:44:28 INFO - Running main action method: create_virtualenv 02:44:28 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:44:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:28 INFO - Using real prefix '/usr' 02:44:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:29 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:31 INFO - Installing pip.................done. 02:44:31 INFO - Return code: 0 02:44:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:44:31 INFO - Reading from file tmpfile_stdout 02:44:31 INFO - Output received: 02:44:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:44:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:31 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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:44:31 INFO - Using env: {'DISPLAY': ':0', 02:44:31 INFO - 'HOME': '/home/cltbld', 02:44:31 INFO - 'LANG': 'en_US.UTF-8', 02:44:31 INFO - 'LANGUAGE': 'en_US:en', 02:44:31 INFO - 'LOGNAME': 'cltbld', 02:44:31 INFO - 'MAIL': '/var/mail/cltbld', 02:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:31 INFO - 'MOZ_NO_REMOTE': '1', 02:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:31 INFO - 'NO_EM_RESTART': '1', 02:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:31 INFO - 'PWD': '/builds/slave/test', 02:44:31 INFO - 'SHELL': '/bin/bash', 02:44:31 INFO - 'SHLVL': '1', 02:44:31 INFO - 'TERM': 'linux', 02:44:31 INFO - 'TMOUT': '86400', 02:44:31 INFO - 'USER': 'cltbld', 02:44:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:31 INFO - '_': '/tools/buildbot/bin/python'} 02:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:44:31 INFO - Cleaning up... 02:44:31 INFO - Return code: 0 02:44:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:31 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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:44:31 INFO - Using env: {'DISPLAY': ':0', 02:44:31 INFO - 'HOME': '/home/cltbld', 02:44:31 INFO - 'LANG': 'en_US.UTF-8', 02:44:31 INFO - 'LANGUAGE': 'en_US:en', 02:44:31 INFO - 'LOGNAME': 'cltbld', 02:44:31 INFO - 'MAIL': '/var/mail/cltbld', 02:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:31 INFO - 'MOZ_NO_REMOTE': '1', 02:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:31 INFO - 'NO_EM_RESTART': '1', 02:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:31 INFO - 'PWD': '/builds/slave/test', 02:44:31 INFO - 'SHELL': '/bin/bash', 02:44:31 INFO - 'SHLVL': '1', 02:44:31 INFO - 'TERM': 'linux', 02:44:31 INFO - 'TMOUT': '86400', 02:44:31 INFO - 'USER': 'cltbld', 02:44:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:31 INFO - '_': '/tools/buildbot/bin/python'} 02:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:31 INFO - Downloading/unpacking psutil>=3.1.1 02:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:32 INFO - Installing collected packages: psutil 02:44:32 INFO - Running setup.py install for psutil 02:44:33 INFO - building 'psutil._psutil_linux' extension 02:44:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:44:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:44:33 INFO - building 'psutil._psutil_posix' extension 02:44:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:44:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:44:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:33 INFO - Successfully installed psutil 02:44:33 INFO - Cleaning up... 02:44:33 INFO - Return code: 0 02:44:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:44:33 INFO - Using env: {'DISPLAY': ':0', 02:44:33 INFO - 'HOME': '/home/cltbld', 02:44:33 INFO - 'LANG': 'en_US.UTF-8', 02:44:33 INFO - 'LANGUAGE': 'en_US:en', 02:44:33 INFO - 'LOGNAME': 'cltbld', 02:44:33 INFO - 'MAIL': '/var/mail/cltbld', 02:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:33 INFO - 'MOZ_NO_REMOTE': '1', 02:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:33 INFO - 'NO_EM_RESTART': '1', 02:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:33 INFO - 'PWD': '/builds/slave/test', 02:44:33 INFO - 'SHELL': '/bin/bash', 02:44:33 INFO - 'SHLVL': '1', 02:44:33 INFO - 'TERM': 'linux', 02:44:33 INFO - 'TMOUT': '86400', 02:44:33 INFO - 'USER': 'cltbld', 02:44:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:33 INFO - '_': '/tools/buildbot/bin/python'} 02:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:44:34 INFO - Installing collected packages: mozsystemmonitor 02:44:34 INFO - Running setup.py install for mozsystemmonitor 02:44:34 INFO - Successfully installed mozsystemmonitor 02:44:34 INFO - Cleaning up... 02:44:34 INFO - Return code: 0 02:44:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:44:34 INFO - Using env: {'DISPLAY': ':0', 02:44:34 INFO - 'HOME': '/home/cltbld', 02:44:34 INFO - 'LANG': 'en_US.UTF-8', 02:44:34 INFO - 'LANGUAGE': 'en_US:en', 02:44:34 INFO - 'LOGNAME': 'cltbld', 02:44:34 INFO - 'MAIL': '/var/mail/cltbld', 02:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:34 INFO - 'MOZ_NO_REMOTE': '1', 02:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:34 INFO - 'NO_EM_RESTART': '1', 02:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:34 INFO - 'PWD': '/builds/slave/test', 02:44:34 INFO - 'SHELL': '/bin/bash', 02:44:34 INFO - 'SHLVL': '1', 02:44:34 INFO - 'TERM': 'linux', 02:44:34 INFO - 'TMOUT': '86400', 02:44:34 INFO - 'USER': 'cltbld', 02:44:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:34 INFO - '_': '/tools/buildbot/bin/python'} 02:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:44:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:44:36 INFO - warning: no files found matching '*.txt' 02:44:36 INFO - no previously-included directories found matching 'build' 02:44:36 INFO - no previously-included directories found matching 'dist' 02:44:36 INFO - no previously-included directories found matching '.git*' 02:44:36 INFO - Installing collected packages: jsonschema, functools32 02:44:36 INFO - Running setup.py install for functools32 02:44:36 INFO - warning: no files found matching '*.txt' 02:44:36 INFO - no previously-included directories found matching 'build' 02:44:36 INFO - no previously-included directories found matching 'dist' 02:44:36 INFO - no previously-included directories found matching '.git*' 02:44:36 INFO - Successfully installed jsonschema functools32 02:44:36 INFO - Cleaning up... 02:44:36 INFO - Return code: 0 02:44:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:44:36 INFO - Using env: {'DISPLAY': ':0', 02:44:36 INFO - 'HOME': '/home/cltbld', 02:44:36 INFO - 'LANG': 'en_US.UTF-8', 02:44:36 INFO - 'LANGUAGE': 'en_US:en', 02:44:36 INFO - 'LOGNAME': 'cltbld', 02:44:36 INFO - 'MAIL': '/var/mail/cltbld', 02:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:36 INFO - 'MOZ_NO_REMOTE': '1', 02:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:36 INFO - 'NO_EM_RESTART': '1', 02:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:36 INFO - 'PWD': '/builds/slave/test', 02:44:36 INFO - 'SHELL': '/bin/bash', 02:44:36 INFO - 'SHLVL': '1', 02:44:36 INFO - 'TERM': 'linux', 02:44:36 INFO - 'TMOUT': '86400', 02:44:36 INFO - 'USER': 'cltbld', 02:44:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:36 INFO - '_': '/tools/buildbot/bin/python'} 02:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:44:36 INFO - Cleaning up... 02:44:36 INFO - Return code: 0 02:44:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:44:36 INFO - Using env: {'DISPLAY': ':0', 02:44:36 INFO - 'HOME': '/home/cltbld', 02:44:36 INFO - 'LANG': 'en_US.UTF-8', 02:44:36 INFO - 'LANGUAGE': 'en_US:en', 02:44:36 INFO - 'LOGNAME': 'cltbld', 02:44:36 INFO - 'MAIL': '/var/mail/cltbld', 02:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:36 INFO - 'MOZ_NO_REMOTE': '1', 02:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:36 INFO - 'NO_EM_RESTART': '1', 02:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:36 INFO - 'PWD': '/builds/slave/test', 02:44:36 INFO - 'SHELL': '/bin/bash', 02:44:36 INFO - 'SHLVL': '1', 02:44:36 INFO - 'TERM': 'linux', 02:44:36 INFO - 'TMOUT': '86400', 02:44:36 INFO - 'USER': 'cltbld', 02:44:36 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:36 INFO - '_': '/tools/buildbot/bin/python'} 02:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:38 INFO - Downloading docopt-0.6.1.tar.gz 02:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:38 INFO - Running setup.py install for blobuploader 02:44:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:38 INFO - Running setup.py install for requests 02:44:39 INFO - Running setup.py install for docopt 02:44:39 INFO - Successfully installed blobuploader requests docopt 02:44:39 INFO - Cleaning up... 02:44:39 INFO - Return code: 0 02:44:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:39 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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:44:39 INFO - Using env: {'DISPLAY': ':0', 02:44:39 INFO - 'HOME': '/home/cltbld', 02:44:39 INFO - 'LANG': 'en_US.UTF-8', 02:44:39 INFO - 'LANGUAGE': 'en_US:en', 02:44:39 INFO - 'LOGNAME': 'cltbld', 02:44:39 INFO - 'MAIL': '/var/mail/cltbld', 02:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:39 INFO - 'MOZ_NO_REMOTE': '1', 02:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:39 INFO - 'NO_EM_RESTART': '1', 02:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:39 INFO - 'PWD': '/builds/slave/test', 02:44:39 INFO - 'SHELL': '/bin/bash', 02:44:39 INFO - 'SHLVL': '1', 02:44:39 INFO - 'TERM': 'linux', 02:44:39 INFO - 'TMOUT': '86400', 02:44:39 INFO - 'USER': 'cltbld', 02:44:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:39 INFO - '_': '/tools/buildbot/bin/python'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:39 INFO - Running setup.py (path:/tmp/pip-VdtX4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:39 INFO - Running setup.py (path:/tmp/pip-YqETT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:39 INFO - Running setup.py (path:/tmp/pip-FkbvZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:39 INFO - Running setup.py (path:/tmp/pip-R8H3xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:39 INFO - Running setup.py (path:/tmp/pip-DYtyl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:39 INFO - Running setup.py (path:/tmp/pip-TCUw_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:39 INFO - Running setup.py (path:/tmp/pip-GPNnxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:40 INFO - Running setup.py (path:/tmp/pip-yseT9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:40 INFO - Running setup.py (path:/tmp/pip-fzPuOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:40 INFO - Running setup.py (path:/tmp/pip-cJkvDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:40 INFO - Running setup.py (path:/tmp/pip-njkaRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:40 INFO - Running setup.py (path:/tmp/pip-AL7eKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:40 INFO - Running setup.py (path:/tmp/pip-Czd7n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:40 INFO - Running setup.py (path:/tmp/pip-yfd0eV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:40 INFO - Running setup.py (path:/tmp/pip-uo1wMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:40 INFO - Running setup.py (path:/tmp/pip-Ndtut0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:40 INFO - Running setup.py (path:/tmp/pip-Hn_sP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:40 INFO - Running setup.py install for manifestparser 02:44:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:40 INFO - Running setup.py install for mozcrash 02:44:40 INFO - Running setup.py install for mozdebug 02:44:41 INFO - Running setup.py install for mozdevice 02:44:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozfile 02:44:41 INFO - Running setup.py install for mozhttpd 02:44:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozinfo 02:44:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozInstall 02:44:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozleak 02:44:41 INFO - Running setup.py install for mozlog 02:44:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for moznetwork 02:44:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:44:41 INFO - Running setup.py install for mozprocess 02:44:42 INFO - Running setup.py install for mozprofile 02:44:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Running setup.py install for mozrunner 02:44:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Running setup.py install for mozscreenshot 02:44:42 INFO - Running setup.py install for moztest 02:44:42 INFO - Running setup.py install for mozversion 02:44:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:44:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:44:42 INFO - Cleaning up... 02:44:42 INFO - Return code: 0 02:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:42 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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:44:42 INFO - Using env: {'DISPLAY': ':0', 02:44:42 INFO - 'HOME': '/home/cltbld', 02:44:42 INFO - 'LANG': 'en_US.UTF-8', 02:44:42 INFO - 'LANGUAGE': 'en_US:en', 02:44:42 INFO - 'LOGNAME': 'cltbld', 02:44:42 INFO - 'MAIL': '/var/mail/cltbld', 02:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:42 INFO - 'MOZ_NO_REMOTE': '1', 02:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:42 INFO - 'NO_EM_RESTART': '1', 02:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:42 INFO - 'PWD': '/builds/slave/test', 02:44:42 INFO - 'SHELL': '/bin/bash', 02:44:42 INFO - 'SHLVL': '1', 02:44:42 INFO - 'TERM': 'linux', 02:44:42 INFO - 'TMOUT': '86400', 02:44:42 INFO - 'USER': 'cltbld', 02:44:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:42 INFO - '_': '/tools/buildbot/bin/python'} 02:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:42 INFO - Running setup.py (path:/tmp/pip-Srfyr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:42 INFO - Running setup.py (path:/tmp/pip-ESw_x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:42 INFO - Running setup.py (path:/tmp/pip-Vt75nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:43 INFO - Running setup.py (path:/tmp/pip-PepcOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:43 INFO - Running setup.py (path:/tmp/pip-oXDMvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:43 INFO - Running setup.py (path:/tmp/pip-60IRXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:43 INFO - Running setup.py (path:/tmp/pip-_mMw8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:43 INFO - Running setup.py (path:/tmp/pip-3cHTSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:43 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)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:43 INFO - Running setup.py (path:/tmp/pip-X3zBOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:43 INFO - Running setup.py (path:/tmp/pip-q3oWKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:43 INFO - Running setup.py (path:/tmp/pip-JQpbHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:43 INFO - Running setup.py (path:/tmp/pip-XbKKCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:43 INFO - Running setup.py (path:/tmp/pip-pdLzFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:43 INFO - Running setup.py (path:/tmp/pip-k4RUis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:43 INFO - Running setup.py (path:/tmp/pip-7TV8e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:43 INFO - Running setup.py (path:/tmp/pip-Z_d5k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:43 INFO - Running setup.py (path:/tmp/pip-umIhR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:44:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:45 INFO - Downloading blessings-1.6.tar.gz 02:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:44:45 INFO - Installing collected packages: blessings 02:44:45 INFO - Running setup.py install for blessings 02:44:45 INFO - Successfully installed blessings 02:44:45 INFO - Cleaning up... 02:44:45 INFO - Return code: 0 02:44:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:44:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:45 INFO - Reading from file tmpfile_stdout 02:44:45 INFO - Current package versions: 02:44:45 INFO - argparse == 1.2.1 02:44:45 INFO - blessings == 1.6 02:44:45 INFO - blobuploader == 1.2.4 02:44:45 INFO - docopt == 0.6.1 02:44:45 INFO - functools32 == 3.2.3-2 02:44:45 INFO - jsonschema == 2.5.1 02:44:45 INFO - manifestparser == 1.1 02:44:45 INFO - mozInstall == 1.12 02:44:45 INFO - mozcrash == 1.0 02:44:45 INFO - mozdebug == 0.1 02:44:45 INFO - mozdevice == 0.51 02:44:45 INFO - mozfile == 1.2 02:44:45 INFO - mozhttpd == 0.7 02:44:45 INFO - mozinfo == 0.9 02:44:45 INFO - mozleak == 0.1 02:44:45 INFO - mozlog == 3.4 02:44:45 INFO - moznetwork == 0.27 02:44:45 INFO - mozprocess == 0.25 02:44:45 INFO - mozprofile == 0.28 02:44:45 INFO - mozrunner == 6.13 02:44:45 INFO - mozscreenshot == 0.1 02:44:45 INFO - mozsystemmonitor == 0.3 02:44:45 INFO - moztest == 0.8 02:44:45 INFO - mozversion == 1.4 02:44:45 INFO - psutil == 3.1.1 02:44:45 INFO - requests == 1.2.3 02:44:45 INFO - wsgiref == 0.1.2 02:44:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:45 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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:44:45 INFO - Using env: {'DISPLAY': ':0', 02:44:45 INFO - 'HOME': '/home/cltbld', 02:44:45 INFO - 'LANG': 'en_US.UTF-8', 02:44:45 INFO - 'LANGUAGE': 'en_US:en', 02:44:45 INFO - 'LOGNAME': 'cltbld', 02:44:45 INFO - 'MAIL': '/var/mail/cltbld', 02:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:45 INFO - 'MOZ_NO_REMOTE': '1', 02:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:45 INFO - 'NO_EM_RESTART': '1', 02:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:45 INFO - 'PWD': '/builds/slave/test', 02:44:45 INFO - 'SHELL': '/bin/bash', 02:44:45 INFO - 'SHLVL': '1', 02:44:45 INFO - 'TERM': 'linux', 02:44:45 INFO - 'TMOUT': '86400', 02:44:45 INFO - 'USER': 'cltbld', 02:44:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:45 INFO - '_': '/tools/buildbot/bin/python'} 02:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:44:45 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:46 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:44:46 INFO - Installing collected packages: marionette-driver 02:44:46 INFO - Running setup.py install for marionette-driver 02:44:47 INFO - Successfully installed marionette-driver 02:44:47 INFO - Cleaning up... 02:44:47 INFO - Return code: 0 02:44:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:47 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 0x17c73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, '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': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:44:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:44:47 INFO - Using env: {'DISPLAY': ':0', 02:44:47 INFO - 'HOME': '/home/cltbld', 02:44:47 INFO - 'LANG': 'en_US.UTF-8', 02:44:47 INFO - 'LANGUAGE': 'en_US:en', 02:44:47 INFO - 'LOGNAME': 'cltbld', 02:44:47 INFO - 'MAIL': '/var/mail/cltbld', 02:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:47 INFO - 'MOZ_NO_REMOTE': '1', 02:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:47 INFO - 'NO_EM_RESTART': '1', 02:44:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:47 INFO - 'PWD': '/builds/slave/test', 02:44:47 INFO - 'SHELL': '/bin/bash', 02:44:47 INFO - 'SHLVL': '1', 02:44:47 INFO - 'TERM': 'linux', 02:44:47 INFO - 'TMOUT': '86400', 02:44:47 INFO - 'USER': 'cltbld', 02:44:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:47 INFO - '_': '/tools/buildbot/bin/python'} 02:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:44:47 INFO - Cleaning up... 02:44:47 INFO - Return code: 0 02:44:47 INFO - Running post-action listener: _resource_record_post_action 02:44:47 INFO - Running post-action listener: _start_resource_monitoring 02:44:47 INFO - Starting resource monitoring. 02:44:47 INFO - [mozharness: 2017-05-30 09:44:47.357754Z] Finished create-virtualenv step (success) 02:44:47 INFO - [mozharness: 2017-05-30 09:44:47.358225Z] Running install step. 02:44:47 INFO - Running pre-action listener: _resource_record_pre_action 02:44:47 INFO - Running main action method: install 02:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:44:47 INFO - Reading from file tmpfile_stdout 02:44:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:44:47 INFO - Reading from file tmpfile_stdout 02:44:47 INFO - Output received: 02:44:47 INFO - Usage: mozinstall [options] installer 02:44:47 INFO - Options: 02:44:47 INFO - -h, --help show this help message and exit 02:44:47 INFO - -d DEST, --destination=DEST 02:44:47 INFO - Directory to install application into. [default: 02:44:47 INFO - "/builds/slave/test"] 02:44:47 INFO - --app=APP Application being installed. [default: firefox] 02:44:47 INFO - mkdir: /builds/slave/test/build/application 02:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:45:03 INFO - Reading from file tmpfile_stdout 02:45:03 INFO - Output received: 02:45:03 INFO - /builds/slave/test/build/application/firefox/firefox 02:45:03 INFO - Running post-action listener: _resource_record_post_action 02:45:03 INFO - [mozharness: 2017-05-30 09:45:03.240417Z] Finished install step (success) 02:45:03 INFO - [mozharness: 2017-05-30 09:45:03.240695Z] Running setup-mitmproxy step. 02:45:03 INFO - Running pre-action listener: _resource_record_pre_action 02:45:03 INFO - Running main action method: setup_mitmproxy 02:45:03 INFO - Skipping: mitmproxy is not required 02:45:03 INFO - Running post-action listener: _resource_record_post_action 02:45:03 INFO - [mozharness: 2017-05-30 09:45:03.241888Z] Finished setup-mitmproxy step (success) 02:45:03 INFO - [mozharness: 2017-05-30 09:45:03.242108Z] Running run-tests step. 02:45:03 INFO - Running pre-action listener: _resource_record_pre_action 02:45:03 INFO - Running main action method: run_tests 02:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:03 INFO - Python 2.7.3 02:45:03 INFO - Return code: 0 02:45:03 INFO - grabbing minidump binary from tooltool 02:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:03 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 0x1b41e40>, '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 0x1b42fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b43440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:45:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:45:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:45:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:03 INFO - Return code: 0 02:45:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:45:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:03 INFO - ENV: RUST_BACKTRACE is now 1 02:45:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:45:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:03 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/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:45:03 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/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:45:03 INFO - Using env: {'DISPLAY': ':0', 02:45:03 INFO - 'HOME': '/home/cltbld', 02:45:03 INFO - 'LANG': 'en_US.UTF-8', 02:45:03 INFO - 'LANGUAGE': 'en_US:en', 02:45:03 INFO - 'LOGNAME': 'cltbld', 02:45:03 INFO - 'MAIL': '/var/mail/cltbld', 02:45:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:03 INFO - 'MOZ_NO_REMOTE': '1', 02:45:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:03 INFO - 'NO_EM_RESTART': '1', 02:45:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:03 INFO - 'PWD': '/builds/slave/test', 02:45:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:03 INFO - 'RUST_BACKTRACE': '1', 02:45:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:45:03 INFO - 'SHELL': '/bin/bash', 02:45:03 INFO - 'SHLVL': '1', 02:45:03 INFO - 'TERM': 'linux', 02:45:03 INFO - 'TMOUT': '86400', 02:45:03 INFO - 'USER': 'cltbld', 02:45:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172', 02:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:03 INFO - '_': '/tools/buildbot/bin/python'} 02:45:03 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/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:45:03 INFO - mozversion application_buildid: 20170530091452 02:45:03 INFO - mozversion application_changeset: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 02:45:03 INFO - mozversion application_display_name: Nightly 02:45:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:03 INFO - mozversion application_name: Firefox 02:45:03 INFO - mozversion application_remotingname: firefox 02:45:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:45:03 INFO - mozversion application_vendor: Mozilla 02:45:03 INFO - mozversion application_version: 55.0a1 02:45:03 INFO - mozversion platform_buildid: 20170530091452 02:45:03 INFO - mozversion platform_changeset: 0c712d76d598ec92a7adaaf7180fd4e559f9abc0 02:45:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:45:03 INFO - mozversion platform_version: 55.0a1 02:45:03 INFO - using testdate: 1496137503 02:45:03 INFO - actual date: 1496137503 02:45:03 INFO - starting webserver on 'localhost:42211' 02:45:03 INFO - SUITE-START | Running 2 tests 02:45:03 INFO - TEST-START | dromaeo_css 02:45:03 INFO - operating with platform_type : linux_ 02:45:03 INFO - Initialising browser for dromaeo_css test... 02:45:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42211/getInfo.html -profile /tmp/tmpvoValc/profile 02:45:03 INFO - TEST-INFO | started process 13965 (/builds/slave/test/build/application/firefox/firefox http://localhost:42211/getInfo.html) 02:45:38 INFO - TEST-INFO | 13965: killed by SIGTERM 02:45:38 INFO - Browser initialized. 02:45:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:38 INFO - TEST-INFO | started process 14165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvoValc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:50 INFO - PID 14165 | RSS: Main: 182525952 02:45:50 INFO - PID 14165 | 02:48:55 INFO - PID 14165 | Cycle 1(1): loaded http://localhost:42211/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42211/tests/dromaeo/cssquery-ext.html) 02:48:56 INFO - PID 14165 | RSS: Main: 179601408 02:48:56 INFO - PID 14165 | 02:51:58 INFO - PID 14165 | Cycle 1(1): loaded http://localhost:42211/tests/dromaeo/cssquery-ext.html (next: http://localhost:42211/tests/dromaeo/cssquery-jquery.html) 02:51:59 INFO - PID 14165 | RSS: Main: 182849536 02:51:59 INFO - PID 14165 | 02:55:01 INFO - PID 14165 | Cycle 1(1): loaded http://localhost:42211/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42211/tests/dromaeo/cssquery-mootools.html) 02:55:01 INFO - PID 14165 | RSS: Main: 180199424 02:55:01 INFO - PID 14165 | 02:58:03 INFO - PID 14165 | Cycle 1(1): loaded http://localhost:42211/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42211/tests/dromaeo/cssquery-prototype.html) 02:58:04 INFO - PID 14165 | RSS: Main: 184696832 02:58:04 INFO - PID 14165 | 03:01:07 INFO - PID 14165 | Cycle 1(1): loaded http://localhost:42211/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42211/tests/dromaeo/cssquery-yui.html) 03:01:07 INFO - PID 14165 | RSS: Main: 184516608 03:01:07 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | Cycle 1(1): loaded http://localhost:42211/tests/dromaeo/cssquery-yui.html (next: http://localhost:42211/tests/dromaeo/cssquery-dojo.html) 03:04:09 INFO - PID 14165 | RSS: Main: 181141504 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | __start_tp_report 03:04:09 INFO - PID 14165 | _x_x_mozilla_page_load 03:04:09 INFO - PID 14165 | _x_x_mozilla_page_load_details 03:04:09 INFO - PID 14165 | |i|pagename|runs| 03:04:09 INFO - PID 14165 | |0;dojo.html;2729.7543221110104;2744.5059889219933;2759.8620068996547;2780.8053436259465;2785.456835916997;5185.144451165563;5286.577073834099;5296.417394086652;5313.654612450188;5342.465753424655;5209.947900520993;5231.319928409311;5285.550728188108;5311.521963023327;5345.385280692722;4645.349651048839;4669.533046695329;4688.578027977482;4700.506446823086;4755.072760811643;4738.455077666061;4743.525647435264;4770.30830529573;4784.3780308559835;4787.880302992436;4553.430821147356;4568.771561421916;4593.977030114861;4688.203005489075;4694.694844835075;4690.718556886563;4701.388819453483;4704.129735998851;4711.269753188261;4753.9762301188275;4651.465081515636;4655.813767449298;4655.88360290992;4668.6731928765;4722.220833562458;5136.897262054738;5213.53078222958;5266.947330526722;5310.62825602208;5336.733163341817;5653.321601407857;5711.171880077407;5731.226284451587;5742.626729262626;5762.942370576283;5764.308283006024;5776.537876969833;5788.102844059177;5797.971010144965;5805.680687562182;5360.946390536123;5360.973195133999;5369.892602147936;5373.516383525502;5379.811706590251;5780.306363236438;5821.563382746311;5855.736491857877;5864.882702345929;5918.23063001807;5585.888282234332;5610.410906854803;5618.185363122325;5625.353084395347;5634.943650563524;5468;5628.015097357946;5637.464440878192;5668.8866222675315;5687.232223649837;5557.694326811983;5610.85972850682;5624.184493248456;5626.803061892896;5651.519620832193;5622.381538030813;5698.287714035746;5734.942650573525;5739.196512488255;5751.482366587027;4813.422389313305;4827.662063655511;4834.685745426536;4834.95165048352;4884.682495637772;4103.8974025649;4111.259973204852;4111.876643700693;4136.793160341971;4151.481064866892;4712.787924543404;4728.361671174416;4789.928151077736;4807.230843065093;4823.927641085386;5677.17680936262;5704.572157088235;5726.742296596663;5730.34101078373;5743.224664670216;4808.110499557523;4808.855734327975;4820.421549414093;4835.95164048362;4859.635527335464;4943.826966056243;5028.7737051832755;5031.748412579356;5045.5459008689395;5098.719570423662;5239.24031015493;5292.338457692788;5331.626786124934;5333.573314134782;5333.759980800951;5602.719864006865;5712.285964254468;5731.8567035824435;5744.281964754406;5767.826965191051;5192.169252919514;5226.843194704165;5261.710605916712;5267.0256002639635;5278.023565640369;5608.298962629671;5631.014572449887;5635.6618602883955;5645.774169033192;5683.5453163747625;5707.800226992035;5707.9429205709075;5713.971430142823;5723.3418156912485;5732.71336433185;5458.91811622818;5499.807506737405;5556.972215139061;5564.360098588714;5604.467575580314;5539.750711217925;5544.889102217852;5551.861203469945;5552.028395030934;5611.551075913999;5446.155845843742;5453.563714902878;5477.20580515831;5489.945100549103;5495.945040549544;5331.493508116722;5467.507924286833;5469.808556700656;5610.102383618765;5635.830925072254;5457.426970168075;5481.123020316731;5503.532199763065;5506.531944784738;5515.834524964257 03:04:09 INFO - PID 14165 | |1;ext.html;588.8998870192067;636.3541005879033;644.9484041276697;1231.193568212821;1242.0684486635023;33827.154321141985;34413.827930860374;34417;34442.65557344426;34486;33552;33942;34019.659803401955;34043.659563404355;34063.31873362531;6707.262201157881;6841.350071743176;6848.075509806187;6851.931480685179;6877.071595334616;6714.194296684404;6800.319968003209;6832.726690932382;6832.897506537381;6836.726530938757;6831.795046148623;6843.315668433167;6846.144231971004;6852.177738671367;6852.6231057291825;6789;6791.830204244884;6812.727490900358;6825.761098361583;6841.350071743152;6701.195856497252;6718.260991290954;6719.2944740802;6738.797836064926;6747.966260168717;32458.513122303186;32656.346873062645;32709.345813083604;32727.18182045444;32820.179495512566;3053.8778448862017;3064.632244130696;3071.032624723205;3084.2135255509925;3084.2597776533694;24986.37534061663;25052.373690657696;25137;25246.621300680505;25271.62092568613;3017.109952563999;3034.286942568495;3042.4371491273964;3079.491883839164;3093.381323735262;122608;122643.38678306641;142662;142705.286473568;144045;39681.801590992436;39921.40117898234;40245.1950960985;40300.39549406761;40365.79817100954;40616.593834061874;40759.388609170885;44662;45097.77451112789;45216;12748.107632465639;12870.420831062625;12900.612981610566;12960.611181664564;12964.870351296366;10304.896951030543;10351.689449316533;10352.5341359639;10363.585456581803;10370.637027703995;12891.097623166475;12932;12953.870461295455;13086.738265234642;13112.868871311355;5241.161414173714;5280.339957505312;5317.122674758699;5364;5429.647072940246;850.3239924260228;882.8455020371409;895.3106108296575;909.3589019741066;927.3647551427293;20683.58632827335;21187.258445954318;21608.56782864334;21765.564688706454;21818.672719909213;941.6610020392653;980.7548112971757;982.5332966840693;982.9017098290257;983.3460748602242;10725.08836748885;14100.153990760587;14446.277686115653;14766.778498322534;14879.10725356482;167088;168054;168597;168871.15564422344;169438.15280923515;44524.10951780946;44546.33180502295;44748.28775683673;44753.10493790171;44899.32651010237;1186.4070816996507;1218.2386008744534;1220.7863623865787;1225.6445630766978;1232.4885172653428;24241.515169696155;24899.253022409357;25563.744362556135;25883.352916177246;25990.87004564965;29703.40593188081;29895;30001.399972000003;30023;30047;148965;149016;149101;149569;150905;29604.851975739984;29772.553411699275;29958.400831983676;30001.249968750082;30007.84996075093;34459.483107753906;35031.64968350284;35719.10702232465;35875.28249434944;35986.46020309645;26775.19674409771;26919.192424227305;27195.320116997234;27719.584206237327;28283.474644056852;26675;27623.58564621492;28578.71421285844;28625.856870715514;28870.42259154763;32502.837485813365;32604.184895377806;32606.34787304288;32670.673293266762;32697.673023269464;27227.863860681362;27649.723502764715;28259.858700706365;28326.858365708038;29029.27426814262;21728.456788580414;22513.549729005656;22561.548769024856;22948.541029179658;23022.654660179775 03:04:09 INFO - PID 14165 | |2;jquery.html;407.7207113127508;408.2814246925414;420.8821529971608;434.1339028637867;439.63729922813684;17154.742678859813;17681.7347739784;17998.730019049726;18082.728759068625;18154.455366339;17427.302907883703;17520.912395438005;17738.379156729516;18242.81757182428;18338.72491912619;5434.157705555635;5469.206964990074;5671.432856714317;5673.943260567404;5681.460261275193;5389.461053894618;5500.037493438632;5518.751656175482;5537.58468114891;5554.333479982408;5483.698396588186;5491.972540137313;5515.200295957084;5517.310336207974;5519.889602207953;5235.738213089349;5377;5394.352677678684;5403.081476149064;5412.648177868466;4858.1983972644475;4883.8290659826735;4890.682105663156;4894.779734911937;4904.60763138948;21187.682184767087;21752.673709894363;21785.346439606838;21881.890590547104;21932;1635.8773092018146;1690.2816303071145;1693.254967814158;1707.2232134378828;1713.2804222226694;14623.926880365636;14996.47512337074;15000.399984000736;15214.391424343014;15306.617334566614;2060.3612880007245;2078.5738923520644;2102.9474263143543;2114.080375036864;2133.861299015559;93334;93387;94332.52833735787;95445;96371.9999999993;10602.734931626772;11082.722931926604;11172.944135279271;11204.327740335606;11310.94344528272;15712;15719.764203536955;15723.68552628941;15723.842761572467;15752.68494630101;7432.591207483532;7444.255574442621;7564.167941526428;7657.885131723028;7693.615319234016;6756.425703815133;6793.762218322335;6967.1291088613925;7010.263922288086;7025.964870175617;6923.4807389446;7006.684699188549;7056.7530136446;7144.821379465555;7174.856502870018;1991.1836147179588;2012.939611811648;2018.2229841511123;2029.6245194639039;2179.705739725117;824.2952275804221;859.2352806002663;879.2965627497977;879.8020445399862;880.0231742765525;16438.835611643968;16699.499015029567;16999.660006799793;17032.2335494903;17061;874.4097734029632;875.6847534887436;878.3719640457103;882.6778225947482;889.0842432294746;11354.318740875575;11862.48734079332;11976.880231197576;12817.423215955305;12832.679183020498;372403;376079;378931;380150;382565;78749.60625196838;81544;81626;81913;88056.559717201;1070.3310430980637;1080.2492267873909;1112.093643680398;1119.1158984402232;1122.3041714137287;18253.726194107363;18522.907385462986;19098.713519296944;19197.424077277705;19583.510412239808;41539.37690934578;41730.99228092648;42539.14921701611;42802.78598607112;42918.57081429146;50654.74672626613;52000.47999519957;52493.21260181024;53019.20471192858;53145.734271328394;11454.312741235553;11848.111391645833;11962.58130965412;12058.819117713418;12245.632631021084;12690.302033388252;12772.680682983;12814;12859.678508037374;12861.871381286443;10555.472226388496;10741.301815381976;10831.133509319077;11351.886481135083;11771.176017678681;10341.482925853828;10749.086327662237;10789.62236321725;10843.891561084603;10969.945150274198;10662.466876656292;11061.612843550438;11186.161037922351;11265.324080555192;11304.095672346357;11727.76544469123;11773;11893.643190704293;12057.879421205676;12240.938795305967;10718.678439646823;10795;10882.12942964545;10955.34267943926;11055.391953442639 03:04:09 INFO - PID 14165 | |3;mootools.html;1236.8144778283258;1293.5666551705178;1293.7671219180543;1296.351824087956;1307.091571357906;10493.317934334264;10970;10989.780204395907;11098.389588572625;11349.943250283757;10998.670039898796;11200.495977681003;11204.439778011087;11212.719682007953;11215.327080375184;2192.9890350548267;2244.7642997485273;2250.088714070804;2255.1994042114975;2258.2209137847417;2181.727284089489;2222.422170235734;2225.043231410493;2225.087714037245;2238.7089678341795;2127.6808478728235;2171.880546569938;2172.9674054889188;2188.1684959715285;2188.5622875424897;2136.9893150534303;2149.355193441961;2151.9892400537974;2157.072458842697;2163.870167789922;1868.4301288107122;1923.5575817561898;1956.4228552577024;1986.6225417170692;2166.967495487569;10778.461076946121;10849.457527123692;10854.620088296952;10856.077233435168;10869.782604347947;5605.915911261334;5807.303123625192;5807.941920580824;5827.096799996008;5832.1834943108;3367.6632336766374;3513.5959364672876;3559.1458050068054;3565.090901820019;3584.121890136933;1098.2202636128359;1116.413882711583;1140.4525827602715;1159.455056123629;1184.3071802995257;16181.19094045293;16218.270177842025;16228.675426491522;16329.428470003493;16401.93387429825;4918.163912134874;5108.905348806971;5164.2770012198325;5203.765830537635;5237;11577;11653.126015548867;11654.475548600334;11688.590899318484;11770.941145294219;5620.803271885465;5793.044147715664;5814.534837213013;5816.098504731774;5817.331006934172;5192.8961420771375;5359.249705041298;5365.812196573102;5393.894251678396;5427.45725427462;3965.3457179565626;4031.959680403217;4075.7554546726697;4083.5508094109623;4135.110951145518;1146.3523109443138;1151.3322273081592;1153.5731779241567;1166.976660466786;1170.4791367841228;703.1843062048;725.3326939215934;725.7496163823472;732.9926700732924;742.2095468326215;5599.244102046253;5717.22817419643;5720.742566584514;5809.7095145242565;5833.416658334133;538.6848693514338;567.5091046245051;568.2101878389043;571.8513186571521;572.7680289482767;3499.3176330615283;3574.1779390740276;3704.9259014819554;4011.7392369495888;4034.415009823559;13628.318584070757;14154.575362739135;14431.134131952116;14504.709905802036;14531.927340363442;13909.73311617593;14040.438382464792;14151.575452736435;14316.5683431656;14395.712085758227;7666.540007599562;7774.611269436618;7890.092639346434;7969.920300797034;7980.082290536547;6119.602225855305;6124.356942521149;6172.506199503939;6222.28443728977;6247.125402443752;12543.93728031354;12546.937265313614;12613.306268154973;12699.936500317808;12836;13074.738505230032;13090.280034598189;13245.27151006704;13283.335833208494;13367.131136476099;7892.763217103496;7899.368050555827;7911.881321780293;7968.521888686697;7977.8404431912195;9944.552495137592;10071.295009349275;10104.141148002502;10122.443265620166;10147;7984.281414672707;8253.79365515867;8262.83474330498;8314.127016663164;8455.577221139041;8169.959150204211;8313.293370063613;8329.375296852639;8393.24460798531;8509.234168924826;7576.8484630308185;7738.303552680286;7744.961275193813;7773.37812974972;7782.182870798485;4958.900821983612;5486.1222204447095;5560.944390556205;5624.3250809903075;5732.885342293214;5549.084401073777;5585.3297604287745;5614.747336369792;5651.321841378896;5753.9136912945505 03:04:09 INFO - PID 14165 | |4;prototype.html;369.13806262377346;387.20043110975837;388.0376665868646;394.6053946053946;396.8610986154846;5359.9732001340035;5497.725113744312;5554.333479982398;5594.832155035356;5603.1315146152365;5344.198370244465;5402.9729851350685;5415.13357862742;5419.756110975006;5440.836774896759;4151.8131684074215;4160.667146628262;4167.270727622669;4167.686933751766;4174;4093.488313960755;4115.71190016699;4163.562825903282;4168.812403441837;4181.142865712522;4110.876673699794;4129;4139.317012692902;4140.358244472097;4153.335466325389;4108.671306295519;4117.814698338552;4122.340425531916;4124.8143833527565;4125.154343359634;3624.6194149614175;3638.872639457633;3640.1263696712863;3644.744867859251;3649.82465255227;5131.255967884673;5291.3385826771655;5357.4374690657305;5380.946190538084;5394.487523685283;4889.462159162489;4896.338994235768;4908.533689299511;4926.187179115442;4931.334269873593;5674.631148975303;5783.710814459302;5828.542864283929;5839.737211825478;5850.590458667895;4080.6531444827224;4091.284025295561;4091.590840915914;4102.692298077626;4120.91758164838;5884.881013063084;6056.242969628796;6070.301915279755;6082.787102451393;6175.876482470326;4120.938185927213;4168.7290326128705;4180.665546756252;4182.9581704182565;4202.348635961431;4163.854265100767;4210.894727631834;4220.282551966173;4221.155768846243;4266.1254442839145;4752.904941901212;4828.106800241966;4873.030537591493;4881.341018962466;4882.389701287339;5780.132980053026;5786.334571524329;5797.869415464028;5798.507126894261;5812.941870581325;1453.3532578002898;1473.1161303217984;1474.4397129090876;1477.2835174940146;1477.8743806776329;987.5852142100335;989.7674046599044;993.4784238274964;1005.5726316315537;1006.6325791086201;5019.949800502021;5031.107113409804;5039.21892106724;5045;5046.419661738873;6002.189704389939;6004.849878753066;6009.609375390585;6011.27864656244;6032.939670603326;4783.880402989953;4974.875628109254;4999.350084488993;5023.522765337287;5027.2207807789855;3163.1775738308206;3182.2203560127455;3195.7603179761145;3200.2959348943195;3202.375536770354;5404.783808647689;5534.695591742412;5553.944460555424;5564.245698379247;5565.6104072714525;6124.265088189357;6138.1713468681155;6139.386061393825;6178.969105154445;6185.659788711574;5543.390227075019;5554.361248456479;5569.554435645138;5570.248016517799;5571.13647384656;5837.620554663933;5920.911186332122;5923.141144534105;5988.820335389945;5993;5720.914186287292;5904.852378690567;5933.199018132669;5940.8611551008935;5943.732532035982;5525.364583072998;5543.805966791143;5577.274954256083;5578.246936663661;5599.616437261444;4182.790860457026;4205.831766729297;4213.747175169499;4220.788960552021;4231.23837709203;5814.476697097281;5980.5514586405325;6055.364186760503;6058.303295121117;6059.787907423219;5796.333421656564;5808.332041815245;5809.390014048464;5822.961963312976;5848.4151584842875;5657.12314591239;5826.863761566454;5833.154192642128;5842.38654941225;5882.735276912635;5712.857178570569;5716.799912003226;5730.598858079894;5775;5789.56578256624;5713.428657134254;5721.1990321354215;5731.627444216113;5806.593538452268;5854.180414741854;5412.107002344569;5568.440836565768;5611.579131565068;5618.129189975561;5696.857578560569 03:04:09 INFO - PID 14165 | |5;yui.html;752.4845480845621;754.2947344233146;762.0893032825772;765.2118318132326;767.7466436076096;13751.518696845613;14797.556073317804;14842.40630374785;15719.292631831566;16378.344866205338;16264.593385165377;16349.673006539862;16419.425320113798;16555.91722041391;16581.41965031224;909.8544232922734;927.1423932862109;928.9442633441981;931.455098767222;933.5285680731221;881.1320848963766;908.6547112097394;909.1090731083542;910.1308250620674;927.248928368024;958.9424634521916;968.4141094637748;968.6754937096081;969.1568335548083;970.4129001953822;952.309575557722;957.1003256938491;957.4255446731975;962.0716009051264;962.2638681408728;698.3435570563654;702.4275215699189;704.6934583456213;705.7706245470242;706.9752558660422;14222;14329.57011289663;14610.780838287434;14647.194404307758;14655.780163297559;15073.547793566211;15580.532584022498;15587.142707151103;15629.06225626466;15631.531054068397;13014.349282535835;13223.272720000396;13379.665508362272;13482.325883705775;13526.59420217395;3049.832259225742;3053.2214285357313;3061.571380006779;3068.47835867903;3077.6768439313773;78265.21734782636;79920.60039699764;80830;81086;81543;11674.533018679327;11844.585439509576;11859.229150105388;11869.406529673483;11899.405029748652;21230.51386402937;21565.568688626452;22270.443238919157;22399;22482;6155.322914479404;6161.476274516626;6169.691515424211;6181.320054793969;6182.783602573888;2791.246363481889;2867.4121805029918;2887.898923537708;2990.5364668476423;3046.22321308065;3668.3030224257304;3739.102615372291;3746.569144548357;3760.191558814868;3773.056735816046;731.2175971710219;752.0336367767393;762.4243696009478;763.7059732003107;765.1201118713524;541.4909984614528;559.7900787204799;568.6843801690102;569.0866159813522;574.7384939852357;9939;10381;10394.16846652266;10427.68716938493;10687.732806679895;586.5131940489383;588.9328457115555;594.8839976204686;607.6111288775187;608.4523928464417;4225.68307376948;4475.932861007088;4499.752513611783;4518.322251662277;4577.656675749266;71696.64151679313;71801;73063;73597.58414495147;73808.26191738014;64307.35692643107;64957.67521162364;65798.34201657922;65918.34081659123;66992;59684.403155967884;59786.70106649439;59852.401475985556;60592.69703651453;62506;8506.319494440306;8726.127387261477;8743.431676940978;8775.341849361452;8821.867671985054;27202.455950880474;27622.3094422633;28321.15036548907;29119.758443480376;29351.853240734516;35339.522374032065;35340.469892951114;35770;35933;36689.5972483293;12761.744765104831;12850.843424091876;13006.80489792635;13105.213687178419;13176.011799114913;13441.991850611048;13602.659933501742;13640.113392629448;13718.108322959375;13912.234827084607;12214.938925305316;12316.322602256962;12372;12451.128421010442;12501.624951251113;12036.939815300868;12116.878831211927;12362.629121126382;12380.4428800706;12459.314737689514;12961.935190323988;12992.805107923577;13052.086353955132;13078.934605326913;13233.867661323264;8945.19493245585;8955.373123881265;9368.156865882103;9496;9503.66737164196;9677.032296770267;9799.363041402286;10152.644657436955;10360.222983276133;10385.584576616851 03:04:09 INFO - PID 14165 | __end_tp_report 03:04:09 INFO - PID 14165 | __start_cc_report 03:04:09 INFO - PID 14165 | _x_x_mozilla_cycle_collect,372 03:04:09 INFO - PID 14165 | __end_cc_report 03:04:09 INFO - PID 14165 | __startTimestamp1496138649517__endTimestamp 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | ------- Summary: start ------- 03:04:09 INFO - PID 14165 | Number of tests: 6 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | [#0] dojo.html Cycles:165 Average:5206.31 Median:5360.97 stddev:612.64 (11.4%) stddev-sans-first:582.90 03:04:09 INFO - PID 14165 | Values: 2729.8 2744.5 2759.9 2780.8 2785.5 5185.1 5286.6 5296.4 5313.7 5342.5 5209.9 5231.3 5285.6 5311.5 5345.4 4645.3 4669.5 4688.6 4700.5 4755.1 4738.5 4743.5 4770.3 4784.4 4787.9 4553.4 4568.8 4594.0 4688.2 4694.7 4690.7 4701.4 4704.1 4711.3 4754.0 4651.5 4655.8 4655.9 4668.7 4722.2 5136.9 5213.5 5266.9 5310.6 5336.7 5653.3 5711.2 5731.2 5742.6 5762.9 5764.3 5776.5 5788.1 5798.0 5805.7 5360.9 5361.0 5369.9 5373.5 5379.8 5780.3 5821.6 5855.7 5864.9 5918.2 5585.9 5610.4 5618.2 5625.4 5634.9 5468.0 5628.0 5637.5 5668.9 5687.2 5557.7 5610.9 5624.2 5626.8 5651.5 5622.4 5698.3 5734.9 5739.2 5751.5 4813.4 4827.7 4834.7 4835.0 4884.7 4103.9 4111.3 4111.9 4136.8 4151.5 4712.8 4728.4 4789.9 4807.2 4823.9 5677.2 5704.6 5726.7 5730.3 5743.2 4808.1 4808.9 4820.4 4836.0 4859.6 4943.8 5028.8 5031.7 5045.5 5098.7 5239.2 5292.3 5331.6 5333.6 5333.8 5602.7 5712.3 5731.9 5744.3 5767.8 5192.2 5226.8 5261.7 5267.0 5278.0 5608.3 5631.0 5635.7 5645.8 5683.5 5707.8 5707.9 5714.0 5723.3 5732.7 5458.9 5499.8 5557.0 5564.4 5604.5 5539.8 5544.9 5551.9 5552.0 5611.6 5446.2 5453.6 5477.2 5489.9 5495.9 5331.5 5467.5 5469.8 5610.1 5635.8 5457.4 5481.1 5503.5 5506.5 5515.8 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | [#1] ext.html Cycles:180 Average:30196.56 Median:3059.26 stddev:39078.38 (1277.4%) stddev-sans-first:39124.76 03:04:09 INFO - PID 14165 | Values: 588.9 636.4 644.9 1231.2 1242.1 33827.2 34413.8 34417.0 34442.7 34486.0 33552.0 33942.0 34019.7 34043.7 34063.3 6707.3 6841.4 6848.1 6851.9 6877.1 6714.2 6800.3 6832.7 6832.9 6836.7 6831.8 6843.3 6846.1 6852.2 6852.6 6789.0 6791.8 6812.7 6825.8 6841.4 6701.2 6718.3 6719.3 6738.8 6748.0 32458.5 32656.3 32709.3 32727.2 32820.2 3053.9 3064.6 3071.0 3084.2 3084.3 24986.4 25052.4 25137.0 25246.6 25271.6 3017.1 3034.3 3042.4 3079.5 3093.4 122608.0 122643.4 142662.0 142705.3 144045.0 39681.8 39921.4 40245.2 40300.4 40365.8 40616.6 40759.4 44662.0 45097.8 45216.0 12748.1 12870.4 12900.6 12960.6 12964.9 10304.9 10351.7 10352.5 10363.6 10370.6 12891.1 12932.0 12953.9 13086.7 13112.9 5241.2 5280.3 5317.1 5364.0 5429.6 850.3 882.8 895.3 909.4 927.4 20683.6 21187.3 21608.6 21765.6 21818.7 941.7 980.8 982.5 982.9 983.3 10725.1 14100.2 14446.3 14766.8 14879.1 167088.0 168054.0 168597.0 168871.2 169438.2 44524.1 44546.3 44748.3 44753.1 44899.3 1186.4 1218.2 1220.8 1225.6 1232.5 24241.5 24899.3 25563.7 25883.4 25990.9 29703.4 29895.0 30001.4 30023.0 30047.0 148965.0 149016.0 149101.0 149569.0 150905.0 29604.9 29772.6 29958.4 30001.2 30007.8 34459.5 35031.6 35719.1 35875.3 35986.5 26775.2 26919.2 27195.3 27719.6 28283.5 26675.0 27623.6 28578.7 28625.9 28870.4 32502.8 32604.2 32606.3 32670.7 32697.7 27227.9 27649.7 28259.9 28326.9 29029.3 21728.5 22513.5 22561.5 22948.5 23022.7 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | [#2] jquery.html Cycles:180 Average:25960.82 Median:2090.76 stddev:63124.46 (3019.2%) stddev-sans-first:63272.38 03:04:09 INFO - PID 14165 | Values: 407.7 408.3 420.9 434.1 439.6 17154.7 17681.7 17998.7 18082.7 18154.5 17427.3 17520.9 17738.4 18242.8 18338.7 5434.2 5469.2 5671.4 5673.9 5681.5 5389.5 5500.0 5518.8 5537.6 5554.3 5483.7 5492.0 5515.2 5517.3 5519.9 5235.7 5377.0 5394.4 5403.1 5412.6 4858.2 4883.8 4890.7 4894.8 4904.6 21187.7 21752.7 21785.3 21881.9 21932.0 1635.9 1690.3 1693.3 1707.2 1713.3 14623.9 14996.5 15000.4 15214.4 15306.6 2060.4 2078.6 2102.9 2114.1 2133.9 93334.0 93387.0 94332.5 95445.0 96372.0 10602.7 11082.7 11172.9 11204.3 11310.9 15712.0 15719.8 15723.7 15723.8 15752.7 7432.6 7444.3 7564.2 7657.9 7693.6 6756.4 6793.8 6967.1 7010.3 7026.0 6923.5 7006.7 7056.8 7144.8 7174.9 1991.2 2012.9 2018.2 2029.6 2179.7 824.3 859.2 879.3 879.8 880.0 16438.8 16699.5 16999.7 17032.2 17061.0 874.4 875.7 878.4 882.7 889.1 11354.3 11862.5 11976.9 12817.4 12832.7 372403.0 376079.0 378931.0 380150.0 382565.0 78749.6 81544.0 81626.0 81913.0 88056.6 1070.3 1080.2 1112.1 1119.1 1122.3 18253.7 18522.9 19098.7 19197.4 19583.5 41539.4 41731.0 42539.1 42802.8 42918.6 50654.7 52000.5 52493.2 53019.2 53145.7 11454.3 11848.1 11962.6 12058.8 12245.6 12690.3 12772.7 12814.0 12859.7 12861.9 10555.5 10741.3 10831.1 11351.9 11771.2 10341.5 10749.1 10789.6 10843.9 10969.9 10662.5 11061.6 11186.2 11265.3 11304.1 11727.8 11773.0 11893.6 12057.9 12240.9 10718.7 10795.0 10882.1 10955.3 11055.4 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | [#3] mootools.html Cycles:180 Average:6594.47 Median:3506.46 stddev:4377.75 (124.8%) stddev-sans-first:4371.52 03:04:09 INFO - PID 14165 | Values: 1236.8 1293.6 1293.8 1296.4 1307.1 10493.3 10970.0 10989.8 11098.4 11349.9 10998.7 11200.5 11204.4 11212.7 11215.3 2193.0 2244.8 2250.1 2255.2 2258.2 2181.7 2222.4 2225.0 2225.1 2238.7 2127.7 2171.9 2173.0 2188.2 2188.6 2137.0 2149.4 2152.0 2157.1 2163.9 1868.4 1923.6 1956.4 1986.6 2167.0 10778.5 10849.5 10854.6 10856.1 10869.8 5605.9 5807.3 5807.9 5827.1 5832.2 3367.7 3513.6 3559.1 3565.1 3584.1 1098.2 1116.4 1140.5 1159.5 1184.3 16181.2 16218.3 16228.7 16329.4 16401.9 4918.2 5108.9 5164.3 5203.8 5237.0 11577.0 11653.1 11654.5 11688.6 11770.9 5620.8 5793.0 5814.5 5816.1 5817.3 5192.9 5359.2 5365.8 5393.9 5427.5 3965.3 4032.0 4075.8 4083.6 4135.1 1146.4 1151.3 1153.6 1167.0 1170.5 703.2 725.3 725.7 733.0 742.2 5599.2 5717.2 5720.7 5809.7 5833.4 538.7 567.5 568.2 571.9 572.8 3499.3 3574.2 3704.9 4011.7 4034.4 13628.3 14154.6 14431.1 14504.7 14531.9 13909.7 14040.4 14151.6 14316.6 14395.7 7666.5 7774.6 7890.1 7969.9 7980.1 6119.6 6124.4 6172.5 6222.3 6247.1 12543.9 12546.9 12613.3 12699.9 12836.0 13074.7 13090.3 13245.3 13283.3 13367.1 7892.8 7899.4 7911.9 7968.5 7977.8 9944.6 10071.3 10104.1 10122.4 10147.0 7984.3 8253.8 8262.8 8314.1 8455.6 8170.0 8313.3 8329.4 8393.2 8509.2 7576.8 7738.3 7745.0 7773.4 7782.2 4958.9 5486.1 5560.9 5624.3 5732.9 5549.1 5585.3 5614.7 5651.3 5753.9 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | [#4] prototype.html Cycles:180 Average:4775.72 Median:5408.45 stddev:1403.48 (25.9%) stddev-sans-first:1367.89 03:04:09 INFO - PID 14165 | Values: 369.1 387.2 388.0 394.6 396.9 5360.0 5497.7 5554.3 5594.8 5603.1 5344.2 5403.0 5415.1 5419.8 5440.8 4151.8 4160.7 4167.3 4167.7 4174.0 4093.5 4115.7 4163.6 4168.8 4181.1 4110.9 4129.0 4139.3 4140.4 4153.3 4108.7 4117.8 4122.3 4124.8 4125.2 3624.6 3638.9 3640.1 3644.7 3649.8 5131.3 5291.3 5357.4 5380.9 5394.5 4889.5 4896.3 4908.5 4926.2 4931.3 5674.6 5783.7 5828.5 5839.7 5850.6 4080.7 4091.3 4091.6 4102.7 4120.9 5884.9 6056.2 6070.3 6082.8 6175.9 4120.9 4168.7 4180.7 4183.0 4202.3 4163.9 4210.9 4220.3 4221.2 4266.1 4752.9 4828.1 4873.0 4881.3 4882.4 5780.1 5786.3 5797.9 5798.5 5812.9 1453.4 1473.1 1474.4 1477.3 1477.9 987.6 989.8 993.5 1005.6 1006.6 5019.9 5031.1 5039.2 5045.0 5046.4 6002.2 6004.8 6009.6 6011.3 6032.9 4783.9 4974.9 4999.4 5023.5 5027.2 3163.2 3182.2 3195.8 3200.3 3202.4 5404.8 5534.7 5553.9 5564.2 5565.6 6124.3 6138.2 6139.4 6179.0 6185.7 5543.4 5554.4 5569.6 5570.2 5571.1 5837.6 5920.9 5923.1 5988.8 5993.0 5720.9 5904.9 5933.2 5940.9 5943.7 5525.4 5543.8 5577.3 5578.2 5599.6 4182.8 4205.8 4213.7 4220.8 4231.2 5814.5 5980.6 6055.4 6058.3 6059.8 5796.3 5808.3 5809.4 5823.0 5848.4 5657.1 5826.9 5833.2 5842.4 5882.7 5712.9 5716.8 5730.6 5775.0 5789.6 5713.4 5721.2 5731.6 5806.6 5854.2 5412.1 5568.4 5611.6 5618.1 5696.9 03:04:09 INFO - PID 14165 | 03:04:09 INFO - PID 14165 | [#5] yui.html Cycles:180 Average:16173.65 Median:3766.62 stddev:20762.01 (551.2%) stddev-sans-first:20787.96 03:04:09 INFO - PID 14165 | Values: 752.5 754.3 762.1 765.2 767.7 13751.5 14797.6 14842.4 15719.3 16378.3 16264.6 16349.7 16419.4 16555.9 16581.4 909.9 927.1 928.9 931.5 933.5 881.1 908.7 909.1 910.1 927.2 958.9 968.4 968.7 969.2 970.4 952.3 957.1 957.4 962.1 962.3 698.3 702.4 704.7 705.8 707.0 14222.0 14329.6 14610.8 14647.2 14655.8 15073.5 15580.5 15587.1 15629.1 15631.5 13014.3 13223.3 13379.7 13482.3 13526.6 3049.8 3053.2 3061.6 3068.5 3077.7 78265.2 79920.6 80830.0 81086.0 81543.0 11674.5 11844.6 11859.2 11869.4 11899.4 21230.5 21565.6 22270.4 22399.0 22482.0 6155.3 6161.5 6169.7 6181.3 6182.8 2791.2 2867.4 2887.9 2990.5 3046.2 3668.3 3739.1 3746.6 3760.2 3773.1 731.2 752.0 762.4 763.7 765.1 541.5 559.8 568.7 569.1 574.7 9939.0 10381.0 10394.2 10427.7 10687.7 586.5 588.9 594.9 607.6 608.5 4225.7 4475.9 4499.8 4518.3 4577.7 71696.6 71801.0 73063.0 73597.6 73808.3 64307.4 64957.7 65798.3 65918.3 66992.0 59684.4 59786.7 59852.4 60592.7 62506.0 8506.3 8726.1 8743.4 8775.3 8821.9 27202.5 27622.3 28321.2 29119.8 29351.9 35339.5 35340.5 35770.0 35933.0 36689.6 12761.7 12850.8 13006.8 13105.2 13176.0 13442.0 13602.7 13640.1 13718.1 13912.2 12214.9 12316.3 12372.0 12451.1 12501.6 12036.9 12116.9 12362.6 12380.4 12459.3 12961.9 12992.8 13052.1 13078.9 13233.9 8945.2 8955.4 9368.2 9496.0 9503.7 9677.0 9799.4 10152.6 10360.2 10385.6 03:04:09 INFO - PID 14165 | -------- Summary: end -------- 03:04:09 INFO - PID 14165 | 03:04:10 INFO - TEST-INFO | 14165: exit 0 03:04:10 INFO - TEST-OK | dromaeo_css | took 1146879ms 03:04:10 INFO - TEST-START | kraken 03:04:10 INFO - operating with platform_type : linux_ 03:04:10 INFO - Initialising browser for kraken test... 03:04:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42211/getInfo.html -profile /tmp/tmpF9ifOL/profile 03:04:10 INFO - TEST-INFO | started process 14570 (/builds/slave/test/build/application/firefox/firefox http://localhost:42211/getInfo.html) 03:04:45 INFO - TEST-INFO | 14570: killed by SIGTERM 03:04:45 INFO - Browser initialized. 03:04:45 INFO - Running cycle 1/1 for kraken test... 03:04:45 INFO - TEST-INFO | started process 14767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9ifOL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:57 INFO - PID 14767 | RSS: Main: 182849536 03:04:57 INFO - PID 14767 | 03:05:00 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42211/tests/kraken/driver.html?testName=audio-beat-detection) 03:05:01 INFO - PID 14767 | RSS: Main: 186327040 03:05:01 INFO - PID 14767 | 03:05:04 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42211/tests/kraken/driver.html?testName=audio-dft) 03:05:04 INFO - PID 14767 | RSS: Main: 185188352 03:05:04 INFO - PID 14767 | 03:05:07 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42211/tests/kraken/driver.html?testName=audio-fft) 03:05:08 INFO - PID 14767 | RSS: Main: 181710848 03:05:08 INFO - PID 14767 | 03:05:10 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42211/tests/kraken/driver.html?testName=audio-oscillator) 03:05:11 INFO - PID 14767 | RSS: Main: 181919744 03:05:11 INFO - PID 14767 | 03:05:13 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42211/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:05:13 INFO - PID 14767 | RSS: Main: 182276096 03:05:13 INFO - PID 14767 | 03:05:16 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42211/tests/kraken/driver.html?testName=imaging-darkroom) 03:05:17 INFO - PID 14767 | RSS: Main: 185999360 03:05:17 INFO - PID 14767 | 03:05:21 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42211/tests/kraken/driver.html?testName=imaging-desaturate) 03:05:21 INFO - PID 14767 | RSS: Main: 182239232 03:05:21 INFO - PID 14767 | 03:05:24 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42211/tests/kraken/driver.html?testName=json-parse-financial) 03:05:25 INFO - PID 14767 | RSS: Main: 183275520 03:05:25 INFO - PID 14767 | 03:05:26 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42211/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:27 INFO - PID 14767 | RSS: Main: 183525376 03:05:27 INFO - PID 14767 | 03:05:29 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:29 INFO - PID 14767 | RSS: Main: 182464512 03:05:29 INFO - PID 14767 | 03:05:32 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:32 INFO - PID 14767 | RSS: Main: 182919168 03:05:32 INFO - PID 14767 | 03:05:35 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:36 INFO - PID 14767 | RSS: Main: 182874112 03:05:36 INFO - PID 14767 | 03:05:39 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:40 INFO - PID 14767 | RSS: Main: 182775808 03:05:40 INFO - PID 14767 | 03:05:41 INFO - PID 14767 | Cycle 1(1): loaded http://localhost:42211/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42211/tests/kraken/driver.html?testName=ai-astar) 03:05:42 INFO - PID 14767 | RSS: Main: 184094720 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | __start_tp_report 03:05:42 INFO - PID 14767 | _x_x_mozilla_page_load 03:05:42 INFO - PID 14767 | _x_x_mozilla_page_load_details 03:05:42 INFO - PID 14767 | |i|pagename|runs| 03:05:42 INFO - PID 14767 | |0;ai-astar;102;109;110;110;110;111;111;110;111;111 03:05:42 INFO - PID 14767 | |1;audio-beat-detection;153;125;126;173;128;129;125;126;152;128 03:05:42 INFO - PID 14767 | |2;audio-dft;165;168;166;167;166;185;163;165;165;166 03:05:42 INFO - PID 14767 | |3;audio-fft;73;74;74;106;77;81;76;75;106;75 03:05:42 INFO - PID 14767 | |4;audio-oscillator;83;83;103;84;84;84;113;84;84;105 03:05:42 INFO - PID 14767 | |5;imaging-gaussian-blur;114;115;114;114;114;114;115;113;114;114 03:05:42 INFO - PID 14767 | |6;imaging-darkroom;150;150;150;151;153;150;151;150;151;150 03:05:42 INFO - PID 14767 | |7;imaging-desaturate;96;94;94;94;94;94;94;96;95;95 03:05:42 INFO - PID 14767 | |8;json-parse-financial;55;54;54;56;54;56;58;56;58;57 03:05:42 INFO - PID 14767 | |9;json-stringify-tinderbox;56;56;56;55;55;56;56;57;56;56 03:05:42 INFO - PID 14767 | |10;stanford-crypto-aes;88;96;89;88;89;97;90;97;122;89 03:05:42 INFO - PID 14767 | |11;stanford-crypto-ccm;141;135;137;133;135;136;135;133;142;134 03:05:42 INFO - PID 14767 | |12;stanford-crypto-pbkdf2;188;193;195;193;196;194;196;193;184;187 03:05:42 INFO - PID 14767 | |13;stanford-crypto-sha256-iterative;76;73;73;73;74;75;71;74;71;72 03:05:42 INFO - PID 14767 | __end_tp_report 03:05:42 INFO - PID 14767 | __start_cc_report 03:05:42 INFO - PID 14767 | _x_x_mozilla_cycle_collect,1038 03:05:42 INFO - PID 14767 | __end_cc_report 03:05:42 INFO - PID 14767 | __startTimestamp1496138742092__endTimestamp 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | ------- Summary: start ------- 03:05:42 INFO - PID 14767 | Number of tests: 14 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:0.71 03:05:42 INFO - PID 14767 | Values: 102.0 109.0 110.0 110.0 110.0 111.0 111.0 110.0 111.0 111.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:128.50 stddev:16.77 (13.0%) stddev-sans-first:16.69 03:05:42 INFO - PID 14767 | Values: 153.0 125.0 126.0 173.0 128.0 129.0 125.0 126.0 152.0 128.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#2] audio-dft Cycles:10 Average:167.60 Median:166.00 stddev:6.26 (3.8%) stddev-sans-first:6.57 03:05:42 INFO - PID 14767 | Values: 165.0 168.0 166.0 167.0 166.0 185.0 163.0 165.0 165.0 166.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.00 (17.3%) stddev-sans-first:13.40 03:05:42 INFO - PID 14767 | Values: 73.0 74.0 74.0 106.0 77.0 81.0 76.0 75.0 106.0 75.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:11.53 (13.7%) stddev-sans-first:11.89 03:05:42 INFO - PID 14767 | Values: 83.0 83.0 103.0 84.0 84.0 84.0 113.0 84.0 84.0 105.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:05:42 INFO - PID 14767 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 115.0 113.0 114.0 114.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 03:05:42 INFO - PID 14767 | Values: 150.0 150.0 150.0 151.0 153.0 150.0 151.0 150.0 151.0 150.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 03:05:42 INFO - PID 14767 | Values: 96.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 95.0 95.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.62 03:05:42 INFO - PID 14767 | Values: 55.0 54.0 54.0 56.0 54.0 56.0 58.0 56.0 58.0 57.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 03:05:42 INFO - PID 14767 | Values: 56.0 56.0 56.0 55.0 55.0 56.0 56.0 57.0 56.0 56.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:89.50 stddev:10.36 (11.6%) stddev-sans-first:10.72 03:05:42 INFO - PID 14767 | Values: 88.0 96.0 89.0 88.0 89.0 97.0 90.0 97.0 122.0 89.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:135.50 stddev:3.11 (2.3%) stddev-sans-first:2.74 03:05:42 INFO - PID 14767 | Values: 141.0 135.0 137.0 133.0 135.0 136.0 135.0 133.0 142.0 134.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.90 Median:193.50 stddev:4.12 (2.1%) stddev-sans-first:4.12 03:05:42 INFO - PID 14767 | Values: 188.0 193.0 195.0 193.0 196.0 194.0 196.0 193.0 184.0 187.0 03:05:42 INFO - PID 14767 | 03:05:42 INFO - PID 14767 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.50 stddev:1.62 (2.2%) stddev-sans-first:1.36 03:05:42 INFO - PID 14767 | Values: 76.0 73.0 73.0 73.0 74.0 75.0 71.0 74.0 71.0 72.0 03:05:42 INFO - PID 14767 | -------- Summary: end -------- 03:05:42 INFO - PID 14767 | 03:05:43 INFO - TEST-INFO | 14767: exit 0 03:05:43 INFO - TEST-OK | kraken | took 92842ms 03:05:43 INFO - SUITE-END | took 1239s 03:05:43 INFO - Completed test suite (00:20:40) 03:05:43 INFO - javascript benchmark 03:05:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6826.395829712658, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2729.7543221110104, 2744.5059889219933, 2759.8620068996547, 2780.8053436259465, 2785.456835916997, 5185.144451165563, 5286.577073834099, 5296.417394086652, 5313.654612450188, 5342.465753424655, 5209.947900520993, 5231.319928409311, 5285.550728188108, 5311.521963023327, 5345.385280692722, 4645.349651048839, 4669.533046695329, 4688.578027977482, 4700.506446823086, 4755.072760811643, 4738.455077666061, 4743.525647435264, 4770.30830529573, 4784.3780308559835, 4787.880302992436, 4553.430821147356, 4568.771561421916, 4593.977030114861, 4688.203005489075, 4694.694844835075, 4690.718556886563, 4701.388819453483, 4704.129735998851, 4711.269753188261, 4753.9762301188275, 4651.465081515636, 4655.813767449298, 4655.88360290992, 4668.6731928765, 4722.220833562458, 5136.897262054738, 5213.53078222958, 5266.947330526722, 5310.62825602208, 5336.733163341817, 5653.321601407857, 5711.171880077407, 5731.226284451587, 5742.626729262626, 5762.942370576283, 5764.308283006024, 5776.537876969833, 5788.102844059177, 5797.971010144965, 5805.680687562182, 5360.946390536123, 5360.973195133999, 5369.892602147936, 5373.516383525502, 5379.811706590251, 5780.306363236438, 5821.563382746311, 5855.736491857877, 5864.882702345929, 5918.23063001807, 5585.888282234332, 5610.410906854803, 5618.185363122325, 5625.353084395347, 5634.943650563524, 5468.0, 5628.015097357946, 5637.464440878192, 5668.8866222675315, 5687.232223649837, 5557.694326811983, 5610.85972850682, 5624.184493248456, 5626.803061892896, 5651.519620832193, 5622.381538030813, 5698.287714035746, 5734.942650573525, 5739.196512488255, 5751.482366587027, 4813.422389313305, 4827.662063655511, 4834.685745426536, 4834.95165048352, 4884.682495637772, 4103.8974025649, 4111.259973204852, 4111.876643700693, 4136.793160341971, 4151.481064866892, 4712.787924543404, 4728.361671174416, 4789.928151077736, 4807.230843065093, 4823.927641085386, 5677.17680936262, 5704.572157088235, 5726.742296596663, 5730.34101078373, 5743.224664670216, 4808.110499557523, 4808.855734327975, 4820.421549414093, 4835.95164048362, 4859.635527335464, 4943.826966056243, 5028.7737051832755, 5031.748412579356, 5045.5459008689395, 5098.719570423662, 5239.24031015493, 5292.338457692788, 5331.626786124934, 5333.573314134782, 5333.759980800951, 5602.719864006865, 5712.285964254468, 5731.8567035824435, 5744.281964754406, 5767.826965191051, 5192.169252919514, 5226.843194704165, 5261.710605916712, 5267.0256002639635, 5278.023565640369, 5608.298962629671, 5631.014572449887, 5635.6618602883955, 5645.774169033192, 5683.5453163747625, 5707.800226992035, 5707.9429205709075, 5713.971430142823, 5723.3418156912485, 5732.71336433185, 5458.91811622818, 5499.807506737405, 5556.972215139061, 5564.360098588714, 5604.467575580314, 5539.750711217925, 5544.889102217852, 5551.861203469945, 5552.028395030934, 5611.551075913999, 5446.155845843742, 5453.563714902878, 5477.20580515831, 5489.945100549103, 5495.945040549544, 5331.493508116722, 5467.507924286833, 5469.808556700656, 5610.102383618765, 5635.830925072254, 5457.426970168075, 5481.123020316731, 5503.532199763065, 5506.531944784738, 5515.834524964257], "value": 5161.905042702327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.8998870192067, 636.3541005879033, 644.9484041276697, 1231.193568212821, 1242.0684486635023, 33827.154321141985, 34413.827930860374, 34417.0, 34442.65557344426, 34486.0, 33552.0, 33942.0, 34019.659803401955, 34043.659563404355, 34063.31873362531, 6707.262201157881, 6841.350071743176, 6848.075509806187, 6851.931480685179, 6877.071595334616, 6714.194296684404, 6800.319968003209, 6832.726690932382, 6832.897506537381, 6836.726530938757, 6831.795046148623, 6843.315668433167, 6846.144231971004, 6852.177738671367, 6852.6231057291825, 6789.0, 6791.830204244884, 6812.727490900358, 6825.761098361583, 6841.350071743152, 6701.195856497252, 6718.260991290954, 6719.2944740802, 6738.797836064926, 6747.966260168717, 32458.513122303186, 32656.346873062645, 32709.345813083604, 32727.18182045444, 32820.179495512566, 3053.8778448862017, 3064.632244130696, 3071.032624723205, 3084.2135255509925, 3084.2597776533694, 24986.37534061663, 25052.373690657696, 25137.0, 25246.621300680505, 25271.62092568613, 3017.109952563999, 3034.286942568495, 3042.4371491273964, 3079.491883839164, 3093.381323735262, 122608.0, 122643.38678306641, 142662.0, 142705.286473568, 144045.0, 39681.801590992436, 39921.40117898234, 40245.1950960985, 40300.39549406761, 40365.79817100954, 40616.593834061874, 40759.388609170885, 44662.0, 45097.77451112789, 45216.0, 12748.107632465639, 12870.420831062625, 12900.612981610566, 12960.611181664564, 12964.870351296366, 10304.896951030543, 10351.689449316533, 10352.5341359639, 10363.585456581803, 10370.637027703995, 12891.097623166475, 12932.0, 12953.870461295455, 13086.738265234642, 13112.868871311355, 5241.161414173714, 5280.339957505312, 5317.122674758699, 5364.0, 5429.647072940246, 850.3239924260228, 882.8455020371409, 895.3106108296575, 909.3589019741066, 927.3647551427293, 20683.58632827335, 21187.258445954318, 21608.56782864334, 21765.564688706454, 21818.672719909213, 941.6610020392653, 980.7548112971757, 982.5332966840693, 982.9017098290257, 983.3460748602242, 10725.08836748885, 14100.153990760587, 14446.277686115653, 14766.778498322534, 14879.10725356482, 167088.0, 168054.0, 168597.0, 168871.15564422344, 169438.15280923515, 44524.10951780946, 44546.33180502295, 44748.28775683673, 44753.10493790171, 44899.32651010237, 1186.4070816996507, 1218.2386008744534, 1220.7863623865787, 1225.6445630766978, 1232.4885172653428, 24241.515169696155, 24899.253022409357, 25563.744362556135, 25883.352916177246, 25990.87004564965, 29703.40593188081, 29895.0, 30001.399972000003, 30023.0, 30047.0, 148965.0, 149016.0, 149101.0, 149569.0, 150905.0, 29604.851975739984, 29772.553411699275, 29958.400831983676, 30001.249968750082, 30007.84996075093, 34459.483107753906, 35031.64968350284, 35719.10702232465, 35875.28249434944, 35986.46020309645, 26775.19674409771, 26919.192424227305, 27195.320116997234, 27719.584206237327, 28283.474644056852, 26675.0, 27623.58564621492, 28578.71421285844, 28625.856870715514, 28870.42259154763, 32502.837485813365, 32604.184895377806, 32606.34787304288, 32670.673293266762, 32697.673023269464, 27227.863860681362, 27649.723502764715, 28259.858700706365, 28326.858365708038, 29029.27426814262, 21728.456788580414, 22513.549729005656, 22561.548769024856, 22948.541029179658, 23022.654660179775], "value": 14717.938615692086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.7207113127508, 408.2814246925414, 420.8821529971608, 434.1339028637867, 439.63729922813684, 17154.742678859813, 17681.7347739784, 17998.730019049726, 18082.728759068625, 18154.455366339, 17427.302907883703, 17520.912395438005, 17738.379156729516, 18242.81757182428, 18338.72491912619, 5434.157705555635, 5469.206964990074, 5671.432856714317, 5673.943260567404, 5681.460261275193, 5389.461053894618, 5500.037493438632, 5518.751656175482, 5537.58468114891, 5554.333479982408, 5483.698396588186, 5491.972540137313, 5515.200295957084, 5517.310336207974, 5519.889602207953, 5235.738213089349, 5377.0, 5394.352677678684, 5403.081476149064, 5412.648177868466, 4858.1983972644475, 4883.8290659826735, 4890.682105663156, 4894.779734911937, 4904.60763138948, 21187.682184767087, 21752.673709894363, 21785.346439606838, 21881.890590547104, 21932.0, 1635.8773092018146, 1690.2816303071145, 1693.254967814158, 1707.2232134378828, 1713.2804222226694, 14623.926880365636, 14996.47512337074, 15000.399984000736, 15214.391424343014, 15306.617334566614, 2060.3612880007245, 2078.5738923520644, 2102.9474263143543, 2114.080375036864, 2133.861299015559, 93334.0, 93387.0, 94332.52833735787, 95445.0, 96371.9999999993, 10602.734931626772, 11082.722931926604, 11172.944135279271, 11204.327740335606, 11310.94344528272, 15712.0, 15719.764203536955, 15723.68552628941, 15723.842761572467, 15752.68494630101, 7432.591207483532, 7444.255574442621, 7564.167941526428, 7657.885131723028, 7693.615319234016, 6756.425703815133, 6793.762218322335, 6967.1291088613925, 7010.263922288086, 7025.964870175617, 6923.4807389446, 7006.684699188549, 7056.7530136446, 7144.821379465555, 7174.856502870018, 1991.1836147179588, 2012.939611811648, 2018.2229841511123, 2029.6245194639039, 2179.705739725117, 824.2952275804221, 859.2352806002663, 879.2965627497977, 879.8020445399862, 880.0231742765525, 16438.835611643968, 16699.499015029567, 16999.660006799793, 17032.2335494903, 17061.0, 874.4097734029632, 875.6847534887436, 878.3719640457103, 882.6778225947482, 889.0842432294746, 11354.318740875575, 11862.48734079332, 11976.880231197576, 12817.423215955305, 12832.679183020498, 372403.0, 376079.0, 378931.0, 380150.0, 382565.0, 78749.60625196838, 81544.0, 81626.0, 81913.0, 88056.559717201, 1070.3310430980637, 1080.2492267873909, 1112.093643680398, 1119.1158984402232, 1122.3041714137287, 18253.726194107363, 18522.907385462986, 19098.713519296944, 19197.424077277705, 19583.510412239808, 41539.37690934578, 41730.99228092648, 42539.14921701611, 42802.78598607112, 42918.57081429146, 50654.74672626613, 52000.47999519957, 52493.21260181024, 53019.20471192858, 53145.734271328394, 11454.312741235553, 11848.111391645833, 11962.58130965412, 12058.819117713418, 12245.632631021084, 12690.302033388252, 12772.680682983, 12814.0, 12859.678508037374, 12861.871381286443, 10555.472226388496, 10741.301815381976, 10831.133509319077, 11351.886481135083, 11771.176017678681, 10341.482925853828, 10749.086327662237, 10789.62236321725, 10843.891561084603, 10969.945150274198, 10662.466876656292, 11061.612843550438, 11186.161037922351, 11265.324080555192, 11304.095672346357, 11727.76544469123, 11773.0, 11893.643190704293, 12057.879421205676, 12240.938795305967, 10718.678439646823, 10795.0, 10882.12942964545, 10955.34267943926, 11055.391953442639], "value": 9202.589539213692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.8144778283258, 1293.5666551705178, 1293.7671219180543, 1296.351824087956, 1307.091571357906, 10493.317934334264, 10970.0, 10989.780204395907, 11098.389588572625, 11349.943250283757, 10998.670039898796, 11200.495977681003, 11204.439778011087, 11212.719682007953, 11215.327080375184, 2192.9890350548267, 2244.7642997485273, 2250.088714070804, 2255.1994042114975, 2258.2209137847417, 2181.727284089489, 2222.422170235734, 2225.043231410493, 2225.087714037245, 2238.7089678341795, 2127.6808478728235, 2171.880546569938, 2172.9674054889188, 2188.1684959715285, 2188.5622875424897, 2136.9893150534303, 2149.355193441961, 2151.9892400537974, 2157.072458842697, 2163.870167789922, 1868.4301288107122, 1923.5575817561898, 1956.4228552577024, 1986.6225417170692, 2166.967495487569, 10778.461076946121, 10849.457527123692, 10854.620088296952, 10856.077233435168, 10869.782604347947, 5605.915911261334, 5807.303123625192, 5807.941920580824, 5827.096799996008, 5832.1834943108, 3367.6632336766374, 3513.5959364672876, 3559.1458050068054, 3565.090901820019, 3584.121890136933, 1098.2202636128359, 1116.413882711583, 1140.4525827602715, 1159.455056123629, 1184.3071802995257, 16181.19094045293, 16218.270177842025, 16228.675426491522, 16329.428470003493, 16401.93387429825, 4918.163912134874, 5108.905348806971, 5164.2770012198325, 5203.765830537635, 5237.0, 11577.0, 11653.126015548867, 11654.475548600334, 11688.590899318484, 11770.941145294219, 5620.803271885465, 5793.044147715664, 5814.534837213013, 5816.098504731774, 5817.331006934172, 5192.8961420771375, 5359.249705041298, 5365.812196573102, 5393.894251678396, 5427.45725427462, 3965.3457179565626, 4031.959680403217, 4075.7554546726697, 4083.5508094109623, 4135.110951145518, 1146.3523109443138, 1151.3322273081592, 1153.5731779241567, 1166.976660466786, 1170.4791367841228, 703.1843062048, 725.3326939215934, 725.7496163823472, 732.9926700732924, 742.2095468326215, 5599.244102046253, 5717.22817419643, 5720.742566584514, 5809.7095145242565, 5833.416658334133, 538.6848693514338, 567.5091046245051, 568.2101878389043, 571.8513186571521, 572.7680289482767, 3499.3176330615283, 3574.1779390740276, 3704.9259014819554, 4011.7392369495888, 4034.415009823559, 13628.318584070757, 14154.575362739135, 14431.134131952116, 14504.709905802036, 14531.927340363442, 13909.73311617593, 14040.438382464792, 14151.575452736435, 14316.5683431656, 14395.712085758227, 7666.540007599562, 7774.611269436618, 7890.092639346434, 7969.920300797034, 7980.082290536547, 6119.602225855305, 6124.356942521149, 6172.506199503939, 6222.28443728977, 6247.125402443752, 12543.93728031354, 12546.937265313614, 12613.306268154973, 12699.936500317808, 12836.0, 13074.738505230032, 13090.280034598189, 13245.27151006704, 13283.335833208494, 13367.131136476099, 7892.763217103496, 7899.368050555827, 7911.881321780293, 7968.521888686697, 7977.8404431912195, 9944.552495137592, 10071.295009349275, 10104.141148002502, 10122.443265620166, 10147.0, 7984.281414672707, 8253.79365515867, 8262.83474330498, 8314.127016663164, 8455.577221139041, 8169.959150204211, 8313.293370063613, 8329.375296852639, 8393.24460798531, 8509.234168924826, 7576.8484630308185, 7738.303552680286, 7744.961275193813, 7773.37812974972, 7782.182870798485, 4958.900821983612, 5486.1222204447095, 5560.944390556205, 5624.3250809903075, 5732.885342293214, 5549.084401073777, 5585.3297604287745, 5614.747336369792, 5651.321841378896, 5753.9136912945505], "value": 4850.703113140717, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.13806262377346, 387.20043110975837, 388.0376665868646, 394.6053946053946, 396.8610986154846, 5359.9732001340035, 5497.725113744312, 5554.333479982398, 5594.832155035356, 5603.1315146152365, 5344.198370244465, 5402.9729851350685, 5415.13357862742, 5419.756110975006, 5440.836774896759, 4151.8131684074215, 4160.667146628262, 4167.270727622669, 4167.686933751766, 4174.0, 4093.488313960755, 4115.71190016699, 4163.562825903282, 4168.812403441837, 4181.142865712522, 4110.876673699794, 4129.0, 4139.317012692902, 4140.358244472097, 4153.335466325389, 4108.671306295519, 4117.814698338552, 4122.340425531916, 4124.8143833527565, 4125.154343359634, 3624.6194149614175, 3638.872639457633, 3640.1263696712863, 3644.744867859251, 3649.82465255227, 5131.255967884673, 5291.3385826771655, 5357.4374690657305, 5380.946190538084, 5394.487523685283, 4889.462159162489, 4896.338994235768, 4908.533689299511, 4926.187179115442, 4931.334269873593, 5674.631148975303, 5783.710814459302, 5828.542864283929, 5839.737211825478, 5850.590458667895, 4080.6531444827224, 4091.284025295561, 4091.590840915914, 4102.692298077626, 4120.91758164838, 5884.881013063084, 6056.242969628796, 6070.301915279755, 6082.787102451393, 6175.876482470326, 4120.938185927213, 4168.7290326128705, 4180.665546756252, 4182.9581704182565, 4202.348635961431, 4163.854265100767, 4210.894727631834, 4220.282551966173, 4221.155768846243, 4266.1254442839145, 4752.904941901212, 4828.106800241966, 4873.030537591493, 4881.341018962466, 4882.389701287339, 5780.132980053026, 5786.334571524329, 5797.869415464028, 5798.507126894261, 5812.941870581325, 1453.3532578002898, 1473.1161303217984, 1474.4397129090876, 1477.2835174940146, 1477.8743806776329, 987.5852142100335, 989.7674046599044, 993.4784238274964, 1005.5726316315537, 1006.6325791086201, 5019.949800502021, 5031.107113409804, 5039.21892106724, 5045.0, 5046.419661738873, 6002.189704389939, 6004.849878753066, 6009.609375390585, 6011.27864656244, 6032.939670603326, 4783.880402989953, 4974.875628109254, 4999.350084488993, 5023.522765337287, 5027.2207807789855, 3163.1775738308206, 3182.2203560127455, 3195.7603179761145, 3200.2959348943195, 3202.375536770354, 5404.783808647689, 5534.695591742412, 5553.944460555424, 5564.245698379247, 5565.6104072714525, 6124.265088189357, 6138.1713468681155, 6139.386061393825, 6178.969105154445, 6185.659788711574, 5543.390227075019, 5554.361248456479, 5569.554435645138, 5570.248016517799, 5571.13647384656, 5837.620554663933, 5920.911186332122, 5923.141144534105, 5988.820335389945, 5993.0, 5720.914186287292, 5904.852378690567, 5933.199018132669, 5940.8611551008935, 5943.732532035982, 5525.364583072998, 5543.805966791143, 5577.274954256083, 5578.246936663661, 5599.616437261444, 4182.790860457026, 4205.831766729297, 4213.747175169499, 4220.788960552021, 4231.23837709203, 5814.476697097281, 5980.5514586405325, 6055.364186760503, 6058.303295121117, 6059.787907423219, 5796.333421656564, 5808.332041815245, 5809.390014048464, 5822.961963312976, 5848.4151584842875, 5657.12314591239, 5826.863761566454, 5833.154192642128, 5842.38654941225, 5882.735276912635, 5712.857178570569, 5716.799912003226, 5730.598858079894, 5775.0, 5789.56578256624, 5713.428657134254, 5721.1990321354215, 5731.627444216113, 5806.593538452268, 5854.180414741854, 5412.107002344569, 5568.440836565768, 5611.579131565068, 5618.129189975561, 5696.857578560569], "value": 4345.739590570164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.4845480845621, 754.2947344233146, 762.0893032825772, 765.2118318132326, 767.7466436076096, 13751.518696845613, 14797.556073317804, 14842.40630374785, 15719.292631831566, 16378.344866205338, 16264.593385165377, 16349.673006539862, 16419.425320113798, 16555.91722041391, 16581.41965031224, 909.8544232922734, 927.1423932862109, 928.9442633441981, 931.455098767222, 933.5285680731221, 881.1320848963766, 908.6547112097394, 909.1090731083542, 910.1308250620674, 927.248928368024, 958.9424634521916, 968.4141094637748, 968.6754937096081, 969.1568335548083, 970.4129001953822, 952.309575557722, 957.1003256938491, 957.4255446731975, 962.0716009051264, 962.2638681408728, 698.3435570563654, 702.4275215699189, 704.6934583456213, 705.7706245470242, 706.9752558660422, 14222.0, 14329.57011289663, 14610.780838287434, 14647.194404307758, 14655.780163297559, 15073.547793566211, 15580.532584022498, 15587.142707151103, 15629.06225626466, 15631.531054068397, 13014.349282535835, 13223.272720000396, 13379.665508362272, 13482.325883705775, 13526.59420217395, 3049.832259225742, 3053.2214285357313, 3061.571380006779, 3068.47835867903, 3077.6768439313773, 78265.21734782636, 79920.60039699764, 80830.0, 81086.0, 81543.0, 11674.533018679327, 11844.585439509576, 11859.229150105388, 11869.406529673483, 11899.405029748652, 21230.51386402937, 21565.568688626452, 22270.443238919157, 22399.0, 22482.0, 6155.322914479404, 6161.476274516626, 6169.691515424211, 6181.320054793969, 6182.783602573888, 2791.246363481889, 2867.4121805029918, 2887.898923537708, 2990.5364668476423, 3046.22321308065, 3668.3030224257304, 3739.102615372291, 3746.569144548357, 3760.191558814868, 3773.056735816046, 731.2175971710219, 752.0336367767393, 762.4243696009478, 763.7059732003107, 765.1201118713524, 541.4909984614528, 559.7900787204799, 568.6843801690102, 569.0866159813522, 574.7384939852357, 9939.0, 10381.0, 10394.16846652266, 10427.68716938493, 10687.732806679895, 586.5131940489383, 588.9328457115555, 594.8839976204686, 607.6111288775187, 608.4523928464417, 4225.68307376948, 4475.932861007088, 4499.752513611783, 4518.322251662277, 4577.656675749266, 71696.64151679313, 71801.0, 73063.0, 73597.58414495147, 73808.26191738014, 64307.35692643107, 64957.67521162364, 65798.34201657922, 65918.34081659123, 66992.0, 59684.403155967884, 59786.70106649439, 59852.401475985556, 60592.69703651453, 62506.0, 8506.319494440306, 8726.127387261477, 8743.431676940978, 8775.341849361452, 8821.867671985054, 27202.455950880474, 27622.3094422633, 28321.15036548907, 29119.758443480376, 29351.853240734516, 35339.522374032065, 35340.469892951114, 35770.0, 35933.0, 36689.5972483293, 12761.744765104831, 12850.843424091876, 13006.80489792635, 13105.213687178419, 13176.011799114913, 13441.991850611048, 13602.659933501742, 13640.113392629448, 13718.108322959375, 13912.234827084607, 12214.938925305316, 12316.322602256962, 12372.0, 12451.128421010442, 12501.624951251113, 12036.939815300868, 12116.878831211927, 12362.629121126382, 12380.4428800706, 12459.314737689514, 12961.935190323988, 12992.805107923577, 13052.086353955132, 13078.934605326913, 13233.867661323264, 8945.19493245585, 8955.373123881265, 9368.156865882103, 9496.0, 9503.66737164196, 9677.032296770267, 9799.363041402286, 10152.644657436955, 10360.222983276133, 10385.584576616851], "value": 6865.647944110027, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 126.0, 173.0, 128.0, 129.0, 125.0, 126.0, 152.0, 128.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 166.0, 167.0, 166.0, 185.0, 163.0, 165.0, 165.0, 166.0], "value": 167.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 106.0, 77.0, 81.0, 76.0, 75.0, 106.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 103.0, 84.0, 84.0, 84.0, 113.0, 84.0, 84.0, 105.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 153.0, 150.0, 151.0, 150.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 56.0, 54.0, 56.0, 58.0, 56.0, 58.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 96.0, 89.0, 88.0, 89.0, 97.0, 90.0, 97.0, 122.0, 89.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 135.0, 137.0, 133.0, 135.0, 136.0, 135.0, 133.0, 142.0, 134.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 193.0, 195.0, 193.0, 196.0, 194.0, 196.0, 193.0, 184.0, 187.0], "value": 191.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 73.0, 73.0, 74.0, 75.0, 71.0, 74.0, 71.0, 72.0], "value": 73.2, "unit": "score"}]}]} 03:05:43 INFO - Return code: 0 03:05:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:05:43 INFO - # TBPL SUCCESS # 03:05:43 INFO - Running post-action listener: _resource_record_post_action 03:05:43 INFO - [mozharness: 2017-05-30 10:05:43.885549Z] Finished run-tests step (success) 03:05:43 INFO - Running post-run listener: _resource_record_post_run 03:05:43 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402841600; Read time: 28; Write time: 239464 03:05:43 INFO - TinderboxPrint: CPU usage
12.7% 03:05:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 03:05:43 INFO - TinderboxPrint: I/O write bytes / time
402,841,600 / 239,464 03:05:43 INFO - TinderboxPrint: CPU idle
8,753.4 (87.3%) 03:05:43 INFO - TinderboxPrint: CPU user
1,218.5 (12.2%) 03:05:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:05:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 97767424; Read time: 0; Write time: 71344 03:05:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:05:43 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305074176; Read time: 28; Write time: 168120 03:05:44 INFO - Running post-run listener: _upload_blobber_files 03:05:44 INFO - Blob upload gear active. 03:05:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:44 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 03:05:44 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'] 03:05:44 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 03:05:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:45 INFO - (blobuploader) - INFO - Done attempting. 03:05:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:05:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:46 INFO - (blobuploader) - INFO - Done attempting. 03:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:53 INFO - (blobuploader) - INFO - Done attempting. 03:05:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:05:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:54 INFO - (blobuploader) - INFO - Done attempting. 03:05:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:05:54 INFO - Return code: 0 03:05:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:05:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:05:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4ca74ef3480c528ecca933c3a404be4d0fddbf95bfd7596b701096d2e44713e3622efe719aab20b9470570e69c16a838afbab3447ce1ee98a210d386cee6830", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e68ba8611ab83a42388ddb6644fe426fd76b1c5bedf03adb6e3ce0a51f8748b49c56866cbad96885d8476dc3f11a637eddad9eb5738c444adbe8ea5730cb735", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8962a0bb8033914ddd6584037966f73e066044a3e27a6f1c5ea83aff0b305679424dde3dfe08f5e78e6d0fe3b90721889a23012dd1f6836a6b359ef43ecb0be1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a3de0e56206574dcca131f7a978c351da1facba253f33fb06c3d9d69d9dcf45dea9ccc697d1d197c5d21ea68198543ed56d7aebe2b7abcfaa99d4597080833"} 03:05:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:05:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:05:54 INFO - Contents: 03:05:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4ca74ef3480c528ecca933c3a404be4d0fddbf95bfd7596b701096d2e44713e3622efe719aab20b9470570e69c16a838afbab3447ce1ee98a210d386cee6830", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e68ba8611ab83a42388ddb6644fe426fd76b1c5bedf03adb6e3ce0a51f8748b49c56866cbad96885d8476dc3f11a637eddad9eb5738c444adbe8ea5730cb735", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8962a0bb8033914ddd6584037966f73e066044a3e27a6f1c5ea83aff0b305679424dde3dfe08f5e78e6d0fe3b90721889a23012dd1f6836a6b359ef43ecb0be1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a3de0e56206574dcca131f7a978c351da1facba253f33fb06c3d9d69d9dcf45dea9ccc697d1d197c5d21ea68198543ed56d7aebe2b7abcfaa99d4597080833"} 03:05:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:05:54 INFO - Copying logs to upload dir... 03:05:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:05:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.204356 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-30 03:05:53.532248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 03:05:53.540684) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172 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/f4ca74ef3480c528ecca933c3a404be4d0fddbf95bfd7596b701096d2e44713e3622efe719aab20b9470570e69c16a838afbab3447ce1ee98a210d386cee6830", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e68ba8611ab83a42388ddb6644fe426fd76b1c5bedf03adb6e3ce0a51f8748b49c56866cbad96885d8476dc3f11a637eddad9eb5738c444adbe8ea5730cb735", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8962a0bb8033914ddd6584037966f73e066044a3e27a6f1c5ea83aff0b305679424dde3dfe08f5e78e6d0fe3b90721889a23012dd1f6836a6b359ef43ecb0be1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a3de0e56206574dcca131f7a978c351da1facba253f33fb06c3d9d69d9dcf45dea9ccc697d1d197c5d21ea68198543ed56d7aebe2b7abcfaa99d4597080833"} build_url:https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/ADFZpUVvR8-bvoHJrZ3rFg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4ca74ef3480c528ecca933c3a404be4d0fddbf95bfd7596b701096d2e44713e3622efe719aab20b9470570e69c16a838afbab3447ce1ee98a210d386cee6830", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e68ba8611ab83a42388ddb6644fe426fd76b1c5bedf03adb6e3ce0a51f8748b49c56866cbad96885d8476dc3f11a637eddad9eb5738c444adbe8ea5730cb735", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8962a0bb8033914ddd6584037966f73e066044a3e27a6f1c5ea83aff0b305679424dde3dfe08f5e78e6d0fe3b90721889a23012dd1f6836a6b359ef43ecb0be1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/29a3de0e56206574dcca131f7a978c351da1facba253f33fb06c3d9d69d9dcf45dea9ccc697d1d197c5d21ea68198543ed56d7aebe2b7abcfaa99d4597080833"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 03:05:53.565159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:05:53.568493) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1496136371.217936-1257214172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:05:53.649922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 03:05:53.653320) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 03:05:53.653605) ========= ========= Total master_lag: 0.04 =========